builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-069 starttime: 1506338546.81 results: success (0) revision: 13ce77b78e364cc952d51b959f22202502be2941 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 04:22:26.811711) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 04:22:26.812097) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 04:22:26.812361) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 04:22:26.889121) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 04:22:26.889385) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 04:22:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.6M=0.001s 2017-09-25 04:22:27 (21.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.188502 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 04:22:27.151213) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 04:22:27.151490) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018173 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 04:22:27.210339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 04:22:27.210673) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 13ce77b78e364cc952d51b959f22202502be2941 --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 13ce77b78e364cc952d51b959f22202502be2941 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 04:22:27,402 truncating revision to first 12 chars 2017-09-25 04:22:27,402 Setting DEBUG logging. 2017-09-25 04:22:27,402 attempt 1/10 2017-09-25 04:22:27,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/13ce77b78e36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 04:22:27,724 unpacking tar archive at: mozilla-central-13ce77b78e36/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674387 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 04:22:27.916732) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 04:22:27.917023) ========= script_repo_revision: 13ce77b78e364cc952d51b959f22202502be2941 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 04:22:27.917372) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 04:22:27.917666) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 04:22:27.947903) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-25 04:22:27.948164) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:22:28 INFO - MultiFileLogger online at 20170925 04:22:28 in /builds/slave/test 04:22:28 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 04:22:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:22:28 INFO - {'append_to_log': False, 04:22:28 INFO - 'base_work_dir': '/builds/slave/test', 04:22:28 INFO - 'blob_upload_branch': 'Firefox', 04:22:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:22:28 INFO - 'branch': 'Firefox', 04:22:28 INFO - 'buildbot_json_path': 'buildprops.json', 04:22:28 INFO - 'code_coverage': False, 04:22:28 INFO - 'config_files': ('talos/linux_config.py',), 04:22:28 INFO - 'default_actions': ('clobber', 04:22:28 INFO - 'read-buildbot-config', 04:22:28 INFO - 'download-and-extract', 04:22:28 INFO - 'populate-webroot', 04:22:28 INFO - 'create-virtualenv', 04:22:28 INFO - 'install', 04:22:28 INFO - 'setup-mitmproxy', 04:22:28 INFO - 'run-tests'), 04:22:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:22:28 INFO - 'disable_ccov_upload': False, 04:22:28 INFO - 'disable_stylo': False, 04:22:28 INFO - 'download_minidump_stackwalk': True, 04:22:28 INFO - 'download_symbols': 'ondemand', 04:22:28 INFO - 'enable_stylo': False, 04:22:28 INFO - 'enable_webrender': False, 04:22:28 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:22:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:22:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:22:28 INFO - 'gecko_profile': False, 04:22:28 INFO - 'gecko_profile_interval': 0, 04:22:28 INFO - 'installer_path': 'installer.exe', 04:22:28 INFO - 'log_level': 'info', 04:22:28 INFO - 'log_name': 'talos', 04:22:28 INFO - 'log_to_console': True, 04:22:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:22:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:22:28 INFO - 'opt_config_files': (), 04:22:28 INFO - 'pip_index': False, 04:22:28 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 04:22:28 INFO - 'system_bits': '32', 04:22:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:22:28 INFO - 'title': 'talos-linux64-ix-069', 04:22:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:22:28 INFO - 'use_talos_json': True, 04:22:28 INFO - 'verify': 'False', 04:22:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:22:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:22:28 INFO - 'work_dir': 'build'} 04:22:28 INFO - [mozharness: 2017-09-25 11:22:28.379647Z] Running clobber step. 04:22:28 INFO - Running pre-action listener: _resource_record_pre_action 04:22:28 INFO - Running main action method: clobber 04:22:28 INFO - rmtree: /builds/slave/test/build 04:22:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:22:29 INFO - Running post-action listener: _resource_record_post_action 04:22:29 INFO - [mozharness: 2017-09-25 11:22:29.336415Z] Finished clobber step (success) 04:22:29 INFO - [mozharness: 2017-09-25 11:22:29.336511Z] Running read-buildbot-config step. 04:22:29 INFO - Running pre-action listener: _resource_record_pre_action 04:22:29 INFO - Running main action method: read_buildbot_config 04:22:29 INFO - Using buildbot properties: 04:22:29 INFO - { 04:22:29 INFO - "project": "", 04:22:29 INFO - "product": "firefox", 04:22:29 INFO - "who": "archaeopteryx@coole-files.de", 04:22:29 INFO - "installer_path": "public/build/target.tar.bz2", 04:22:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 04:22:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:22:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 04:22:29 INFO - "stage_platform": "linux64-pgo", 04:22:29 INFO - "basedir": "/builds/slave/test", 04:22:29 INFO - "buildnumber": 58, 04:22:29 INFO - "platform": "ubuntu64_hw", 04:22:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:22:29 INFO - "slavebuilddir": "test", 04:22:29 INFO - "taskId": "ETMr7HgsRZSOEdE46yZL4Q", 04:22:29 INFO - "branch": "mozilla-central", 04:22:29 INFO - "script_repo_revision": "production", 04:22:29 INFO - "revision": "13ce77b78e364cc952d51b959f22202502be2941", 04:22:29 INFO - "slavename": "talos-linux64-ix-069", 04:22:29 INFO - "repo_path": "mozilla-central" 04:22:29 INFO - } 04:22:29 INFO - Finding installer, test and symbols from parent task. 04:22:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ETMr7HgsRZSOEdE46yZL4Q'}, attempt #1 04:22:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ETMr7HgsRZSOEdE46yZL4Q'}, attempt #1 04:22:30 INFO - Task dependencies: c6Yk_WdkTh-UotDFJcbP0A 04:22:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A'}, attempt #1 04:22:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.tar.bz2 04:22:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.test_packages.json 04:22:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.crashreporter-symbols.zip 04:22:30 INFO - Running post-action listener: _resource_record_post_action 04:22:30 INFO - [mozharness: 2017-09-25 11:22:30.692711Z] Finished read-buildbot-config step (success) 04:22:30 INFO - [mozharness: 2017-09-25 11:22:30.692929Z] Running download-and-extract step. 04:22:30 INFO - Running pre-action listener: _resource_record_pre_action 04:22:30 INFO - Running main action method: download_and_extract 04:22:30 INFO - mkdir: /builds/slave/test/build/tests 04:22:30 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')]} 04:22:30 INFO - trying https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.test_packages.json 04:22:30 INFO - Downloading https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:22:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:22:31 INFO - Downloaded 989 bytes. 04:22:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:22:31 INFO - Using the following test package requirements: 04:22:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:22:31 INFO - u'common': [u'target.common.tests.zip'], 04:22:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:22:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:22:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:22:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:22:31 INFO - u'mozbase': [u'target.common.tests.zip'], 04:22:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:22:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:22:31 INFO - u'web-platform': [u'target.common.tests.zip', 04:22:31 INFO - u'target.web-platform.tests.tar.gz'], 04:22:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:22:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:22:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.common.tests.zip 04:22:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:22:31 INFO - Fetch https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.common.tests.zip into memory 04:22:32 INFO - Content-Length response header: 55344822 04:22:32 INFO - Bytes received: 55344822 04:22:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.talos.tests.zip 04:22:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:22:44 INFO - Fetch https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.talos.tests.zip into memory 04:22:44 INFO - Content-Length response header: 14513823 04:22:44 INFO - Bytes received: 14513823 04:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:45 INFO - trying https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.tar.bz2 04:22:45 INFO - Downloading https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:22:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:22:46 INFO - Downloaded 62299341 bytes. 04:22:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.tar.bz2 04:22:46 INFO - mkdir: /builds/slave/test/properties 04:22:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:22:46 INFO - Writing to file /builds/slave/test/properties/build_url 04:22:46 INFO - Contents: 04:22:46 INFO - build_url:https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.tar.bz2 04:22:46 INFO - Running post-action listener: _resource_record_post_action 04:22:46 INFO - Running post-action listener: find_tests_for_verification 04:22:46 INFO - Running post-action listener: set_extra_try_arguments 04:22:46 INFO - [mozharness: 2017-09-25 11:22:46.947569Z] Finished download-and-extract step (success) 04:22:46 INFO - [mozharness: 2017-09-25 11:22:46.947672Z] Running populate-webroot step. 04:22:46 INFO - Running pre-action listener: _resource_record_pre_action 04:22:46 INFO - Running main action method: populate_webroot 04:22:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:22:46 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:22:46 INFO - 'tests': ['tresize', 04:22:46 INFO - 'tcanvasmark']}, 04:22:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:22:46 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:22:46 INFO - 'tests': ['dromaeo_css', 04:22:46 INFO - 'kraken']}, 04:22:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:22:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:46 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:22:46 INFO - 'talos_options': ['--disable-stylo'], 04:22:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:22:46 INFO - 'tests': ['damp', 'tps']}, 04:22:46 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:22:46 INFO - 'talos_options': ['--disable-stylo'], 04:22:46 INFO - 'tests': ['damp', 'tps']}, 04:22:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:22:46 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:22:46 INFO - 'tests': ['dromaeo_dom']}, 04:22:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:22:46 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:22:46 INFO - 'tests': ['basic_compositor_video', 04:22:46 INFO - 'glvideo']}, 04:22:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:22:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:22:46 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:22:46 INFO - 'talos_options': ['--disable-stylo'], 04:22:46 INFO - 'tests': ['ts_paint_webext', 04:22:46 INFO - 'tp5o_webext']}, 04:22:46 INFO - 'other-e10s': {'tests': ['a11yr', 04:22:46 INFO - 'ts_paint', 04:22:46 INFO - 'tpaint', 04:22:46 INFO - 'sessionrestore', 04:22:46 INFO - 'sessionrestore_many_windows', 04:22:46 INFO - 'sessionrestore_no_auto_restore', 04:22:46 INFO - 'tabpaint']}, 04:22:46 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:22:46 INFO - 'tests': ['a11yr', 04:22:46 INFO - 'ts_paint', 04:22:46 INFO - 'tpaint', 04:22:46 INFO - 'sessionrestore', 04:22:46 INFO - 'sessionrestore_many_windows', 04:22:46 INFO - 'sessionrestore_no_auto_restore', 04:22:46 INFO - 'tabpaint']}, 04:22:46 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 04:22:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:22:46 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:22:46 INFO - 'tests': ['perf_reftest_singletons']}, 04:22:46 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:22:46 INFO - 'tests': ['perf_reftest']}, 04:22:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:22:46 INFO - 'tsvgr_opacity', 04:22:46 INFO - 'tart', 04:22:46 INFO - 'tscrollx', 04:22:46 INFO - 'tsvg_static']}, 04:22:46 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:22:46 INFO - 'tests': ['tsvgx', 04:22:46 INFO - 'tsvgr_opacity', 04:22:46 INFO - 'tart', 04:22:46 INFO - 'tscrollx', 04:22:46 INFO - 'tsvg_static']}, 04:22:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:22:46 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:22:46 INFO - 'talos_options': ['--disable-stylo'], 04:22:46 INFO - 'tests': ['tp5o']}, 04:22:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:22:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:22:46 INFO - 'talos_options': ['--mitmproxy', 04:22:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:22:46 INFO - '--firstNonBlankPaint'], 04:22:46 INFO - 'tests': ['tp6_google', 04:22:46 INFO - 'tp6_youtube', 04:22:46 INFO - 'tp6_amazon', 04:22:46 INFO - 'tp6_facebook']}, 04:22:46 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:22:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:22:46 INFO - 'talos_options': ['--disable-stylo', 04:22:46 INFO - '--mitmproxy', 04:22:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:22:46 INFO - '--firstNonBlankPaint'], 04:22:46 INFO - 'tests': ['tp6_google', 04:22:46 INFO - 'tp6_youtube', 04:22:46 INFO - 'tp6_amazon', 04:22:46 INFO - 'tp6_facebook']}, 04:22:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:22:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:22:46 INFO - 'talos_options': ['--stylo-threads=1', 04:22:46 INFO - '--mitmproxy', 04:22:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:22:46 INFO - '--firstNonBlankPaint'], 04:22:46 INFO - 'tests': ['tp6_google', 04:22:46 INFO - 'tp6_youtube', 04:22:46 INFO - 'tp6_amazon', 04:22:46 INFO - 'tp6_facebook']}, 04:22:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:22:46 INFO - 'talos_options': ['--xperf_path', 04:22:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:46 INFO - 'tests': ['tp5n']}, 04:22:46 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:22:46 INFO - 'talos_options': ['--disable-stylo', 04:22:46 INFO - '--xperf_path', 04:22:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:46 INFO - 'tests': ['tp5n']}}} 04:22:46 INFO - Running post-action listener: _resource_record_post_action 04:22:46 INFO - [mozharness: 2017-09-25 11:22:46.963025Z] Finished populate-webroot step (success) 04:22:46 INFO - [mozharness: 2017-09-25 11:22:46.963114Z] Running create-virtualenv step. 04:22:46 INFO - Running pre-action listener: _resource_record_pre_action 04:22:46 INFO - Running main action method: create_virtualenv 04:22:46 INFO - Creating virtualenv /builds/slave/test/build/venv 04:22:46 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:22:46 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:22:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:22:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:22:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:22:49 INFO - Installing distribute.............................................................................................................................................................................................done. 04:22:51 INFO - Installing pip...............done. 04:22:51 INFO - Return code: 0 04:22:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:22:51 INFO - Reading from file tmpfile_stdout 04:22:51 INFO - Output received: 04:22:51 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:22:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffd60>, '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 0x2100a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100ef0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', '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 04:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:22:51 INFO - Using env: {'DISPLAY': ':0', 04:22:51 INFO - 'HOME': '/home/cltbld', 04:22:51 INFO - 'LANG': 'en_US.UTF-8', 04:22:51 INFO - 'LANGUAGE': 'en_US:en', 04:22:51 INFO - 'LOGNAME': 'cltbld', 04:22:51 INFO - 'MAIL': '/var/mail/cltbld', 04:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:51 INFO - 'MOZ_NO_REMOTE': '1', 04:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:51 INFO - 'NO_EM_RESTART': '1', 04:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:51 INFO - 'PWD': '/builds/slave/test', 04:22:51 INFO - 'SHELL': '/bin/bash', 04:22:51 INFO - 'SHLVL': '1', 04:22:51 INFO - 'TERM': 'linux', 04:22:51 INFO - 'TMOUT': '86400', 04:22:51 INFO - 'USER': 'cltbld', 04:22:51 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', 04:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:51 INFO - '_': '/tools/buildbot/bin/python'} 04:22:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:22:52 INFO - Downloading/unpacking pip>=1.5 04:22:52 INFO - Running setup.py egg_info for package pip 04:22:52 INFO - warning: no files found matching 'pip/cacert.pem' 04:22:52 INFO - warning: no files found matching '*.html' under directory 'docs' 04:22:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:22:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:22:52 INFO - Installing collected packages: pip 04:22:52 INFO - Found existing installation: pip 1.1 04:22:52 INFO - Uninstalling pip: 04:22:52 INFO - Successfully uninstalled pip 04:22:52 INFO - Running setup.py install for pip 04:22:52 INFO - warning: no files found matching 'pip/cacert.pem' 04:22:52 INFO - warning: no files found matching '*.html' under directory 'docs' 04:22:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:22:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:22:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:22:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:22:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:22:52 INFO - Successfully installed pip 04:22:52 INFO - Cleaning up... 04:22:52 INFO - Return code: 0 04:22:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22: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')]} 04:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22: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 0x1d951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffd60>, '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 0x2100a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100ef0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', '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 04:22: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 04:22: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 04:22:52 INFO - Using env: {'DISPLAY': ':0', 04:22:52 INFO - 'HOME': '/home/cltbld', 04:22:52 INFO - 'LANG': 'en_US.UTF-8', 04:22:52 INFO - 'LANGUAGE': 'en_US:en', 04:22:52 INFO - 'LOGNAME': 'cltbld', 04:22:52 INFO - 'MAIL': '/var/mail/cltbld', 04:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:52 INFO - 'MOZ_NO_REMOTE': '1', 04:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:52 INFO - 'NO_EM_RESTART': '1', 04:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:52 INFO - 'PWD': '/builds/slave/test', 04:22:52 INFO - 'SHELL': '/bin/bash', 04:22:52 INFO - 'SHLVL': '1', 04:22:52 INFO - 'TERM': 'linux', 04:22:52 INFO - 'TMOUT': '86400', 04:22:52 INFO - 'USER': 'cltbld', 04:22:52 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', 04:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:52 INFO - '_': '/tools/buildbot/bin/python'} 04:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:52 INFO - Downloading/unpacking psutil>=3.1.1 04:22: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 04:22: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 04:22: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 04:22: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 04:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:22:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:54 INFO - Installing collected packages: psutil 04:22:54 INFO - Running setup.py install for psutil 04:22:54 INFO - building 'psutil._psutil_linux' extension 04:22:54 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 04:22:55 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 04:22:55 INFO - building 'psutil._psutil_posix' extension 04:22:55 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 04:22:55 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 04:22:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:55 INFO - Successfully installed psutil 04:22:55 INFO - Cleaning up... 04:22:55 INFO - Return code: 0 04:22:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22: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')]} 04:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffd60>, '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 0x2100a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100ef0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', '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 04:22: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:22: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 mozsystemmonitor==0.3 04:22:55 INFO - Using env: {'DISPLAY': ':0', 04:22:55 INFO - 'HOME': '/home/cltbld', 04:22:55 INFO - 'LANG': 'en_US.UTF-8', 04:22:55 INFO - 'LANGUAGE': 'en_US:en', 04:22:55 INFO - 'LOGNAME': 'cltbld', 04:22:55 INFO - 'MAIL': '/var/mail/cltbld', 04:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:55 INFO - 'MOZ_NO_REMOTE': '1', 04:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:55 INFO - 'NO_EM_RESTART': '1', 04:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:55 INFO - 'PWD': '/builds/slave/test', 04:22:55 INFO - 'SHELL': '/bin/bash', 04:22:55 INFO - 'SHLVL': '1', 04:22:55 INFO - 'TERM': 'linux', 04:22:55 INFO - 'TMOUT': '86400', 04:22:55 INFO - 'USER': 'cltbld', 04:22:55 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', 04:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:55 INFO - '_': '/tools/buildbot/bin/python'} 04:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:22: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 04:22: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 04:22: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 04:22: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 04:22:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:22:56 INFO - Installing collected packages: mozsystemmonitor 04:22:56 INFO - Running setup.py install for mozsystemmonitor 04:22:56 INFO - Successfully installed mozsystemmonitor 04:22:56 INFO - Cleaning up... 04:22:56 INFO - Return code: 0 04:22:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:22:56 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')]} 04:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:56 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')]} 04:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:56 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 0x1d951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffd60>, '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 0x2100a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100ef0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', '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 04:22:56 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 04:22:56 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 04:22:56 INFO - Using env: {'DISPLAY': ':0', 04:22:56 INFO - 'HOME': '/home/cltbld', 04:22:56 INFO - 'LANG': 'en_US.UTF-8', 04:22:56 INFO - 'LANGUAGE': 'en_US:en', 04:22:56 INFO - 'LOGNAME': 'cltbld', 04:22:56 INFO - 'MAIL': '/var/mail/cltbld', 04:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:56 INFO - 'MOZ_NO_REMOTE': '1', 04:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:56 INFO - 'NO_EM_RESTART': '1', 04:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:56 INFO - 'PWD': '/builds/slave/test', 04:22:56 INFO - 'SHELL': '/bin/bash', 04:22:56 INFO - 'SHLVL': '1', 04:22:56 INFO - 'TERM': 'linux', 04:22:56 INFO - 'TMOUT': '86400', 04:22:56 INFO - 'USER': 'cltbld', 04:22:56 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', 04:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:56 INFO - '_': '/tools/buildbot/bin/python'} 04:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:57 INFO - Downloading/unpacking jsonschema==2.5.1 04:22: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 04:22: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 04:22: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 04:22: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 04:22:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:22:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:22: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 04:22: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 04:22: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 04:22: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 04:22:58 INFO - Downloading functools32-3.2.3-2.tar.gz 04:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:22:58 INFO - warning: no files found matching '*.txt' 04:22:58 INFO - no previously-included directories found matching 'build' 04:22:58 INFO - no previously-included directories found matching 'dist' 04:22:58 INFO - no previously-included directories found matching '.git*' 04:22:58 INFO - Installing collected packages: jsonschema, functools32 04:22:58 INFO - Running setup.py install for functools32 04:22:58 INFO - warning: no files found matching '*.txt' 04:22:58 INFO - no previously-included directories found matching 'build' 04:22:58 INFO - no previously-included directories found matching 'dist' 04:22:58 INFO - no previously-included directories found matching '.git*' 04:22:58 INFO - Successfully installed jsonschema functools32 04:22:58 INFO - Cleaning up... 04:22:58 INFO - Return code: 0 04:22:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:58 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 0x1d951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffd60>, '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 0x2100a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100ef0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', '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 04:22:58 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 04:22:58 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 04:22:58 INFO - Using env: {'DISPLAY': ':0', 04:22:58 INFO - 'HOME': '/home/cltbld', 04:22:58 INFO - 'LANG': 'en_US.UTF-8', 04:22:58 INFO - 'LANGUAGE': 'en_US:en', 04:22:58 INFO - 'LOGNAME': 'cltbld', 04:22:58 INFO - 'MAIL': '/var/mail/cltbld', 04:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:58 INFO - 'MOZ_NO_REMOTE': '1', 04:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:58 INFO - 'NO_EM_RESTART': '1', 04:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:58 INFO - 'PWD': '/builds/slave/test', 04:22:58 INFO - 'SHELL': '/bin/bash', 04:22:58 INFO - 'SHLVL': '1', 04:22:58 INFO - 'TERM': 'linux', 04:22:58 INFO - 'TMOUT': '86400', 04:22:58 INFO - 'USER': 'cltbld', 04:22:58 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', 04:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:58 INFO - '_': '/tools/buildbot/bin/python'} 04:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:22:58 INFO - Cleaning up... 04:22:58 INFO - Return code: 0 04:22:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:58 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 0x1d951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffd60>, '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 0x2100a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100ef0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', '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 04:22:58 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 04:22:58 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 04:22:58 INFO - Using env: {'DISPLAY': ':0', 04:22:58 INFO - 'HOME': '/home/cltbld', 04:22:58 INFO - 'LANG': 'en_US.UTF-8', 04:22:58 INFO - 'LANGUAGE': 'en_US:en', 04:22:58 INFO - 'LOGNAME': 'cltbld', 04:22:58 INFO - 'MAIL': '/var/mail/cltbld', 04:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:58 INFO - 'MOZ_NO_REMOTE': '1', 04:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:58 INFO - 'NO_EM_RESTART': '1', 04:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:58 INFO - 'PWD': '/builds/slave/test', 04:22:58 INFO - 'SHELL': '/bin/bash', 04:22:58 INFO - 'SHLVL': '1', 04:22:58 INFO - 'TERM': 'linux', 04:22:58 INFO - 'TMOUT': '86400', 04:22:58 INFO - 'USER': 'cltbld', 04:22:58 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', 04:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:58 INFO - '_': '/tools/buildbot/bin/python'} 04:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:59 INFO - Downloading/unpacking blobuploader==1.2.4 04:22: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 04:22: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 04:22: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 04:22: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 04:23:00 INFO - Downloading blobuploader-1.2.4.tar.gz 04:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:23:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:23:00 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 04:23:00 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 04:23:00 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 04:23:00 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 04:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:23:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:23:00 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 04:23:00 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 04:23:00 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 04:23:00 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 04:23:00 INFO - Downloading docopt-0.6.1.tar.gz 04:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:23:00 INFO - Installing collected packages: blobuploader, requests, docopt 04:23:00 INFO - Running setup.py install for blobuploader 04:23:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:23:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:23:00 INFO - Running setup.py install for requests 04:23:01 INFO - Running setup.py install for docopt 04:23:01 INFO - Successfully installed blobuploader requests docopt 04:23:01 INFO - Cleaning up... 04:23:01 INFO - Return code: 0 04:23:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:01 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 0x1d951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffd60>, '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 0x2100a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100ef0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', '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 04:23:01 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 04:23:01 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 04:23:01 INFO - Using env: {'DISPLAY': ':0', 04:23:01 INFO - 'HOME': '/home/cltbld', 04:23:01 INFO - 'LANG': 'en_US.UTF-8', 04:23:01 INFO - 'LANGUAGE': 'en_US:en', 04:23:01 INFO - 'LOGNAME': 'cltbld', 04:23:01 INFO - 'MAIL': '/var/mail/cltbld', 04:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:01 INFO - 'MOZ_NO_REMOTE': '1', 04:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:01 INFO - 'NO_EM_RESTART': '1', 04:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:01 INFO - 'PWD': '/builds/slave/test', 04:23:01 INFO - 'SHELL': '/bin/bash', 04:23:01 INFO - 'SHLVL': '1', 04:23:01 INFO - 'TERM': 'linux', 04:23:01 INFO - 'TMOUT': '86400', 04:23:01 INFO - 'USER': 'cltbld', 04:23:01 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', 04:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:01 INFO - '_': '/tools/buildbot/bin/python'} 04:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:01 INFO - Running setup.py (path:/tmp/pip-1C5etH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:01 INFO - Running setup.py (path:/tmp/pip-mC1usq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:01 INFO - Running setup.py (path:/tmp/pip-qzTo97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:01 INFO - Running setup.py (path:/tmp/pip-alS8Sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:01 INFO - Running setup.py (path:/tmp/pip-FLAvz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:01 INFO - Running setup.py (path:/tmp/pip-8bZB2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:02 INFO - Running setup.py (path:/tmp/pip-WTnPnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:02 INFO - Running setup.py (path:/tmp/pip-uYzxi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:02 INFO - Running setup.py (path:/tmp/pip-avtqYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:02 INFO - Running setup.py (path:/tmp/pip-xJxrY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:02 INFO - Running setup.py (path:/tmp/pip-y6US9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:02 INFO - Running setup.py (path:/tmp/pip-GEqHkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:02 INFO - Running setup.py (path:/tmp/pip-aNkShc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:02 INFO - Running setup.py (path:/tmp/pip-RcWjss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:02 INFO - Running setup.py (path:/tmp/pip-s24pmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:02 INFO - Running setup.py (path:/tmp/pip-XLOHHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:02 INFO - Running setup.py (path:/tmp/pip-9UhmX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:23:02 INFO - Running setup.py install for manifestparser 04:23:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:23:02 INFO - Running setup.py install for mozcrash 04:23:03 INFO - Running setup.py install for mozdebug 04:23:03 INFO - Running setup.py install for mozdevice 04:23:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Running setup.py install for mozfile 04:23:03 INFO - Running setup.py install for mozhttpd 04:23:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Running setup.py install for mozinfo 04:23:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Running setup.py install for mozInstall 04:23:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Running setup.py install for mozleak 04:23:03 INFO - Running setup.py install for mozlog 04:23:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Running setup.py install for moznetwork 04:23:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Running setup.py install for mozprocess 04:23:04 INFO - Running setup.py install for mozprofile 04:23:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:23:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:23:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:23:04 INFO - Running setup.py install for mozrunner 04:23:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:23:04 INFO - Running setup.py install for mozscreenshot 04:23:04 INFO - Running setup.py install for moztest 04:23:04 INFO - Running setup.py install for mozversion 04:23:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:23:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:23:04 INFO - Cleaning up... 04:23:04 INFO - Return code: 0 04:23:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:04 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')]} 04:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:04 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')]} 04:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:04 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 0x1d951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffd60>, '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 0x2100a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100ef0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', '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 04:23:04 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 04:23:04 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 04:23:04 INFO - Using env: {'DISPLAY': ':0', 04:23:04 INFO - 'HOME': '/home/cltbld', 04:23:04 INFO - 'LANG': 'en_US.UTF-8', 04:23:04 INFO - 'LANGUAGE': 'en_US:en', 04:23:04 INFO - 'LOGNAME': 'cltbld', 04:23:04 INFO - 'MAIL': '/var/mail/cltbld', 04:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:04 INFO - 'MOZ_NO_REMOTE': '1', 04:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:04 INFO - 'NO_EM_RESTART': '1', 04:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:04 INFO - 'PWD': '/builds/slave/test', 04:23:04 INFO - 'SHELL': '/bin/bash', 04:23:04 INFO - 'SHLVL': '1', 04:23:04 INFO - 'TERM': 'linux', 04:23:04 INFO - 'TMOUT': '86400', 04:23:04 INFO - 'USER': 'cltbld', 04:23:04 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', 04:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:04 INFO - '_': '/tools/buildbot/bin/python'} 04:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:04 INFO - Running setup.py (path:/tmp/pip-22e5ZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:04 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)) 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:04 INFO - Running setup.py (path:/tmp/pip-6pMZ7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:04 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)) 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:04 INFO - Running setup.py (path:/tmp/pip-h3IE2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:05 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)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:05 INFO - Running setup.py (path:/tmp/pip-FnBtUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:05 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)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:05 INFO - Running setup.py (path:/tmp/pip-sBUpS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:05 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)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:05 INFO - Running setup.py (path:/tmp/pip-rtEe4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:05 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)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:05 INFO - Running setup.py (path:/tmp/pip-B8IBgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:05 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)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:05 INFO - Running setup.py (path:/tmp/pip-Pjotl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:05 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)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:05 INFO - Running setup.py (path:/tmp/pip-6xmAjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:05 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)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:05 INFO - Running setup.py (path:/tmp/pip-SMIXqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:05 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)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:05 INFO - Running setup.py (path:/tmp/pip-I66oY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:05 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)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:05 INFO - Running setup.py (path:/tmp/pip-PN7C7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:05 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)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:05 INFO - Running setup.py (path:/tmp/pip-3X0tZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:05 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)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:05 INFO - Running setup.py (path:/tmp/pip-uk_sIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:05 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)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:05 INFO - Running setup.py (path:/tmp/pip-RJQG_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:05 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)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:05 INFO - Running setup.py (path:/tmp/pip-NIrC7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:05 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)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:05 INFO - Running setup.py (path:/tmp/pip-tGvZUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:06 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)) 04:23:06 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)) 04:23:06 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)) 04:23:06 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)) 04:23:06 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)) 04:23:06 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)) 04:23:06 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)) 04:23:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23: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 04:23: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 04:23: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 04:23: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 04:23:07 INFO - Downloading blessings-1.6.tar.gz 04:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:23:07 INFO - Installing collected packages: blessings 04:23:07 INFO - Running setup.py install for blessings 04:23:07 INFO - Successfully installed blessings 04:23:07 INFO - Cleaning up... 04:23:07 INFO - Return code: 0 04:23:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:07 INFO - Reading from file tmpfile_stdout 04:23:07 INFO - Current package versions: 04:23:07 INFO - argparse == 1.2.1 04:23:07 INFO - blessings == 1.6 04:23:07 INFO - blobuploader == 1.2.4 04:23:07 INFO - docopt == 0.6.1 04:23:07 INFO - functools32 == 3.2.3-2 04:23:07 INFO - jsonschema == 2.5.1 04:23:07 INFO - manifestparser == 1.1 04:23:07 INFO - mozInstall == 1.13 04:23:07 INFO - mozcrash == 1.0 04:23:07 INFO - mozdebug == 0.1 04:23:07 INFO - mozdevice == 0.51 04:23:07 INFO - mozfile == 1.2 04:23:07 INFO - mozhttpd == 0.7 04:23:07 INFO - mozinfo == 0.10 04:23:07 INFO - mozleak == 0.1 04:23:07 INFO - mozlog == 3.5 04:23:07 INFO - moznetwork == 0.27 04:23:07 INFO - mozprocess == 0.25 04:23:07 INFO - mozprofile == 0.28 04:23:07 INFO - mozrunner == 6.13 04:23:07 INFO - mozscreenshot == 0.1 04:23:07 INFO - mozsystemmonitor == 0.3 04:23:07 INFO - moztest == 0.8 04:23:07 INFO - mozversion == 1.4 04:23:07 INFO - psutil == 3.1.1 04:23:07 INFO - requests == 1.2.3 04:23:07 INFO - wsgiref == 0.1.2 04:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:07 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')]} 04:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:07 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')]} 04:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:07 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 0x1d951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffd60>, '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 0x2100a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100ef0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', '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 04:23:07 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 04:23:07 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 04:23:07 INFO - Using env: {'DISPLAY': ':0', 04:23:07 INFO - 'HOME': '/home/cltbld', 04:23:07 INFO - 'LANG': 'en_US.UTF-8', 04:23:07 INFO - 'LANGUAGE': 'en_US:en', 04:23:07 INFO - 'LOGNAME': 'cltbld', 04:23:07 INFO - 'MAIL': '/var/mail/cltbld', 04:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:07 INFO - 'MOZ_NO_REMOTE': '1', 04:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:07 INFO - 'NO_EM_RESTART': '1', 04:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:07 INFO - 'PWD': '/builds/slave/test', 04:23:07 INFO - 'SHELL': '/bin/bash', 04:23:07 INFO - 'SHLVL': '1', 04:23:07 INFO - 'TERM': 'linux', 04:23:07 INFO - 'TMOUT': '86400', 04:23:07 INFO - 'USER': 'cltbld', 04:23:07 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', 04:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:07 INFO - '_': '/tools/buildbot/bin/python'} 04:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:07 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)) 04:23:07 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)) 04:23:07 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)) 04:23:07 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)) 04:23:07 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)) 04:23:07 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)) 04:23:07 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)) 04:23:07 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)) 04:23:07 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)) 04:23:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:23:07 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 04:23:07 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 04:23:07 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 04:23:07 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 04:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:23:09 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)) 04:23:09 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)) 04:23:09 INFO - Installing collected packages: simplejson 04:23:09 INFO - Running setup.py install for simplejson 04:23:09 INFO - building 'simplejson._speedups' extension 04:23:09 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 04:23:09 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 04:23:10 INFO - Successfully installed simplejson 04:23:10 INFO - Cleaning up... 04:23:10 INFO - Return code: 0 04:23:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:23:10 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')]} 04:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:10 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')]} 04:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1d951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ffd60>, '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 0x2100a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100ef0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', '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 04:23:10 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 04:23:10 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 04:23:10 INFO - Using env: {'DISPLAY': ':0', 04:23:10 INFO - 'HOME': '/home/cltbld', 04:23:10 INFO - 'LANG': 'en_US.UTF-8', 04:23:10 INFO - 'LANGUAGE': 'en_US:en', 04:23:10 INFO - 'LOGNAME': 'cltbld', 04:23:10 INFO - 'MAIL': '/var/mail/cltbld', 04:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:10 INFO - 'MOZ_NO_REMOTE': '1', 04:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:10 INFO - 'NO_EM_RESTART': '1', 04:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:10 INFO - 'PWD': '/builds/slave/test', 04:23:10 INFO - 'SHELL': '/bin/bash', 04:23:10 INFO - 'SHLVL': '1', 04:23:10 INFO - 'TERM': 'linux', 04:23:10 INFO - 'TMOUT': '86400', 04:23:10 INFO - 'USER': 'cltbld', 04:23:10 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', 04:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:10 INFO - '_': '/tools/buildbot/bin/python'} 04:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:23:10 INFO - Cleaning up... 04:23:10 INFO - Return code: 0 04:23:10 INFO - Running post-action listener: _resource_record_post_action 04:23:10 INFO - Running post-action listener: _start_resource_monitoring 04:23:10 INFO - Starting resource monitoring. 04:23:10 INFO - [mozharness: 2017-09-25 11:23:10.342789Z] Finished create-virtualenv step (success) 04:23:10 INFO - [mozharness: 2017-09-25 11:23:10.343922Z] Running install step. 04:23:10 INFO - Running pre-action listener: _resource_record_pre_action 04:23:10 INFO - Running main action method: install 04:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:10 INFO - Reading from file tmpfile_stdout 04:23:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:23:10 INFO - Reading from file tmpfile_stdout 04:23:10 INFO - Output received: 04:23:10 INFO - Usage: mozinstall [options] installer 04:23:10 INFO - Options: 04:23:10 INFO - -h, --help show this help message and exit 04:23:10 INFO - -d DEST, --destination=DEST 04:23:10 INFO - Directory to install application into. [default: 04:23:10 INFO - "/builds/slave/test"] 04:23:10 INFO - --app=APP Application being installed. [default: firefox] 04:23:10 INFO - mkdir: /builds/slave/test/build/application 04:23:10 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'] 04:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:23:28 INFO - Reading from file tmpfile_stdout 04:23:28 INFO - Output received: 04:23:28 INFO - /builds/slave/test/build/application/firefox/firefox 04:23:28 INFO - Running post-action listener: _resource_record_post_action 04:23:28 INFO - [mozharness: 2017-09-25 11:23:28.303405Z] Finished install step (success) 04:23:28 INFO - [mozharness: 2017-09-25 11:23:28.303551Z] Running setup-mitmproxy step. 04:23:28 INFO - Running pre-action listener: _resource_record_pre_action 04:23:28 INFO - Running main action method: setup_mitmproxy 04:23:28 INFO - Skipping: mitmproxy is not required 04:23:28 INFO - Running post-action listener: _resource_record_post_action 04:23:28 INFO - [mozharness: 2017-09-25 11:23:28.304685Z] Finished setup-mitmproxy step (success) 04:23:28 INFO - [mozharness: 2017-09-25 11:23:28.304904Z] Running run-tests step. 04:23:28 INFO - Running pre-action listener: _resource_record_pre_action 04:23:28 INFO - Running pre-action listener: _set_gcov_prefix 04:23:28 INFO - Running main action method: run_tests 04:23:28 WARNING - Try message not found. 04:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:23:28 INFO - Python 2.7.3 04:23:28 INFO - Return code: 0 04:23:28 INFO - grabbing minidump binary from tooltool 04:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:28 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 0x20ffd60>, '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 0x2100a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:23:28 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 04:23:28 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 04:23:28 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 04:23:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:23:28 INFO - Return code: 0 04:23:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:23:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:23:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:23:28 INFO - ENV: RUST_BACKTRACE is now full 04:23:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:23:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:23:28 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/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 04:23:28 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/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 04:23:28 INFO - Using env: {'DISPLAY': ':0', 04:23:28 INFO - 'HOME': '/home/cltbld', 04:23:28 INFO - 'LANG': 'en_US.UTF-8', 04:23:28 INFO - 'LANGUAGE': 'en_US:en', 04:23:28 INFO - 'LOGNAME': 'cltbld', 04:23:28 INFO - 'MAIL': '/var/mail/cltbld', 04:23:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:23:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:28 INFO - 'MOZ_NO_REMOTE': '1', 04:23:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:28 INFO - 'NO_EM_RESTART': '1', 04:23:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:28 INFO - 'PWD': '/builds/slave/test', 04:23:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:23:28 INFO - 'RUST_BACKTRACE': 'full', 04:23:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:23:28 INFO - 'SHELL': '/bin/bash', 04:23:28 INFO - 'SHLVL': '1', 04:23:28 INFO - 'TERM': 'linux', 04:23:28 INFO - 'TMOUT': '86400', 04:23:28 INFO - 'USER': 'cltbld', 04:23:28 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', 04:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:28 INFO - '_': '/tools/buildbot/bin/python'} 04:23:28 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/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 04:23:28 INFO - mozversion application_buildid: 20170925095628 04:23:28 INFO - mozversion application_changeset: 13ce77b78e364cc952d51b959f22202502be2941 04:23:28 INFO - mozversion application_display_name: Nightly 04:23:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:23:28 INFO - mozversion application_name: Firefox 04:23:28 INFO - mozversion application_remotingname: firefox 04:23:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:23:28 INFO - mozversion application_vendor: Mozilla 04:23:28 INFO - mozversion application_version: 58.0a1 04:23:28 INFO - mozversion platform_buildid: 20170925095628 04:23:28 INFO - mozversion platform_changeset: 13ce77b78e364cc952d51b959f22202502be2941 04:23:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:23:28 INFO - mozversion platform_version: 58.0a1 04:23:28 INFO - using testdate: 1506338608 04:23:28 INFO - actual date: 1506338608 04:23:28 INFO - starting webserver on 'localhost:39758' 04:23:28 INFO - SUITE-START | Running 2 tests 04:23:28 INFO - TEST-START | dromaeo_css 04:23:28 INFO - Initialising browser for dromaeo_css test... 04:23:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39758/getInfo.html -profile /tmp/tmpVA2eTI/profile 04:23:28 INFO - TEST-INFO | started process 3574 (/builds/slave/test/build/application/firefox/firefox http://localhost:39758/getInfo.html) 04:23:38 INFO - TEST-INFO | 3574: exit 0 04:23:38 INFO - Browser initialized. 04:23:38 INFO - Running cycle 1/1 for dromaeo_css test... 04:23:38 INFO - Using env: {'DISPLAY': ':0', 04:23:38 INFO - 'HOME': '/home/cltbld', 04:23:38 INFO - 'JSGC_DISABLE_POISONING': '1', 04:23:38 INFO - 'LANG': 'en_US.UTF-8', 04:23:38 INFO - 'LANGUAGE': 'en_US:en', 04:23:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:23:38 INFO - 'LOGNAME': 'cltbld', 04:23:38 INFO - 'MAIL': '/var/mail/cltbld', 04:23:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:23:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:23:38 INFO - 'MOZ_CRASHREPORTER': '1', 04:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:23:38 INFO - 'MOZ_NO_REMOTE': '1', 04:23:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:38 INFO - 'NO_EM_RESTART': '1', 04:23:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:38 INFO - 'PWD': '/builds/slave/test', 04:23:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:23:38 INFO - 'RUST_BACKTRACE': 'full', 04:23:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:23:38 INFO - 'SHELL': '/bin/bash', 04:23:38 INFO - 'SHLVL': '1', 04:23:38 INFO - 'STYLO_FORCE_DISABLED': '1', 04:23:38 INFO - 'TERM': 'linux', 04:23:38 INFO - 'TMOUT': '86400', 04:23:38 INFO - 'USER': 'cltbld', 04:23:38 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', 04:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:38 INFO - '_': '/tools/buildbot/bin/python'} 04:23:38 INFO - TEST-INFO | started process 3816 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVA2eTI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:39 INFO - PID 3816 | 04:23:39 INFO - PID 3816 | (/builds/slave/test/build/application/firefox/firefox:3865): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:23:39 INFO - PID 3816 | 04:23:49 INFO - PID 3816 | RSS: Main: 141594624 04:23:49 INFO - PID 3816 | 04:26:46 INFO - PID 3816 | Cycle 1(1): loaded http://localhost:39758/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39758/tests/dromaeo/cssquery-ext.html) 04:26:47 INFO - PID 3816 | RSS: Main: 146382848 04:26:47 INFO - PID 3816 | 04:29:49 INFO - PID 3816 | Cycle 1(1): loaded http://localhost:39758/tests/dromaeo/cssquery-ext.html (next: http://localhost:39758/tests/dromaeo/cssquery-jquery.html) 04:29:49 INFO - PID 3816 | RSS: Main: 145920000 04:29:49 INFO - PID 3816 | 04:32:51 INFO - PID 3816 | Cycle 1(1): loaded http://localhost:39758/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39758/tests/dromaeo/cssquery-mootools.html) 04:32:51 INFO - PID 3816 | RSS: Main: 148086784 04:32:51 INFO - PID 3816 | 04:35:53 INFO - PID 3816 | Cycle 1(1): loaded http://localhost:39758/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39758/tests/dromaeo/cssquery-prototype.html) 04:35:54 INFO - PID 3816 | RSS: Main: 144867328 04:35:54 INFO - PID 3816 | 04:38:57 INFO - PID 3816 | Cycle 1(1): loaded http://localhost:39758/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39758/tests/dromaeo/cssquery-yui.html) 04:38:57 INFO - PID 3816 | RSS: Main: 148271104 04:38:57 INFO - PID 3816 | 04:41:59 INFO - PID 3816 | Cycle 1(1): loaded http://localhost:39758/tests/dromaeo/cssquery-yui.html (next: http://localhost:39758/tests/dromaeo/cssquery-dojo.html) 04:41:59 INFO - PID 3816 | RSS: Main: 150896640 04:41:59 INFO - PID 3816 | 04:41:59 INFO - PID 3816 | __start_tp_report 04:41:59 INFO - PID 3816 | _x_x_mozilla_page_load 04:41:59 INFO - PID 3816 | _x_x_mozilla_page_load_details 04:41:59 INFO - PID 3816 | |i|pagename|runs| 04:41:59 INFO - PID 3816 | |0;dojo.html;3893.3965235388514;3902.8243729032192;3903.0242439390154;3919.7844118573466;3942.388929715893;6228.096925945735;6301.873962520747;6360.80917572473;6382.138411314471;6455.774047908324;6344.365563443654;6371.776987805428;6388.073729309259;6434.9678251608675;6499;5681.971590142043;5759.68321742304;5765.4811067004175;5775.3358363788175;5780.277465316835;111.97792152131414;5676.091825307952;5747.712614369286;5837.036888913345;5847;5315.973420132913;5670.886582268332;5699.344575373843;5789.971050144764;5793.652380857162;5705.372409035002;5706.3722990471015;5791.739371728282;5800.361960184377;5837.036888913324;5697.886042279131;5710.685912274823;5766.654000759926;5767.711614419304;5782.3639399666;6367.6497792621385;6370.426661600478;6422.678866056725;6444.709988050549;6501.479881609507;6785.457163426914;6830.077939478207;6965.825854353631;7051.788446346566;7052.224255331909;6890.44876409886;6898.448124150056;6910.3089691031;6981.650917454107;6984.615846128461;6292.622442653455;6313.116163737081;6366.554341196118;6382.553221274513;6385.96807015962;7169.175544812413;7189.784306470762;7260.310270524292;7278.636068196675;7279.6360181990685;6883.793486195422;6892.345227203407;6958.408535274457;6959.652017399109;6968.895466568006;6867.278935711678;6929.792106236821;6968.338007889242;6984.371406573331;6995.300469952964;6826.965865170642;6840.657967101625;6913.3777959983845;6968.163820341591;6998.580085194904;6921.550099243533;6929.133858267716;6980.371766540934;6991.440684745208;6998.580085194904;5024.095662780662;5048.974755126201;5080;5094.643374963717;5122.9743851281255;4581.839635612738;4590.609798167126;4647.930281045787;4658.883527911761;4660.091282200006;6359.077933699587;6370.406629138819;6445.4199122079235;6449.290578036413;6459.321771214049;6805.591664500146;6887.586744795329;6931.306869313028;6931.826704332331;6937.202221744463;6303.023031430135;6361.522885783585;6447.161868957006;6452.032195170762;6454.257760357619;5659.320881494247;5704.914426283609;5710.114932185518;5712.285964254468;5715.714214289269;7105.89341159883;7182.856342873218;7185.96407017972;7293.161286452126;7298.598577078205;6747.561408508432;6867.931320686829;6887.070245516991;6964.338387853146;6975.651217439006;7162.176349719641;7213.60325182099;7235.2764723527225;7236.927630723625;7306.123265208209;6819.386255237053;6915.51591388598;6921.204061532988;6943.166819981635;6947.79156625302;6940.444764418733;6948;7034.648267586703;7039.366457018893;7053.365197132282;6656.201255849329;6689;6747.696353664195;6759.831004224737;6773.390394864486;6759.425448836707;6779.694913728993;6797.5581587196675;6798.796036118924;6799.048133261248;6616.437602803623;6644.235912870082;6687.966560167168;6731.360520750521;6749.223839258351;6697.799066028027;6787.966060169668;6865.519413641197;6892.931070689229;6911.550749201286;6483.4164925156965;6556.606603603799;6591.505637077143;6596.2744098148205;6671.032700258533 04:41:59 INFO - PID 3816 | |1;ext.html;935.5088578496288;955.3551352836834;986.8914419413863;1013.5337744637462;1014.0417305646165;42432.787836060816;43459.78270108653;43675.78162109189;43685.7815710921;43762.12475750483;40906.590934090724;40961.38557921634;41153.79423102888;41167.38248926269;41249;7648;7737.690492380298;7757.806054848617;7774.727884524043;7777.844443111135;7726.304632583066;7823.100343460518;7823.452358334919;7825.765227043198;7836.804079897991;8375.497470151811;8554.828903421927;8568.657253709844;8569.700060497884;8571.699990500334;8457.112003239663;8469.999999999969;8490.490570565786;8492.957535212347;8513.95743021284;8209.958950205271;8424.073351931283;8429.072801991775;8437.957810210972;8441.240288374014;40669.59330406717;41051.589484105374;41056.794716026525;41077;41105.383419248734;3680.4847321375028;3720.014196237999;3720.8697695580795;3722.181120153562;3726.9440958385644;32379.190520236945;32675.509867352008;32704.836475817705;32764.508532372034;32843.83578082094;5493.176023596453;5496.1755736639425;5519.475649813261;5525.336959564878;5529.806456774034;211825;213791;214169.92915035482;214223;215280;51457.742711286206;51541.226881596805;51688.74155629198;51827;51867.481325186265;53656.195157072674;53927.46072539303;54133.45866541284;54245.45754542483;54303.45696543063;16557;17001.829981700026;17007.48977530676;17039.062851543036;17050.147492625318;13793.10344827583;13809.792853107212;13819.516316928859;13828.446862125402;13844.30778461073;14867.553973380816;15195.92402038005;15236;15288.464903728316;15328.616784580474;5928.170056192136;6082.422169893853;6194.132821405007;6248.593841400295;6307.4954003679595;1091.44881834673;1096.5778175402527;1099.6646022962914;1101.9504122314515;1112.2158877990996;23874.925628346766;24414.389640259134;24668.753312467004;24766.504669906502;24845.87577062103;1191.7497325561728;1198.4846515998204;1204.951801927913;1205.2166092040068;1206.3365149167923;12854.421551030226;12919.160254583421;12937.676558086123;12979.091463597646;13073.934630326787;264032;266766;269364;272704;273375;54590.72704636451;58255;59731.40268597345;60012.69993650091;60262.69868650717;1474.2555009720238;1491.56744544081;1491.7314883321105;1491.9104853708811;1517.2413793103449;29367.412651747272;29606;29752.107436776932;29899.850500747358;29996;39304.60695393124;40239.79880100698;40373;40498.797506012284;40534.39198411967;222393;223742;224942;226943;226983;34024.48963265504;34104.48843267303;34207.82896085503;34243;34265.828670856485;42013.159736805705;42942.57057429386;43475.130497390506;43493.565064350216;43593;32546;33054.016758994534;33150.336993260484;33181.66818331786;33340;32263.838680806446;33098;33149.33701326008;33347.49978750272;33681.32637347288;37928.43107353447;37931;38312.04219894525;38313.616863831005;38507.80746096252;31171.220719482193;31222.21944451316;31487.685123148476;31668.683313166573;31952.84023579867;24718.629220562067;24975.750242497343;25004.249872503853;25173;25374.74625253724 04:41:59 INFO - PID 3816 | |2;jquery.html;588.5262363797142;593.6734795862275;606.3804365142585;608.747369841516;617.4998251416353;23269.301920942376;23705.881470592645;23912.76087239127;23924.88037559812;23944.1619543316;25067.510569584563;25539.489210215783;25608.487830243383;25740.613890791654;25760.871195643995;6731.9326806731915;6866.27904070073;6890.655467226644;6895.482838787086;6898.448124150081;6512.934870651304;6689.598624082546;6776.966115169417;6817.965910170467;6859.691313890862;6753.864922701543;6757.222919364262;6767.390934815866;6770.898436523432;6775.62734049627;6548.116004339401;6763.120794296759;6796.116504854387;6805.353491418332;6851.520393572452;6367.42693157618;6381.553291269613;6385.2656944451055;6388.39310265524;6404.7117879695525;29940.70059299401;30000;30160.8491957541;30380.8480957596;30514.237144071354;2324.5467133908896;2355.6348765941134;2356.045801450415;2360.3980984848927;2361.1381845626224;20595;20783.16867325305;21352.893235533724;21609.35171944844;21626.24308149223;2493.925182244536;2503.624456331565;2571.974280257211;2592.922212333633;2605.557055300603;133508.33245833806;140278;152184;160571;160574.99999999884;16087.67824643524;16667.49997500077;16798.664026719398;16990.405335813186;17082.743758843626;25537.48925021526;25654.74345256561;25678;25691.48617027649;25830.354241144123;10866.891331086588;11077.50151243196;11220.382878941573;11228.382438965771;11231.71920701989;10076.69769906904;10083.19334453242;10092.444915529717;10243.282970192015;10251.948740256252;9760.707178784647;10050.798984020425;10246.436445995541;10259.28185027056;10305;2942.911712648624;2958.689337619562;2972;2974.9553756693667;3043.1479185828002;1032.8863824979246;1048.9213309001855;1059.422614675004;1075.3762817565794;1085.8045551800594;20597;21306.893465532885;21574.600257672668;21598.56802863934;21661.67507487389;1104.679642903565;1105.1214284643727;1108.800415925125;1119.412308538024;1125.1336470917347;11574.247673901338;11634.476448559835;11637.53449861996;11662.241954272946;11751.529938802523;591601;592750;599408;602100;609203;131629;134707.326463369;134971.32514337366;136677;137974.62025379617;1113.7494063835572;1164.574930150489;1224.5591587028662;1239.8450193725785;1266.468083404972;22289.5511791733;22745.886270569204;22767.65848512307;22842;22969;63263.36736632575;64529.67735161294;64567.35432645614;65049;65891.34108658852;81532;81599.59200203962;81661;82554.58722706589;83168;15520;15910.0453972762;15999.280032398803;16006.519804405887;16028.67942641164;23678.28965131049;24228.51542969166;24367.756322436548;24444;24532.754672453048;19419.3203237886;19654.60690786148;19831.10760015774;20057;20101.29645462402;14872.479463219168;15528.223588820289;16467.423640172536;17642.470725878244;17922.820771792638;20253.898730506255;20371.59256814885;20492;20594.27920022792;20807.791922080585;15665.765013524579;15685.372585096467;15748.606284842512;15794.68410631804;15797.684046319238;19408.320708775125;19565.8043419564;19670.606587867875;20010.399688009384;20167.294144704865 04:41:59 INFO - PID 3816 | |3;mootools.html;1404.5154421724505;1444;1462.2891217275787;1473.270730988161;1483.6958423523176;16762.41331553396;17392.56518587036;17409.129543522835;17415.47753567392;17434.215460304284;17017.489475315728;17309.567260818487;17358.305667773275;17379.217935192915;17386.391476298333;2672.719364466737;2802.495550800855;2803.649543807024;2804.4531316393313;2808.8174268672574;2664.9200523984214;2720.8367497950185;2721.1700431368427;2724.1282789507363;2734.3437574981963;2786.21985843964;2822.971770282302;2823.153054083777;2824.3503994081375;2830.632017837678;2342.8242881783763;2420.261820144855;2520.43290259691;2573.163721790426;2588.5858262677975;2631.4342416380377;2711.7423844734917;2713.077553631755;2716.1444145094233;2720;16967.406140785013;16983.57541061471;17053.976761394355;17127.229274682668;17132.828671713374;8327.50034997902;8609.440386374928;8613.224809767089;8613.61238744258;8616.612252448655;5012.699238045729;5136.794528218867;5226.503482169188;5289.391719952217;5294;2088.2482306369693;2098.1921960045493;2116.0426605389953;2130.456733532955;2157.083239623154;30259.243518911982;30360.8481957591;30559.38881222363;30609.234769130726;30623.08130756081;7174.3184397482155;7250.6374681265725;7302.415806735448;7441.55350678961;7455.515391499535;19713.310034149024;19792.406227812902;19846;19870.205191792455;19906.402807915787;8159.877601835978;8573.571321433903;8802;8809.867851982226;8815.867761983576;7614.961925190339;7706.113796913427;7764.728234511765;7796.5711885845685;7808.219178082147;5555.861103472364;5693.459121383462;5694.259746232963;5704.201411802351;5734.16854556087;1610.9355625775072;1622.6024623966969;1628.804543454793;1630.861376782963;1641.9343226271055;911.694582314932;932.7994481186441;943.1323182671821;944.9102335278275;951.9762005949768;8074.757757267292;8232.62953167109;8240.50556966572;8258.380621453294;8268.173182681683;795.6459375577928;801.0907619851511;806.2824086562964;806.8345989072226;814.9062857771314;5497.120460726264;6140.2017737694705;6201.906971395432;6236.906446403307;6292.433680968735;24521.264362069167;24891.128810491547;25123.120690775737;25639.10263140781;25722.6141607876;22800.31599052031;23700.170494032627;23790.405239869142;23899;23961.760382395954;12419.379031048593;12521.186122901981;12568.874311256954;12760.80858787119;12768.553100641433;9395.342326037386;9966.40201587878;10024.997500249916;10128.392296462236;10282.07461328484;21688.566228675023;21690.566188676454;21779.12883484643;21950;22501.549969000855;22465.213717519808;22510.099596015974;22746;22838.31485055451;23344.53310933738;12572.245665260114;12604.810927836274;12610.432530535965;12660.556880509139;12708.618741437771;15504.84495155034;15555.300011499283;15574.532764017098;15707.842921570638;15715.607109822346;12663.810042849549;12815.423305951068;12824.358782060674;12933.09468337245;12961.675958101123;11865.5847045353;12168.209066410654;12282.631521054383;12352.876471235173;12433.37833108323;10814;11035.39305338214;11043.171762117712;11043.503042363274;11049;8450.070492245724;8571.314294856273;8613.48319100856;8634.266087382643;8652;8007;8013.19868013194;8113.7565873023905;8116.107228204774;8130 04:41:59 INFO - PID 3816 | |4;prototype.html;523.1629392971247;530.7929907336139;548.8408361575141;551.2392897801034;561.8230257468897;6239.188905442292;6301.6534090625;6327.841803954909;6354.904676429852;6394.616323020622;6338.749743840939;6346.921023426017;6351.428371446569;6355.555111142222;6360.268569114542;5160;5177.559907407875;5193.428722840504;5194.6493911583075;5202.115640341132;4809.639277054217;5017.473165317644;5070.670406423571;5090.770915308802;5118.129917913963;5049.823256186034;5057.873553161164;5060.116987107441;5072.72100034498;5091.389033316007;5030.748462576893;5048.419431765339;5073.873153171164;5091.949080509222;5107.284980102789;4712.387389639359;4715.386999690053;4727.7163370197895;4748.691335063209;4751.311059896296;6079.908801367983;6150.5079593632845;6151.907721384183;6221.471174950135;6250.7812226572305;5971.4327138921735;6038.667873266969;6041.1240370146525;6077.878442431171;6078.817635470943;6661.533692641517;6685.298043705389;6708.83227919301;6741.179881431985;6747.730090796363;5190.390978796585;5210.739463026872;5298.682079075268;5333.839984800424;5348.277982472356;6724.899126513106;6845.589264644137;6876.112032946175;6883.965580172117;6952.165740111219;5635.492805647511;5648.435156484319;5650.717464126859;5650.773969041193;5664.745086471119;5731.856703582361;5737.913931291034;5760.42395760429;5762.625429347079;5767.971160144256;6080.7871724490315;6104.87059893921;6106.801551441477;6119.326874043852;6138.416850399205;6706.530542861953;6737.461003119739;6756.797296081126;6772.661366931732;6789.117414736152;1962.254343349518;1972.6054789042248;1986.5927484865567;1992.870463419873;2002.209127394671;1405.7610206264756;1469.4709904434394;1481.3333999700178;1488.4046381447508;1520.4222395489644;6209.9068513972325;6218.258887511504;6234;6251.187345645128;6283.3088360280335;6684.2647308795995;6686.1642294713165;6701.262861085277;6735.966320168368;6741.528093033538;6174.166487524217;6176;6204.3795620437595;6219.751209951552;6237.500999919996;3534.593521744981;3551.183227857607;3555.666625015619;3575.3564358415733;3577.5170352002665;7053.576785392893;7059.8820353893625;7075.150981882207;7081.442082741789;7095.609741464269;6900.447964162955;6917.619530925847;6922.7923162305215;6963.09479767627;6977.860442791116;6745.52781305304;6992.720291188295;7008.762201640544;7033.859322813618;7037.155541334971;6502.252240992347;6591.868162636816;6594.802155935329;6618.238902526271;6695.12963314766;6608.768693095719;6679.432248258952;6699.430548403246;6730.192376914606;6762.8985565217545;6887.449004079562;6887.6556172192195;6982.895256571054;6986.790396288119;7088.432925365855;5599.664020158803;5601.467860553241;5606.355269144101;5653.3498647654405;5657.32112146545;6600.471962243105;6606.192368243381;6722.764703235363;6729.394354508117;6747.359000894907;6380.9361906380345;6394.200724909387;6454.128692626623;6496.610203387811;6539.705713243011;6445.935540644721;6452.741890324334;6489.448396886129;6496.480281577557;6554.14796076507;6440.677966101583;6473.935260647333;6474.482041436768;6493.675316234075;6551.181102362205;6536.934630653633;6554.918438457601;6571.277159512354;6600.60396376219;6659.4006539411685;6303.369663033844;6311.558190926775;6311.842203944938;6393.1369265148605;6394.328595497405 04:41:59 INFO - PID 3816 | |5;yui.html;960.0783248081846;960.8991055939126;976.0971101730897;977.8386566216573;986.8207492047006;21080.367588972334;22425.66361504579;22432.32703018908;22438.43903902401;22473.21343752969;20470;20702.68945965812;20712.585748285026;21480.57038859222;22497.662535061987;1092.355510248953;1104.6630777612825;1106.0709004436271;1106.1537923488538;1106.2753896198003;1039.0129377091794;1075.833245846895;1083.6586475260308;1085.1047885494459;1085.9891401086006;1150.2408410449104;1159.3855256713955;1161.866385365681;1162.7093226693328;1162.7441962768178;1145.3357052909375;1151.1999160583398;1151.856017997746;1152.216492784906;1157.8494795676593;838.7190291252438;839.047680882197;845.5053793530792;847.3179090831878;847.8770578266117;19886.602267954706;20065.1973921043;20326.5934681307;20400.489987750276;20908;22349.441263968532;22509.437264068365;22875.77124228753;22943.082276708912;23006.76993230063;18029.098545072826;18119.63760724778;18180.818191818045;18243.17905694247;18248.178831952595;3717.3866312058476;3798.0315019669806;3899.6490315871706;3919.5884432134785;3949.111449923773;152426;156873;156907;157722;157871;16951.06769127685;17223.56941076483;17436.302547897943;17459.38892138769;17506.29974801019;33027.83486082602;33334.8333258337;33424.66575334264;33781.66218337834;34045.489317660256;8722.912770872337;8776.25401840838;8853.778655533662;8859.202671759573;8921.776955576162;4795.736234507136;4799.66402351839;4856.587190088882;4879.097366987119;4885.7312847793;6098.1157732128595;6192.876142477216;6209.6895155242055;6227.221597300338;6237.282712488122;1120.0815331428314;1162.0761494611804;1166.6616681162538;1178.6581891251442;1183.816508441193;719.3382088478612;742.6323969635065;744.4825846037061;755.652399896054;767.673738661078;13311.201327920357;13578.796318055238;13592.38834252461;14301.78547321791;14307.85692143086;682.8975653651992;699.2448155991517;705.7424040225384;706.9399101076364;712.2236761929522;6136.631802091889;6301.873962520724;6308.274548426898;6367.713452894631;6419.165508483868;142860;143513;143518;144443;146984;114624;116761;117871;119428.40285798516;119883.40058299653;106330.46834765932;107650;109125;109234.45382773194;110858.44570777095;11947.163698541366;12041.277523348626;12051.819222711842;12244.020478361888;15100.924495377452;49037.2644410327;52108.21837672514;52388;52572.474275256754;52971.20543191932;86803.56598216969;86919.8270043254;89454.55272723595;90238.54880725816;92212;21064.368068957956;21411.35765927025;22224.888875556164;22255.332340029825;22269.109235630393;24311.149109781072;24320.878395608615;24609.13868014611;24845.503089937738;25355.6196657054;21316.36050918475;21458.678119827902;21637.918104094417;22441.21455749041;23020;20587.4853128673;20869.686954695997;21102.47243818917;21109.89445052765;21241.78758212398;21672.133114675868;21718.67421988703;21944;22461.66307505356;22721.659175112058;13492.86507134916;13573.914086873225;14566.417343306573;14601.196934168724;15215;15292.311845966735;15409.998350107207;15423.383064677288;16457.83542164611;16822.327106915585 04:41:59 INFO - PID 3816 | __end_tp_report 04:41:59 INFO - PID 3816 | __start_cc_report 04:41:59 INFO - PID 3816 | _x_x_mozilla_cycle_collect,281 04:41:59 INFO - PID 3816 | __end_cc_report 04:41:59 INFO - PID 3816 | __startTimestamp1506339719437__endTimestamp 04:41:59 INFO - PID 3816 | 04:41:59 INFO - PID 3816 | ------- Summary: start ------- 04:41:59 INFO - PID 3816 | Number of tests: 6 04:41:59 INFO - PID 3816 | 04:41:59 INFO - PID 3816 | [#0] dojo.html Cycles:165 Average:6358.65 Median:6671.03 stddev:909.36 (13.6%) stddev-sans-first:891.34 04:41:59 INFO - PID 3816 | Values: 3893.4 3902.8 3903.0 3919.8 3942.4 6228.1 6301.9 6360.8 6382.1 6455.8 6344.4 6371.8 6388.1 6435.0 6499.0 5682.0 5759.7 5765.5 5775.3 5780.3 112.0 5676.1 5747.7 5837.0 5847.0 5316.0 5670.9 5699.3 5790.0 5793.7 5705.4 5706.4 5791.7 5800.4 5837.0 5697.9 5710.7 5766.7 5767.7 5782.4 6367.6 6370.4 6422.7 6444.7 6501.5 6785.5 6830.1 6965.8 7051.8 7052.2 6890.4 6898.4 6910.3 6981.7 6984.6 6292.6 6313.1 6366.6 6382.6 6386.0 7169.2 7189.8 7260.3 7278.6 7279.6 6883.8 6892.3 6958.4 6959.7 6968.9 6867.3 6929.8 6968.3 6984.4 6995.3 6827.0 6840.7 6913.4 6968.2 6998.6 6921.6 6929.1 6980.4 6991.4 6998.6 5024.1 5049.0 5080.0 5094.6 5123.0 4581.8 4590.6 4647.9 4658.9 4660.1 6359.1 6370.4 6445.4 6449.3 6459.3 6805.6 6887.6 6931.3 6931.8 6937.2 6303.0 6361.5 6447.2 6452.0 6454.3 5659.3 5704.9 5710.1 5712.3 5715.7 7105.9 7182.9 7186.0 7293.2 7298.6 6747.6 6867.9 6887.1 6964.3 6975.7 7162.2 7213.6 7235.3 7236.9 7306.1 6819.4 6915.5 6921.2 6943.2 6947.8 6940.4 6948.0 7034.6 7039.4 7053.4 6656.2 6689.0 6747.7 6759.8 6773.4 6759.4 6779.7 6797.6 6798.8 6799.0 6616.4 6644.2 6688.0 6731.4 6749.2 6697.8 6788.0 6865.5 6892.9 6911.6 6483.4 6556.6 6591.5 6596.3 6671.0 04:41:59 INFO - PID 3816 | 04:41:59 INFO - PID 3816 | [#1] ext.html Cycles:180 Average:41199.01 Median:34254.41 stddev:61591.65 (179.8%) stddev-sans-first:61690.23 04:41:59 INFO - PID 3816 | Values: 935.5 955.4 986.9 1013.5 1014.0 42432.8 43459.8 43675.8 43685.8 43762.1 40906.6 40961.4 41153.8 41167.4 41249.0 7648.0 7737.7 7757.8 7774.7 7777.8 7726.3 7823.1 7823.5 7825.8 7836.8 8375.5 8554.8 8568.7 8569.7 8571.7 8457.1 8470.0 8490.5 8493.0 8514.0 8210.0 8424.1 8429.1 8438.0 8441.2 40669.6 41051.6 41056.8 41077.0 41105.4 3680.5 3720.0 3720.9 3722.2 3726.9 32379.2 32675.5 32704.8 32764.5 32843.8 5493.2 5496.2 5519.5 5525.3 5529.8 211825.0 213791.0 214169.9 214223.0 215280.0 51457.7 51541.2 51688.7 51827.0 51867.5 53656.2 53927.5 54133.5 54245.5 54303.5 16557.0 17001.8 17007.5 17039.1 17050.1 13793.1 13809.8 13819.5 13828.4 13844.3 14867.6 15195.9 15236.0 15288.5 15328.6 5928.2 6082.4 6194.1 6248.6 6307.5 1091.4 1096.6 1099.7 1102.0 1112.2 23874.9 24414.4 24668.8 24766.5 24845.9 1191.7 1198.5 1205.0 1205.2 1206.3 12854.4 12919.2 12937.7 12979.1 13073.9 264032.0 266766.0 269364.0 272704.0 273375.0 54590.7 58255.0 59731.4 60012.7 60262.7 1474.3 1491.6 1491.7 1491.9 1517.2 29367.4 29606.0 29752.1 29899.9 29996.0 39304.6 40239.8 40373.0 40498.8 40534.4 222393.0 223742.0 224942.0 226943.0 226983.0 34024.5 34104.5 34207.8 34243.0 34265.8 42013.2 42942.6 43475.1 43493.6 43593.0 32546.0 33054.0 33150.3 33181.7 33340.0 32263.8 33098.0 33149.3 33347.5 33681.3 37928.4 37931.0 38312.0 38313.6 38507.8 31171.2 31222.2 31487.7 31668.7 31952.8 24718.6 24975.8 25004.2 25173.0 25374.7 04:41:59 INFO - PID 3816 | 04:41:59 INFO - PID 3816 | [#2] jquery.html Cycles:180 Average:39955.71 Median:22756.77 stddev:100391.00 (441.1%) stddev-sans-first:100629.11 04:41:59 INFO - PID 3816 | Values: 588.5 593.7 606.4 608.7 617.5 23269.3 23705.9 23912.8 23924.9 23944.2 25067.5 25539.5 25608.5 25740.6 25760.9 6731.9 6866.3 6890.7 6895.5 6898.4 6512.9 6689.6 6777.0 6818.0 6859.7 6753.9 6757.2 6767.4 6770.9 6775.6 6548.1 6763.1 6796.1 6805.4 6851.5 6367.4 6381.6 6385.3 6388.4 6404.7 29940.7 30000.0 30160.8 30380.8 30514.2 2324.5 2355.6 2356.0 2360.4 2361.1 20595.0 20783.2 21352.9 21609.4 21626.2 2493.9 2503.6 2572.0 2592.9 2605.6 133508.3 140278.0 152184.0 160571.0 160575.0 16087.7 16667.5 16798.7 16990.4 17082.7 25537.5 25654.7 25678.0 25691.5 25830.4 10866.9 11077.5 11220.4 11228.4 11231.7 10076.7 10083.2 10092.4 10243.3 10251.9 9760.7 10050.8 10246.4 10259.3 10305.0 2942.9 2958.7 2972.0 2975.0 3043.1 1032.9 1048.9 1059.4 1075.4 1085.8 20597.0 21306.9 21574.6 21598.6 21661.7 1104.7 1105.1 1108.8 1119.4 1125.1 11574.2 11634.5 11637.5 11662.2 11751.5 591601.0 592750.0 599408.0 602100.0 609203.0 131629.0 134707.3 134971.3 136677.0 137974.6 1113.7 1164.6 1224.6 1239.8 1266.5 22289.6 22745.9 22767.7 22842.0 22969.0 63263.4 64529.7 64567.4 65049.0 65891.3 81532.0 81599.6 81661.0 82554.6 83168.0 15520.0 15910.0 15999.3 16006.5 16028.7 23678.3 24228.5 24367.8 24444.0 24532.8 19419.3 19654.6 19831.1 20057.0 20101.3 14872.5 15528.2 16467.4 17642.5 17922.8 20253.9 20371.6 20492.0 20594.3 20807.8 15665.8 15685.4 15748.6 15794.7 15797.7 19408.3 19565.8 19670.6 20010.4 20167.3 04:41:59 INFO - PID 3816 | 04:41:59 INFO - PID 3816 | [#3] mootools.html Cycles:180 Average:10467.20 Median:14147.89 stddev:7780.16 (55.0%) stddev-sans-first:7772.19 04:41:59 INFO - PID 3816 | Values: 1404.5 1444.0 1462.3 1473.3 1483.7 16762.4 17392.6 17409.1 17415.5 17434.2 17017.5 17309.6 17358.3 17379.2 17386.4 2672.7 2802.5 2803.6 2804.5 2808.8 2664.9 2720.8 2721.2 2724.1 2734.3 2786.2 2823.0 2823.2 2824.4 2830.6 2342.8 2420.3 2520.4 2573.2 2588.6 2631.4 2711.7 2713.1 2716.1 2720.0 16967.4 16983.6 17054.0 17127.2 17132.8 8327.5 8609.4 8613.2 8613.6 8616.6 5012.7 5136.8 5226.5 5289.4 5294.0 2088.2 2098.2 2116.0 2130.5 2157.1 30259.2 30360.8 30559.4 30609.2 30623.1 7174.3 7250.6 7302.4 7441.6 7455.5 19713.3 19792.4 19846.0 19870.2 19906.4 8159.9 8573.6 8802.0 8809.9 8815.9 7615.0 7706.1 7764.7 7796.6 7808.2 5555.9 5693.5 5694.3 5704.2 5734.2 1610.9 1622.6 1628.8 1630.9 1641.9 911.7 932.8 943.1 944.9 952.0 8074.8 8232.6 8240.5 8258.4 8268.2 795.6 801.1 806.3 806.8 814.9 5497.1 6140.2 6201.9 6236.9 6292.4 24521.3 24891.1 25123.1 25639.1 25722.6 22800.3 23700.2 23790.4 23899.0 23961.8 12419.4 12521.2 12568.9 12760.8 12768.6 9395.3 9966.4 10025.0 10128.4 10282.1 21688.6 21690.6 21779.1 21950.0 22501.5 22465.2 22510.1 22746.0 22838.3 23344.5 12572.2 12604.8 12610.4 12660.6 12708.6 15504.8 15555.3 15574.5 15707.8 15715.6 12663.8 12815.4 12824.4 12933.1 12961.7 11865.6 12168.2 12282.6 12352.9 12433.4 10814.0 11035.4 11043.2 11043.5 11049.0 8450.1 8571.3 8613.5 8634.3 8652.0 8007.0 8013.2 8113.8 8116.1 8130.0 04:41:59 INFO - PID 3816 | 04:41:59 INFO - PID 3816 | [#4] prototype.html Cycles:180 Average:5713.18 Median:6292.48 stddev:1534.62 (24.4%) stddev-sans-first:1488.66 04:41:59 INFO - PID 3816 | Values: 523.2 530.8 548.8 551.2 561.8 6239.2 6301.7 6327.8 6354.9 6394.6 6338.7 6346.9 6351.4 6355.6 6360.3 5160.0 5177.6 5193.4 5194.6 5202.1 4809.6 5017.5 5070.7 5090.8 5118.1 5049.8 5057.9 5060.1 5072.7 5091.4 5030.7 5048.4 5073.9 5091.9 5107.3 4712.4 4715.4 4727.7 4748.7 4751.3 6079.9 6150.5 6151.9 6221.5 6250.8 5971.4 6038.7 6041.1 6077.9 6078.8 6661.5 6685.3 6708.8 6741.2 6747.7 5190.4 5210.7 5298.7 5333.8 5348.3 6724.9 6845.6 6876.1 6884.0 6952.2 5635.5 5648.4 5650.7 5650.8 5664.7 5731.9 5737.9 5760.4 5762.6 5768.0 6080.8 6104.9 6106.8 6119.3 6138.4 6706.5 6737.5 6756.8 6772.7 6789.1 1962.3 1972.6 1986.6 1992.9 2002.2 1405.8 1469.5 1481.3 1488.4 1520.4 6209.9 6218.3 6234.0 6251.2 6283.3 6684.3 6686.2 6701.3 6736.0 6741.5 6174.2 6176.0 6204.4 6219.8 6237.5 3534.6 3551.2 3555.7 3575.4 3577.5 7053.6 7059.9 7075.2 7081.4 7095.6 6900.4 6917.6 6922.8 6963.1 6977.9 6745.5 6992.7 7008.8 7033.9 7037.2 6502.3 6591.9 6594.8 6618.2 6695.1 6608.8 6679.4 6699.4 6730.2 6762.9 6887.4 6887.7 6982.9 6986.8 7088.4 5599.7 5601.5 5606.4 5653.3 5657.3 6600.5 6606.2 6722.8 6729.4 6747.4 6380.9 6394.2 6454.1 6496.6 6539.7 6445.9 6452.7 6489.4 6496.5 6554.1 6440.7 6473.9 6474.5 6493.7 6551.2 6536.9 6554.9 6571.3 6600.6 6659.4 6303.4 6311.6 6311.8 6393.1 6394.3 04:41:59 INFO - PID 3816 | 04:41:59 INFO - PID 3816 | [#5] yui.html Cycles:180 Average:28625.51 Median:21363.86 stddev:40666.51 (190.4%) stddev-sans-first:40727.53 04:41:59 INFO - PID 3816 | Values: 960.1 960.9 976.1 977.8 986.8 21080.4 22425.7 22432.3 22438.4 22473.2 20470.0 20702.7 20712.6 21480.6 22497.7 1092.4 1104.7 1106.1 1106.2 1106.3 1039.0 1075.8 1083.7 1085.1 1086.0 1150.2 1159.4 1161.9 1162.7 1162.7 1145.3 1151.2 1151.9 1152.2 1157.8 838.7 839.0 845.5 847.3 847.9 19886.6 20065.2 20326.6 20400.5 20908.0 22349.4 22509.4 22875.8 22943.1 23006.8 18029.1 18119.6 18180.8 18243.2 18248.2 3717.4 3798.0 3899.6 3919.6 3949.1 152426.0 156873.0 156907.0 157722.0 157871.0 16951.1 17223.6 17436.3 17459.4 17506.3 33027.8 33334.8 33424.7 33781.7 34045.5 8722.9 8776.3 8853.8 8859.2 8921.8 4795.7 4799.7 4856.6 4879.1 4885.7 6098.1 6192.9 6209.7 6227.2 6237.3 1120.1 1162.1 1166.7 1178.7 1183.8 719.3 742.6 744.5 755.7 767.7 13311.2 13578.8 13592.4 14301.8 14307.9 682.9 699.2 705.7 706.9 712.2 6136.6 6301.9 6308.3 6367.7 6419.2 142860.0 143513.0 143518.0 144443.0 146984.0 114624.0 116761.0 117871.0 119428.4 119883.4 106330.5 107650.0 109125.0 109234.5 110858.4 11947.2 12041.3 12051.8 12244.0 15100.9 49037.3 52108.2 52388.0 52572.5 52971.2 86803.6 86919.8 89454.6 90238.5 92212.0 21064.4 21411.4 22224.9 22255.3 22269.1 24311.1 24320.9 24609.1 24845.5 25355.6 21316.4 21458.7 21637.9 22441.2 23020.0 20587.5 20869.7 21102.5 21109.9 21241.8 21672.1 21718.7 21944.0 22461.7 22721.7 13492.9 13573.9 14566.4 14601.2 15215.0 15292.3 15410.0 15423.4 16457.8 16822.3 04:41:59 INFO - PID 3816 | -------- Summary: end -------- 04:41:59 INFO - PID 3816 | 04:42:00 INFO - TEST-INFO | 3816: exit 0 04:42:00 INFO - TEST-OK | dromaeo_css | took 1111210ms 04:42:00 INFO - TEST-START | kraken 04:42:00 INFO - Initialising browser for kraken test... 04:42:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39758/getInfo.html -profile /tmp/tmpqPFwVS/profile 04:42:00 INFO - TEST-INFO | started process 4183 (/builds/slave/test/build/application/firefox/firefox http://localhost:39758/getInfo.html) 04:42:05 INFO - TEST-INFO | 4183: exit 0 04:42:05 INFO - Browser initialized. 04:42:05 INFO - Running cycle 1/1 for kraken test... 04:42:05 INFO - Using env: {'DISPLAY': ':0', 04:42:05 INFO - 'HOME': '/home/cltbld', 04:42:05 INFO - 'JSGC_DISABLE_POISONING': '1', 04:42:05 INFO - 'LANG': 'en_US.UTF-8', 04:42:05 INFO - 'LANGUAGE': 'en_US:en', 04:42:05 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:42:05 INFO - 'LOGNAME': 'cltbld', 04:42:05 INFO - 'MAIL': '/var/mail/cltbld', 04:42:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:42:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:42:05 INFO - 'MOZ_CRASHREPORTER': '1', 04:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:05 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:42:05 INFO - 'MOZ_NO_REMOTE': '1', 04:42:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:05 INFO - 'NO_EM_RESTART': '1', 04:42:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:05 INFO - 'PWD': '/builds/slave/test', 04:42:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:42:05 INFO - 'RUST_BACKTRACE': 'full', 04:42:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:42:05 INFO - 'SHELL': '/bin/bash', 04:42:05 INFO - 'SHLVL': '1', 04:42:05 INFO - 'STYLO_FORCE_DISABLED': '1', 04:42:05 INFO - 'TERM': 'linux', 04:42:05 INFO - 'TMOUT': '86400', 04:42:05 INFO - 'USER': 'cltbld', 04:42:05 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202', 04:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:05 INFO - '_': '/tools/buildbot/bin/python'} 04:42:05 INFO - TEST-INFO | started process 4426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqPFwVS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:05 INFO - PID 4426 | 04:42:05 INFO - PID 4426 | (/builds/slave/test/build/application/firefox/firefox:4475): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:42:05 INFO - PID 4426 | 04:42:16 INFO - PID 4426 | RSS: Main: 145104896 04:42:16 INFO - PID 4426 | 04:42:18 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:39758/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39758/tests/kraken/driver.html?testName=audio-beat-detection) 04:42:19 INFO - PID 4426 | RSS: Main: 151420928 04:42:19 INFO - PID 4426 | 04:42:22 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:39758/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39758/tests/kraken/driver.html?testName=audio-dft) 04:42:22 INFO - PID 4426 | RSS: Main: 151793664 04:42:22 INFO - PID 4426 | 04:42:25 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:39758/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39758/tests/kraken/driver.html?testName=audio-fft) 04:42:26 INFO - PID 4426 | RSS: Main: 148201472 04:42:26 INFO - PID 4426 | 04:42:28 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:39758/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39758/tests/kraken/driver.html?testName=audio-oscillator) 04:42:29 INFO - PID 4426 | RSS: Main: 149147648 04:42:29 INFO - PID 4426 | 04:42:31 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:39758/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39758/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:42:31 INFO - PID 4426 | RSS: Main: 149291008 04:42:31 INFO - PID 4426 | 04:42:34 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:39758/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39758/tests/kraken/driver.html?testName=imaging-darkroom) 04:42:35 INFO - PID 4426 | RSS: Main: 149250048 04:42:35 INFO - PID 4426 | 04:42:39 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:39758/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39758/tests/kraken/driver.html?testName=imaging-desaturate) 04:42:39 INFO - PID 4426 | RSS: Main: 150089728 04:42:39 INFO - PID 4426 | 04:42:42 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:39758/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39758/tests/kraken/driver.html?testName=json-parse-financial) 04:42:43 INFO - PID 4426 | RSS: Main: 151961600 04:42:43 INFO - PID 4426 | 04:42:44 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:39758/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39758/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:42:45 INFO - PID 4426 | RSS: Main: 151826432 04:42:45 INFO - PID 4426 | 04:42:46 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:39758/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39758/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:42:47 INFO - PID 4426 | RSS: Main: 151650304 04:42:47 INFO - PID 4426 | 04:42:49 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:39758/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39758/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:42:50 INFO - PID 4426 | RSS: Main: 148979712 04:42:50 INFO - PID 4426 | 04:42:53 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:39758/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39758/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:42:53 INFO - PID 4426 | RSS: Main: 148926464 04:42:53 INFO - PID 4426 | 04:42:56 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:39758/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39758/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:42:57 INFO - PID 4426 | RSS: Main: 149188608 04:42:57 INFO - PID 4426 | 04:42:58 INFO - PID 4426 | Cycle 1(1): loaded http://localhost:39758/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39758/tests/kraken/driver.html?testName=ai-astar) 04:42:59 INFO - PID 4426 | RSS: Main: 150757376 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | __start_tp_report 04:42:59 INFO - PID 4426 | _x_x_mozilla_page_load 04:42:59 INFO - PID 4426 | _x_x_mozilla_page_load_details 04:42:59 INFO - PID 4426 | |i|pagename|runs| 04:42:59 INFO - PID 4426 | |0;ai-astar;106;104;106;107;104;106;107;107;107;107 04:42:59 INFO - PID 4426 | |1;audio-beat-detection;114;113;112;112;113;116;114;115;113;117 04:42:59 INFO - PID 4426 | |2;audio-dft;162;164;163;164;165;162;161;161;167;169 04:42:59 INFO - PID 4426 | |3;audio-fft;74;73;72;73;72;74;73;73;73;74 04:42:59 INFO - PID 4426 | |4;audio-oscillator;79;78;77;78;78;79;79;77;77;82 04:42:59 INFO - PID 4426 | |5;imaging-gaussian-blur;114;113;114;115;114;114;112;116;114;114 04:42:59 INFO - PID 4426 | |6;imaging-darkroom;151;150;149;150;149;150;151;151;151;151 04:42:59 INFO - PID 4426 | |7;imaging-desaturate;94;95;94;94;95;95;94;94;95;94 04:42:59 INFO - PID 4426 | |8;json-parse-financial;47;50;45;45;44;43;45;44;48;46 04:42:59 INFO - PID 4426 | |9;json-stringify-tinderbox;40;38;39;39;39;39;39;39;40;39 04:42:59 INFO - PID 4426 | |10;stanford-crypto-aes;76;71;71;70;73;71;74;72;71;71 04:42:59 INFO - PID 4426 | |11;stanford-crypto-ccm;106;114;105;104;107;108;111;106;109;106 04:42:59 INFO - PID 4426 | |12;stanford-crypto-pbkdf2;160;155;149;151;154;155;158;154;150;150 04:42:59 INFO - PID 4426 | |13;stanford-crypto-sha256-iterative;64;65;60;59;59;60;62;62;60;61 04:42:59 INFO - PID 4426 | __end_tp_report 04:42:59 INFO - PID 4426 | __start_cc_report 04:42:59 INFO - PID 4426 | _x_x_mozilla_cycle_collect,709 04:42:59 INFO - PID 4426 | __end_cc_report 04:42:59 INFO - PID 4426 | __startTimestamp1506339779147__endTimestamp 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | ------- Summary: start ------- 04:42:59 INFO - PID 4426 | Number of tests: 14 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | [#0] ai-astar Cycles:10 Average:106.10 Median:107.00 stddev:1.20 (1.1%) stddev-sans-first:1.27 04:42:59 INFO - PID 4426 | Values: 106.0 104.0 106.0 107.0 104.0 106.0 107.0 107.0 107.0 107.0 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | [#1] audio-beat-detection Cycles:10 Average:113.90 Median:114.00 stddev:1.66 (1.5%) stddev-sans-first:1.76 04:42:59 INFO - PID 4426 | Values: 114.0 113.0 112.0 112.0 113.0 116.0 114.0 115.0 113.0 117.0 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:2.62 (1.6%) stddev-sans-first:2.69 04:42:59 INFO - PID 4426 | Values: 162.0 164.0 163.0 164.0 165.0 162.0 161.0 161.0 167.0 169.0 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | [#3] audio-fft Cycles:10 Average:73.10 Median:73.00 stddev:0.74 (1.0%) stddev-sans-first:0.71 04:42:59 INFO - PID 4426 | Values: 74.0 73.0 72.0 73.0 72.0 74.0 73.0 73.0 73.0 74.0 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:78.50 stddev:1.51 (1.9%) stddev-sans-first:1.58 04:42:59 INFO - PID 4426 | Values: 79.0 78.0 77.0 78.0 78.0 79.0 79.0 77.0 77.0 82.0 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:1.05 (0.9%) stddev-sans-first:1.12 04:42:59 INFO - PID 4426 | Values: 114.0 113.0 114.0 115.0 114.0 114.0 112.0 116.0 114.0 114.0 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 04:42:59 INFO - PID 4426 | Values: 151.0 150.0 149.0 150.0 149.0 150.0 151.0 151.0 151.0 151.0 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:42:59 INFO - PID 4426 | Values: 94.0 95.0 94.0 94.0 95.0 95.0 94.0 94.0 95.0 94.0 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | [#8] json-parse-financial Cycles:10 Average:45.70 Median:45.50 stddev:2.11 (4.6%) stddev-sans-first:2.19 04:42:59 INFO - PID 4426 | Values: 47.0 50.0 45.0 45.0 44.0 43.0 45.0 44.0 48.0 46.0 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | [#9] json-stringify-tinderbox Cycles:10 Average:39.10 Median:39.00 stddev:0.57 (1.5%) stddev-sans-first:0.50 04:42:59 INFO - PID 4426 | Values: 40.0 38.0 39.0 39.0 39.0 39.0 39.0 39.0 40.0 39.0 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | [#10] stanford-crypto-aes Cycles:10 Average:72.00 Median:71.50 stddev:1.83 (2.6%) stddev-sans-first:1.24 04:42:59 INFO - PID 4426 | Values: 76.0 71.0 71.0 70.0 73.0 71.0 74.0 72.0 71.0 71.0 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | [#11] stanford-crypto-ccm Cycles:10 Average:107.60 Median:107.50 stddev:3.03 (2.8%) stddev-sans-first:3.15 04:42:59 INFO - PID 4426 | Values: 106.0 114.0 105.0 104.0 107.0 108.0 111.0 106.0 109.0 106.0 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:154.50 stddev:3.63 (2.3%) stddev-sans-first:3.02 04:42:59 INFO - PID 4426 | Values: 160.0 155.0 149.0 151.0 154.0 155.0 158.0 154.0 150.0 150.0 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.50 stddev:2.04 (3.3%) stddev-sans-first:1.90 04:42:59 INFO - PID 4426 | Values: 64.0 65.0 60.0 59.0 59.0 60.0 62.0 62.0 60.0 61.0 04:42:59 INFO - PID 4426 | -------- Summary: end -------- 04:42:59 INFO - PID 4426 | 04:42:59 INFO - PID 4426 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:42:59 INFO - TEST-INFO | 4426: exit 0 04:42:59 INFO - TEST-OK | kraken | took 59746ms 04:42:59 INFO - SUITE-END | took 1170s 04:42:59 INFO - Completed test suite (00:19:30) 04:42:59 INFO - javascript benchmark 04:42:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9163.173107600169, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3893.3965235388514, 3902.8243729032192, 3903.0242439390154, 3919.7844118573466, 3942.388929715893, 6228.096925945735, 6301.873962520747, 6360.80917572473, 6382.138411314471, 6455.774047908324, 6344.365563443654, 6371.776987805428, 6388.073729309259, 6434.9678251608675, 6499.0, 5681.971590142043, 5759.68321742304, 5765.4811067004175, 5775.3358363788175, 5780.277465316835, 111.97792152131414, 5676.091825307952, 5747.712614369286, 5837.036888913345, 5847.0, 5315.973420132913, 5670.886582268332, 5699.344575373843, 5789.971050144764, 5793.652380857162, 5705.372409035002, 5706.3722990471015, 5791.739371728282, 5800.361960184377, 5837.036888913324, 5697.886042279131, 5710.685912274823, 5766.654000759926, 5767.711614419304, 5782.3639399666, 6367.6497792621385, 6370.426661600478, 6422.678866056725, 6444.709988050549, 6501.479881609507, 6785.457163426914, 6830.077939478207, 6965.825854353631, 7051.788446346566, 7052.224255331909, 6890.44876409886, 6898.448124150056, 6910.3089691031, 6981.650917454107, 6984.615846128461, 6292.622442653455, 6313.116163737081, 6366.554341196118, 6382.553221274513, 6385.96807015962, 7169.175544812413, 7189.784306470762, 7260.310270524292, 7278.636068196675, 7279.6360181990685, 6883.793486195422, 6892.345227203407, 6958.408535274457, 6959.652017399109, 6968.895466568006, 6867.278935711678, 6929.792106236821, 6968.338007889242, 6984.371406573331, 6995.300469952964, 6826.965865170642, 6840.657967101625, 6913.3777959983845, 6968.163820341591, 6998.580085194904, 6921.550099243533, 6929.133858267716, 6980.371766540934, 6991.440684745208, 6998.580085194904, 5024.095662780662, 5048.974755126201, 5080.0, 5094.643374963717, 5122.9743851281255, 4581.839635612738, 4590.609798167126, 4647.930281045787, 4658.883527911761, 4660.091282200006, 6359.077933699587, 6370.406629138819, 6445.4199122079235, 6449.290578036413, 6459.321771214049, 6805.591664500146, 6887.586744795329, 6931.306869313028, 6931.826704332331, 6937.202221744463, 6303.023031430135, 6361.522885783585, 6447.161868957006, 6452.032195170762, 6454.257760357619, 5659.320881494247, 5704.914426283609, 5710.114932185518, 5712.285964254468, 5715.714214289269, 7105.89341159883, 7182.856342873218, 7185.96407017972, 7293.161286452126, 7298.598577078205, 6747.561408508432, 6867.931320686829, 6887.070245516991, 6964.338387853146, 6975.651217439006, 7162.176349719641, 7213.60325182099, 7235.2764723527225, 7236.927630723625, 7306.123265208209, 6819.386255237053, 6915.51591388598, 6921.204061532988, 6943.166819981635, 6947.79156625302, 6940.444764418733, 6948.0, 7034.648267586703, 7039.366457018893, 7053.365197132282, 6656.201255849329, 6689.0, 6747.696353664195, 6759.831004224737, 6773.390394864486, 6759.425448836707, 6779.694913728993, 6797.5581587196675, 6798.796036118924, 6799.048133261248, 6616.437602803623, 6644.235912870082, 6687.966560167168, 6731.360520750521, 6749.223839258351, 6697.799066028027, 6787.966060169668, 6865.519413641197, 6892.931070689229, 6911.550749201286, 6483.4164925156965, 6556.606603603799, 6591.505637077143, 6596.2744098148205, 6671.032700258533], "value": 6298.419732219319, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [935.5088578496288, 955.3551352836834, 986.8914419413863, 1013.5337744637462, 1014.0417305646165, 42432.787836060816, 43459.78270108653, 43675.78162109189, 43685.7815710921, 43762.12475750483, 40906.590934090724, 40961.38557921634, 41153.79423102888, 41167.38248926269, 41249.0, 7648.0, 7737.690492380298, 7757.806054848617, 7774.727884524043, 7777.844443111135, 7726.304632583066, 7823.100343460518, 7823.452358334919, 7825.765227043198, 7836.804079897991, 8375.497470151811, 8554.828903421927, 8568.657253709844, 8569.700060497884, 8571.699990500334, 8457.112003239663, 8469.999999999969, 8490.490570565786, 8492.957535212347, 8513.95743021284, 8209.958950205271, 8424.073351931283, 8429.072801991775, 8437.957810210972, 8441.240288374014, 40669.59330406717, 41051.589484105374, 41056.794716026525, 41077.0, 41105.383419248734, 3680.4847321375028, 3720.014196237999, 3720.8697695580795, 3722.181120153562, 3726.9440958385644, 32379.190520236945, 32675.509867352008, 32704.836475817705, 32764.508532372034, 32843.83578082094, 5493.176023596453, 5496.1755736639425, 5519.475649813261, 5525.336959564878, 5529.806456774034, 211825.0, 213791.0, 214169.92915035482, 214223.0, 215280.0, 51457.742711286206, 51541.226881596805, 51688.74155629198, 51827.0, 51867.481325186265, 53656.195157072674, 53927.46072539303, 54133.45866541284, 54245.45754542483, 54303.45696543063, 16557.0, 17001.829981700026, 17007.48977530676, 17039.062851543036, 17050.147492625318, 13793.10344827583, 13809.792853107212, 13819.516316928859, 13828.446862125402, 13844.30778461073, 14867.553973380816, 15195.92402038005, 15236.0, 15288.464903728316, 15328.616784580474, 5928.170056192136, 6082.422169893853, 6194.132821405007, 6248.593841400295, 6307.4954003679595, 1091.44881834673, 1096.5778175402527, 1099.6646022962914, 1101.9504122314515, 1112.2158877990996, 23874.925628346766, 24414.389640259134, 24668.753312467004, 24766.504669906502, 24845.87577062103, 1191.7497325561728, 1198.4846515998204, 1204.951801927913, 1205.2166092040068, 1206.3365149167923, 12854.421551030226, 12919.160254583421, 12937.676558086123, 12979.091463597646, 13073.934630326787, 264032.0, 266766.0, 269364.0, 272704.0, 273375.0, 54590.72704636451, 58255.0, 59731.40268597345, 60012.69993650091, 60262.69868650717, 1474.2555009720238, 1491.56744544081, 1491.7314883321105, 1491.9104853708811, 1517.2413793103449, 29367.412651747272, 29606.0, 29752.107436776932, 29899.850500747358, 29996.0, 39304.60695393124, 40239.79880100698, 40373.0, 40498.797506012284, 40534.39198411967, 222393.0, 223742.0, 224942.0, 226943.0, 226983.0, 34024.48963265504, 34104.48843267303, 34207.82896085503, 34243.0, 34265.828670856485, 42013.159736805705, 42942.57057429386, 43475.130497390506, 43493.565064350216, 43593.0, 32546.0, 33054.016758994534, 33150.336993260484, 33181.66818331786, 33340.0, 32263.838680806446, 33098.0, 33149.33701326008, 33347.49978750272, 33681.32637347288, 37928.43107353447, 37931.0, 38312.04219894525, 38313.616863831005, 38507.80746096252, 31171.220719482193, 31222.21944451316, 31487.685123148476, 31668.683313166573, 31952.84023579867, 24718.629220562067, 24975.750242497343, 25004.249872503853, 25173.0, 25374.74625253724], "value": 18329.679047731934, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.5262363797142, 593.6734795862275, 606.3804365142585, 608.747369841516, 617.4998251416353, 23269.301920942376, 23705.881470592645, 23912.76087239127, 23924.88037559812, 23944.1619543316, 25067.510569584563, 25539.489210215783, 25608.487830243383, 25740.613890791654, 25760.871195643995, 6731.9326806731915, 6866.27904070073, 6890.655467226644, 6895.482838787086, 6898.448124150081, 6512.934870651304, 6689.598624082546, 6776.966115169417, 6817.965910170467, 6859.691313890862, 6753.864922701543, 6757.222919364262, 6767.390934815866, 6770.898436523432, 6775.62734049627, 6548.116004339401, 6763.120794296759, 6796.116504854387, 6805.353491418332, 6851.520393572452, 6367.42693157618, 6381.553291269613, 6385.2656944451055, 6388.39310265524, 6404.7117879695525, 29940.70059299401, 30000.0, 30160.8491957541, 30380.8480957596, 30514.237144071354, 2324.5467133908896, 2355.6348765941134, 2356.045801450415, 2360.3980984848927, 2361.1381845626224, 20595.0, 20783.16867325305, 21352.893235533724, 21609.35171944844, 21626.24308149223, 2493.925182244536, 2503.624456331565, 2571.974280257211, 2592.922212333633, 2605.557055300603, 133508.33245833806, 140278.0, 152184.0, 160571.0, 160574.99999999884, 16087.67824643524, 16667.49997500077, 16798.664026719398, 16990.405335813186, 17082.743758843626, 25537.48925021526, 25654.74345256561, 25678.0, 25691.48617027649, 25830.354241144123, 10866.891331086588, 11077.50151243196, 11220.382878941573, 11228.382438965771, 11231.71920701989, 10076.69769906904, 10083.19334453242, 10092.444915529717, 10243.282970192015, 10251.948740256252, 9760.707178784647, 10050.798984020425, 10246.436445995541, 10259.28185027056, 10305.0, 2942.911712648624, 2958.689337619562, 2972.0, 2974.9553756693667, 3043.1479185828002, 1032.8863824979246, 1048.9213309001855, 1059.422614675004, 1075.3762817565794, 1085.8045551800594, 20597.0, 21306.893465532885, 21574.600257672668, 21598.56802863934, 21661.67507487389, 1104.679642903565, 1105.1214284643727, 1108.800415925125, 1119.412308538024, 1125.1336470917347, 11574.247673901338, 11634.476448559835, 11637.53449861996, 11662.241954272946, 11751.529938802523, 591601.0, 592750.0, 599408.0, 602100.0, 609203.0, 131629.0, 134707.326463369, 134971.32514337366, 136677.0, 137974.62025379617, 1113.7494063835572, 1164.574930150489, 1224.5591587028662, 1239.8450193725785, 1266.468083404972, 22289.5511791733, 22745.886270569204, 22767.65848512307, 22842.0, 22969.0, 63263.36736632575, 64529.67735161294, 64567.35432645614, 65049.0, 65891.34108658852, 81532.0, 81599.59200203962, 81661.0, 82554.58722706589, 83168.0, 15520.0, 15910.0453972762, 15999.280032398803, 16006.519804405887, 16028.67942641164, 23678.28965131049, 24228.51542969166, 24367.756322436548, 24444.0, 24532.754672453048, 19419.3203237886, 19654.60690786148, 19831.10760015774, 20057.0, 20101.29645462402, 14872.479463219168, 15528.223588820289, 16467.423640172536, 17642.470725878244, 17922.820771792638, 20253.898730506255, 20371.59256814885, 20492.0, 20594.27920022792, 20807.791922080585, 15665.765013524579, 15685.372585096467, 15748.606284842512, 15794.68410631804, 15797.684046319238, 19408.320708775125, 19565.8043419564, 19670.606587867875, 20010.399688009384, 20167.294144704865], "value": 12965.61503486705, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.5154421724505, 1444.0, 1462.2891217275787, 1473.270730988161, 1483.6958423523176, 16762.41331553396, 17392.56518587036, 17409.129543522835, 17415.47753567392, 17434.215460304284, 17017.489475315728, 17309.567260818487, 17358.305667773275, 17379.217935192915, 17386.391476298333, 2672.719364466737, 2802.495550800855, 2803.649543807024, 2804.4531316393313, 2808.8174268672574, 2664.9200523984214, 2720.8367497950185, 2721.1700431368427, 2724.1282789507363, 2734.3437574981963, 2786.21985843964, 2822.971770282302, 2823.153054083777, 2824.3503994081375, 2830.632017837678, 2342.8242881783763, 2420.261820144855, 2520.43290259691, 2573.163721790426, 2588.5858262677975, 2631.4342416380377, 2711.7423844734917, 2713.077553631755, 2716.1444145094233, 2720.0, 16967.406140785013, 16983.57541061471, 17053.976761394355, 17127.229274682668, 17132.828671713374, 8327.50034997902, 8609.440386374928, 8613.224809767089, 8613.61238744258, 8616.612252448655, 5012.699238045729, 5136.794528218867, 5226.503482169188, 5289.391719952217, 5294.0, 2088.2482306369693, 2098.1921960045493, 2116.0426605389953, 2130.456733532955, 2157.083239623154, 30259.243518911982, 30360.8481957591, 30559.38881222363, 30609.234769130726, 30623.08130756081, 7174.3184397482155, 7250.6374681265725, 7302.415806735448, 7441.55350678961, 7455.515391499535, 19713.310034149024, 19792.406227812902, 19846.0, 19870.205191792455, 19906.402807915787, 8159.877601835978, 8573.571321433903, 8802.0, 8809.867851982226, 8815.867761983576, 7614.961925190339, 7706.113796913427, 7764.728234511765, 7796.5711885845685, 7808.219178082147, 5555.861103472364, 5693.459121383462, 5694.259746232963, 5704.201411802351, 5734.16854556087, 1610.9355625775072, 1622.6024623966969, 1628.804543454793, 1630.861376782963, 1641.9343226271055, 911.694582314932, 932.7994481186441, 943.1323182671821, 944.9102335278275, 951.9762005949768, 8074.757757267292, 8232.62953167109, 8240.50556966572, 8258.380621453294, 8268.173182681683, 795.6459375577928, 801.0907619851511, 806.2824086562964, 806.8345989072226, 814.9062857771314, 5497.120460726264, 6140.2017737694705, 6201.906971395432, 6236.906446403307, 6292.433680968735, 24521.264362069167, 24891.128810491547, 25123.120690775737, 25639.10263140781, 25722.6141607876, 22800.31599052031, 23700.170494032627, 23790.405239869142, 23899.0, 23961.760382395954, 12419.379031048593, 12521.186122901981, 12568.874311256954, 12760.80858787119, 12768.553100641433, 9395.342326037386, 9966.40201587878, 10024.997500249916, 10128.392296462236, 10282.07461328484, 21688.566228675023, 21690.566188676454, 21779.12883484643, 21950.0, 22501.549969000855, 22465.213717519808, 22510.099596015974, 22746.0, 22838.31485055451, 23344.53310933738, 12572.245665260114, 12604.810927836274, 12610.432530535965, 12660.556880509139, 12708.618741437771, 15504.84495155034, 15555.300011499283, 15574.532764017098, 15707.842921570638, 15715.607109822346, 12663.810042849549, 12815.423305951068, 12824.358782060674, 12933.09468337245, 12961.675958101123, 11865.5847045353, 12168.209066410654, 12282.631521054383, 12352.876471235173, 12433.37833108323, 10814.0, 11035.39305338214, 11043.171762117712, 11043.503042363274, 11049.0, 8450.070492245724, 8571.314294856273, 8613.48319100856, 8634.266087382643, 8652.0, 8007.0, 8013.19868013194, 8113.7565873023905, 8116.107228204774, 8130.0], "value": 7242.17370955501, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.1629392971247, 530.7929907336139, 548.8408361575141, 551.2392897801034, 561.8230257468897, 6239.188905442292, 6301.6534090625, 6327.841803954909, 6354.904676429852, 6394.616323020622, 6338.749743840939, 6346.921023426017, 6351.428371446569, 6355.555111142222, 6360.268569114542, 5160.0, 5177.559907407875, 5193.428722840504, 5194.6493911583075, 5202.115640341132, 4809.639277054217, 5017.473165317644, 5070.670406423571, 5090.770915308802, 5118.129917913963, 5049.823256186034, 5057.873553161164, 5060.116987107441, 5072.72100034498, 5091.389033316007, 5030.748462576893, 5048.419431765339, 5073.873153171164, 5091.949080509222, 5107.284980102789, 4712.387389639359, 4715.386999690053, 4727.7163370197895, 4748.691335063209, 4751.311059896296, 6079.908801367983, 6150.5079593632845, 6151.907721384183, 6221.471174950135, 6250.7812226572305, 5971.4327138921735, 6038.667873266969, 6041.1240370146525, 6077.878442431171, 6078.817635470943, 6661.533692641517, 6685.298043705389, 6708.83227919301, 6741.179881431985, 6747.730090796363, 5190.390978796585, 5210.739463026872, 5298.682079075268, 5333.839984800424, 5348.277982472356, 6724.899126513106, 6845.589264644137, 6876.112032946175, 6883.965580172117, 6952.165740111219, 5635.492805647511, 5648.435156484319, 5650.717464126859, 5650.773969041193, 5664.745086471119, 5731.856703582361, 5737.913931291034, 5760.42395760429, 5762.625429347079, 5767.971160144256, 6080.7871724490315, 6104.87059893921, 6106.801551441477, 6119.326874043852, 6138.416850399205, 6706.530542861953, 6737.461003119739, 6756.797296081126, 6772.661366931732, 6789.117414736152, 1962.254343349518, 1972.6054789042248, 1986.5927484865567, 1992.870463419873, 2002.209127394671, 1405.7610206264756, 1469.4709904434394, 1481.3333999700178, 1488.4046381447508, 1520.4222395489644, 6209.9068513972325, 6218.258887511504, 6234.0, 6251.187345645128, 6283.3088360280335, 6684.2647308795995, 6686.1642294713165, 6701.262861085277, 6735.966320168368, 6741.528093033538, 6174.166487524217, 6176.0, 6204.3795620437595, 6219.751209951552, 6237.500999919996, 3534.593521744981, 3551.183227857607, 3555.666625015619, 3575.3564358415733, 3577.5170352002665, 7053.576785392893, 7059.8820353893625, 7075.150981882207, 7081.442082741789, 7095.609741464269, 6900.447964162955, 6917.619530925847, 6922.7923162305215, 6963.09479767627, 6977.860442791116, 6745.52781305304, 6992.720291188295, 7008.762201640544, 7033.859322813618, 7037.155541334971, 6502.252240992347, 6591.868162636816, 6594.802155935329, 6618.238902526271, 6695.12963314766, 6608.768693095719, 6679.432248258952, 6699.430548403246, 6730.192376914606, 6762.8985565217545, 6887.449004079562, 6887.6556172192195, 6982.895256571054, 6986.790396288119, 7088.432925365855, 5599.664020158803, 5601.467860553241, 5606.355269144101, 5653.3498647654405, 5657.32112146545, 6600.471962243105, 6606.192368243381, 6722.764703235363, 6729.394354508117, 6747.359000894907, 6380.9361906380345, 6394.200724909387, 6454.128692626623, 6496.610203387811, 6539.705713243011, 6445.935540644721, 6452.741890324334, 6489.448396886129, 6496.480281577557, 6554.14796076507, 6440.677966101583, 6473.935260647333, 6474.482041436768, 6493.675316234075, 6551.181102362205, 6536.934630653633, 6554.918438457601, 6571.277159512354, 6600.60396376219, 6659.4006539411685, 6303.369663033844, 6311.558190926775, 6311.842203944938, 6393.1369265148605, 6394.328595497405], "value": 5277.253653447611, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [960.0783248081846, 960.8991055939126, 976.0971101730897, 977.8386566216573, 986.8207492047006, 21080.367588972334, 22425.66361504579, 22432.32703018908, 22438.43903902401, 22473.21343752969, 20470.0, 20702.68945965812, 20712.585748285026, 21480.57038859222, 22497.662535061987, 1092.355510248953, 1104.6630777612825, 1106.0709004436271, 1106.1537923488538, 1106.2753896198003, 1039.0129377091794, 1075.833245846895, 1083.6586475260308, 1085.1047885494459, 1085.9891401086006, 1150.2408410449104, 1159.3855256713955, 1161.866385365681, 1162.7093226693328, 1162.7441962768178, 1145.3357052909375, 1151.1999160583398, 1151.856017997746, 1152.216492784906, 1157.8494795676593, 838.7190291252438, 839.047680882197, 845.5053793530792, 847.3179090831878, 847.8770578266117, 19886.602267954706, 20065.1973921043, 20326.5934681307, 20400.489987750276, 20908.0, 22349.441263968532, 22509.437264068365, 22875.77124228753, 22943.082276708912, 23006.76993230063, 18029.098545072826, 18119.63760724778, 18180.818191818045, 18243.17905694247, 18248.178831952595, 3717.3866312058476, 3798.0315019669806, 3899.6490315871706, 3919.5884432134785, 3949.111449923773, 152426.0, 156873.0, 156907.0, 157722.0, 157871.0, 16951.06769127685, 17223.56941076483, 17436.302547897943, 17459.38892138769, 17506.29974801019, 33027.83486082602, 33334.8333258337, 33424.66575334264, 33781.66218337834, 34045.489317660256, 8722.912770872337, 8776.25401840838, 8853.778655533662, 8859.202671759573, 8921.776955576162, 4795.736234507136, 4799.66402351839, 4856.587190088882, 4879.097366987119, 4885.7312847793, 6098.1157732128595, 6192.876142477216, 6209.6895155242055, 6227.221597300338, 6237.282712488122, 1120.0815331428314, 1162.0761494611804, 1166.6616681162538, 1178.6581891251442, 1183.816508441193, 719.3382088478612, 742.6323969635065, 744.4825846037061, 755.652399896054, 767.673738661078, 13311.201327920357, 13578.796318055238, 13592.38834252461, 14301.78547321791, 14307.85692143086, 682.8975653651992, 699.2448155991517, 705.7424040225384, 706.9399101076364, 712.2236761929522, 6136.631802091889, 6301.873962520724, 6308.274548426898, 6367.713452894631, 6419.165508483868, 142860.0, 143513.0, 143518.0, 144443.0, 146984.0, 114624.0, 116761.0, 117871.0, 119428.40285798516, 119883.40058299653, 106330.46834765932, 107650.0, 109125.0, 109234.45382773194, 110858.44570777095, 11947.163698541366, 12041.277523348626, 12051.819222711842, 12244.020478361888, 15100.924495377452, 49037.2644410327, 52108.21837672514, 52388.0, 52572.474275256754, 52971.20543191932, 86803.56598216969, 86919.8270043254, 89454.55272723595, 90238.54880725816, 92212.0, 21064.368068957956, 21411.35765927025, 22224.888875556164, 22255.332340029825, 22269.109235630393, 24311.149109781072, 24320.878395608615, 24609.13868014611, 24845.503089937738, 25355.6196657054, 21316.36050918475, 21458.678119827902, 21637.918104094417, 22441.21455749041, 23020.0, 20587.4853128673, 20869.686954695997, 21102.47243818917, 21109.89445052765, 21241.78758212398, 21672.133114675868, 21718.67421988703, 21944.0, 22461.66307505356, 22721.659175112058, 13492.86507134916, 13573.914086873225, 14566.417343306573, 14601.196934168724, 15215.0, 15292.311845966735, 15409.998350107207, 15423.383064677288, 16457.83542164611, 16822.327106915585], "value": 10346.485595628137, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1373.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 104.0, 106.0, 107.0, 104.0, 106.0, 107.0, 107.0, 107.0, 107.0], "value": 106.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 112.0, 112.0, 113.0, 116.0, 114.0, 115.0, 113.0, 117.0], "value": 113.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 164.0, 165.0, 162.0, 161.0, 161.0, 167.0, 169.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 73.0, 72.0, 74.0, 73.0, 73.0, 73.0, 74.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 77.0, 78.0, 78.0, 79.0, 79.0, 77.0, 77.0, 82.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 115.0, 114.0, 114.0, 112.0, 116.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 149.0, 150.0, 149.0, 150.0, 151.0, 151.0, 151.0, 151.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 50.0, 45.0, 45.0, 44.0, 43.0, 45.0, 44.0, 48.0, 46.0], "value": 45.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 38.0, 39.0, 39.0, 39.0, 39.0, 39.0, 39.0, 40.0, 39.0], "value": 39.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 71.0, 71.0, 70.0, 73.0, 71.0, 74.0, 72.0, 71.0, 71.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 105.0, 104.0, 107.0, 108.0, 111.0, 106.0, 109.0, 106.0], "value": 107.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 155.0, 149.0, 151.0, 154.0, 155.0, 158.0, 154.0, 150.0, 150.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 60.0, 59.0, 59.0, 60.0, 62.0, 62.0, 60.0, 61.0], "value": 61.2, "unit": "score"}]}]} 04:42:59 INFO - Return code: 0 04:42:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:42:59 INFO - # TBPL SUCCESS # 04:42:59 INFO - Running post-action listener: _package_coverage_data 04:42:59 INFO - Running post-action listener: _resource_record_post_action 04:42:59 INFO - [mozharness: 2017-09-25 11:42:59.938161Z] Finished run-tests step (success) 04:42:59 INFO - Running post-run listener: _resource_record_post_run 04:43:00 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 10715136; Write bytes: 456339456; Read time: 3520; Write time: 551484 04:43:00 INFO - TinderboxPrint: CPU usage
13.1% 04:43:00 INFO - TinderboxPrint: I/O read bytes / time
10,715,136 / 3,520 04:43:00 INFO - TinderboxPrint: I/O write bytes / time
456,339,456 / 551,484 04:43:00 INFO - TinderboxPrint: CPU idle
8,234.9 (86.9%) 04:43:00 INFO - TinderboxPrint: CPU user
1,188.0 (12.5%) 04:43:00 INFO - TinderboxPrint: Swap in / out
0 / 0 04:43:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9101312; Read time: 0; Write time: 560 04:43:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:43:00 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 10715136; Write bytes: 447238144; Read time: 3520; Write time: 550924 04:43:00 INFO - Running post-run listener: _upload_blobber_files 04:43:00 INFO - Blob upload gear active. 04:43:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:43:00 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 04:43:00 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'] 04:43:00 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 04:43:00 INFO - (blobuploader) - INFO - Open directory for files ... 04:43:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:43:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:43:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:06 INFO - (blobuploader) - INFO - Done attempting. 04:43:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:43:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:43:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:07 INFO - (blobuploader) - INFO - Done attempting. 04:43:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:43:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:43:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:09 INFO - (blobuploader) - INFO - Done attempting. 04:43:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:43:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:43:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:09 INFO - (blobuploader) - INFO - Done attempting. 04:43:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:43:09 INFO - Return code: 0 04:43:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:43:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:43:09 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5505a84e2c2a1f32cb88562d422b1e4ffe7f7733b7b6c79a19256ebf4d7d48f59059a045fa5bbd52000e2bd7f381d2116d84378bbe3c2917691fcc86cd0e21f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/162d402863b22d61735be2affe06082f08f2df4911d9b3ca66cc1d20037c083716fa9e0d9d61801711a466513791de3b80abd24caebd1c4eaaf6d50b4d736f28", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54847c9e2dee71688fa5b7b064c44e5bd7278934bd101ef664856b15a62d71fa14586a3229653fe99cfc91db9f2a8728ca8d09507b43ba7d9c8ccc7a28d6a8cd", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76db5ea6c7851518111010960e5f98a106da8d0660ec6890b19d1cd907f99f5af946041922fc8b27d01300fcc3d928b78f10c38a5d0cd2695d8817e1136e8032"} 04:43:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:43:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:43:09 INFO - Contents: 04:43:09 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5505a84e2c2a1f32cb88562d422b1e4ffe7f7733b7b6c79a19256ebf4d7d48f59059a045fa5bbd52000e2bd7f381d2116d84378bbe3c2917691fcc86cd0e21f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/162d402863b22d61735be2affe06082f08f2df4911d9b3ca66cc1d20037c083716fa9e0d9d61801711a466513791de3b80abd24caebd1c4eaaf6d50b4d736f28", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54847c9e2dee71688fa5b7b064c44e5bd7278934bd101ef664856b15a62d71fa14586a3229653fe99cfc91db9f2a8728ca8d09507b43ba7d9c8ccc7a28d6a8cd", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76db5ea6c7851518111010960e5f98a106da8d0660ec6890b19d1cd907f99f5af946041922fc8b27d01300fcc3d928b78f10c38a5d0cd2695d8817e1136e8032"} 04:43:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:43:09 INFO - Copying logs to upload dir... 04:43:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:43:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.913325 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-25 04:43:09.946400) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 04:43:09.951067) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202 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/e5505a84e2c2a1f32cb88562d422b1e4ffe7f7733b7b6c79a19256ebf4d7d48f59059a045fa5bbd52000e2bd7f381d2116d84378bbe3c2917691fcc86cd0e21f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/162d402863b22d61735be2affe06082f08f2df4911d9b3ca66cc1d20037c083716fa9e0d9d61801711a466513791de3b80abd24caebd1c4eaaf6d50b4d736f28", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54847c9e2dee71688fa5b7b064c44e5bd7278934bd101ef664856b15a62d71fa14586a3229653fe99cfc91db9f2a8728ca8d09507b43ba7d9c8ccc7a28d6a8cd", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76db5ea6c7851518111010960e5f98a106da8d0660ec6890b19d1cd907f99f5af946041922fc8b27d01300fcc3d928b78f10c38a5d0cd2695d8817e1136e8032"} build_url:https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/c6Yk_WdkTh-UotDFJcbP0A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5505a84e2c2a1f32cb88562d422b1e4ffe7f7733b7b6c79a19256ebf4d7d48f59059a045fa5bbd52000e2bd7f381d2116d84378bbe3c2917691fcc86cd0e21f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/162d402863b22d61735be2affe06082f08f2df4911d9b3ca66cc1d20037c083716fa9e0d9d61801711a466513791de3b80abd24caebd1c4eaaf6d50b4d736f28", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54847c9e2dee71688fa5b7b064c44e5bd7278934bd101ef664856b15a62d71fa14586a3229653fe99cfc91db9f2a8728ca8d09507b43ba7d9c8ccc7a28d6a8cd", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76db5ea6c7851518111010960e5f98a106da8d0660ec6890b19d1cd907f99f5af946041922fc8b27d01300fcc3d928b78f10c38a5d0cd2695d8817e1136e8032"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 04:43:09.982177) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 04:43:09.982497) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1506337694.513554-659576202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 04:43:10.064559) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 04:43:10.064873) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 04:43:10.065199) ========= ========= Total master_lag: 0.33 =========