builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1506815725.25 results: success (0) revision: 179dccc17c7f261347436b4b1c33029c8272960b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-30 16:55:25.250577) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-30 16:55:25.251005) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-30 16:55:25.251638) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-30 16:55:25.403574) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 16:55:25.403821) ========= 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=c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-30 16:55:25-- 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% 42.1M=0s 2017-09-30 16:55:25 (42.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162410 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 16:55:25.601998) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 16:55:25.602333) ========= 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=c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018073 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 16:55:25.655381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 16:55:25.655703) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 179dccc17c7f261347436b4b1c33029c8272960b --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 179dccc17c7f261347436b4b1c33029c8272960b --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=c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-30 16:55:25,706 truncating revision to first 12 chars 2017-09-30 16:55:25,706 Setting DEBUG logging. 2017-09-30 16:55:25,706 attempt 1/10 2017-09-30 16:55:25,706 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/179dccc17c7f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-30 16:55:26,128 unpacking tar archive at: mozilla-central-179dccc17c7f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.783051 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 16:55:26.458613) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-30 16:55:26.458923) ========= script_repo_revision: 179dccc17c7f261347436b4b1c33029c8272960b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-30 16:55:26.459286) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-30 16:55:26.459545) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-30 16:55:26.476802) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-30 16:55:26.477175) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-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-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=c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:55:26 INFO - MultiFileLogger online at 20170930 16:55:26 in /builds/slave/test 16:55:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:55:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:55:26 INFO - {'append_to_log': False, 16:55:26 INFO - 'base_work_dir': '/builds/slave/test', 16:55:26 INFO - 'blob_upload_branch': 'Firefox', 16:55:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:55:26 INFO - 'branch': 'Firefox', 16:55:26 INFO - 'buildbot_json_path': 'buildprops.json', 16:55:26 INFO - 'code_coverage': False, 16:55:26 INFO - 'config_files': ('talos/linux_config.py',), 16:55:26 INFO - 'default_actions': ('clobber', 16:55:26 INFO - 'read-buildbot-config', 16:55:26 INFO - 'download-and-extract', 16:55:26 INFO - 'populate-webroot', 16:55:26 INFO - 'create-virtualenv', 16:55:26 INFO - 'install', 16:55:26 INFO - 'setup-mitmproxy', 16:55:26 INFO - 'run-tests'), 16:55:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:55:26 INFO - 'disable_ccov_upload': False, 16:55:26 INFO - 'disable_stylo': False, 16:55:26 INFO - 'download_minidump_stackwalk': True, 16:55:26 INFO - 'download_symbols': 'ondemand', 16:55:26 INFO - 'enable_stylo': False, 16:55:26 INFO - 'enable_webrender': False, 16:55:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:55:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:55:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:55:26 INFO - 'gecko_profile': False, 16:55:26 INFO - 'gecko_profile_interval': 0, 16:55:26 INFO - 'installer_path': 'installer.exe', 16:55:26 INFO - 'log_level': 'info', 16:55:26 INFO - 'log_name': 'talos', 16:55:26 INFO - 'log_to_console': True, 16:55:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:55:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:55:26 INFO - 'opt_config_files': (), 16:55:26 INFO - 'pip_index': False, 16:55:26 INFO - 'suite': 'dromaeojs-e10s', 16:55:26 INFO - 'system_bits': '32', 16:55:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:55:26 INFO - 'title': 'talos-linux64-ix-004', 16:55:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:55:26 INFO - 'use_talos_json': True, 16:55:26 INFO - 'verify': 'False', 16:55:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:55:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:55:26 INFO - 'work_dir': 'build'} 16:55:26 INFO - [mozharness: 2017-09-30 23:55:26.679656Z] Running clobber step. 16:55:26 INFO - Running pre-action listener: _resource_record_pre_action 16:55:26 INFO - Running main action method: clobber 16:55:26 INFO - rmtree: /builds/slave/test/build 16:55:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:55:27 INFO - Running post-action listener: _resource_record_post_action 16:55:27 INFO - [mozharness: 2017-09-30 23:55:27.689814Z] Finished clobber step (success) 16:55:27 INFO - [mozharness: 2017-09-30 23:55:27.689910Z] Running read-buildbot-config step. 16:55:27 INFO - Running pre-action listener: _resource_record_pre_action 16:55:27 INFO - Running main action method: read_buildbot_config 16:55:27 INFO - Using buildbot properties: 16:55:27 INFO - { 16:55:27 INFO - "project": "", 16:55:27 INFO - "product": "firefox", 16:55:27 INFO - "who": "archaeopteryx@coole-files.de", 16:55:27 INFO - "installer_path": "public/build/target.tar.bz2", 16:55:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 16:55:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:55:27 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 16:55:27 INFO - "stage_platform": "linux64-qr", 16:55:27 INFO - "basedir": "/builds/slave/test", 16:55:27 INFO - "buildnumber": 113, 16:55:27 INFO - "platform": "ubuntu64_hw_qr", 16:55:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:55:27 INFO - "slavebuilddir": "test", 16:55:27 INFO - "taskId": "PHYIZBwyTKios2THKy8PVg", 16:55:27 INFO - "branch": "mozilla-central", 16:55:27 INFO - "script_repo_revision": "production", 16:55:27 INFO - "revision": "179dccc17c7f261347436b4b1c33029c8272960b", 16:55:27 INFO - "slavename": "talos-linux64-ix-004", 16:55:27 INFO - "repo_path": "mozilla-central" 16:55:27 INFO - } 16:55:27 INFO - Finding installer, test and symbols from parent task. 16:55:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PHYIZBwyTKios2THKy8PVg'}, attempt #1 16:55:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PHYIZBwyTKios2THKy8PVg'}, attempt #1 16:55:28 INFO - Task dependencies: Oy_3fd7dS46Shpt74MAsbg 16:55:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg'}, attempt #1 16:55:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.tar.bz2 16:55:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.test_packages.json 16:55:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.crashreporter-symbols.zip 16:55:29 INFO - Running post-action listener: _resource_record_post_action 16:55:29 INFO - [mozharness: 2017-09-30 23:55:29.339414Z] Finished read-buildbot-config step (success) 16:55:29 INFO - [mozharness: 2017-09-30 23:55:29.339632Z] Running download-and-extract step. 16:55:29 INFO - Running pre-action listener: _resource_record_pre_action 16:55:29 INFO - Running main action method: download_and_extract 16:55:29 INFO - mkdir: /builds/slave/test/build/tests 16:55:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:29 INFO - trying https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.test_packages.json 16:55:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:55:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:55:29 INFO - Downloaded 989 bytes. 16:55:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:55:29 INFO - Using the following test package requirements: 16:55:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:55:29 INFO - u'common': [u'target.common.tests.zip'], 16:55:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:55:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:55:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:55:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:55:29 INFO - u'mozbase': [u'target.common.tests.zip'], 16:55:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:55:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:55:29 INFO - u'web-platform': [u'target.common.tests.zip', 16:55:29 INFO - u'target.web-platform.tests.tar.gz'], 16:55:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:55:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:55:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.common.tests.zip 16:55:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:55:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.common.tests.zip into memory 16:55:32 INFO - Content-Length response header: 55366791 16:55:32 INFO - Bytes received: 55366791 16:55:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.talos.tests.zip 16:55:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:55:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.talos.tests.zip into memory 16:55:43 INFO - Content-Length response header: 14522385 16:55:43 INFO - Bytes received: 14522385 16:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:44 INFO - trying https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.tar.bz2 16:55:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:55:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:55:46 INFO - Downloaded 61553897 bytes. 16:55:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.tar.bz2 16:55:46 INFO - mkdir: /builds/slave/test/properties 16:55:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:55:46 INFO - Writing to file /builds/slave/test/properties/build_url 16:55:46 INFO - Contents: 16:55:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.tar.bz2 16:55:46 INFO - Running post-action listener: _resource_record_post_action 16:55:46 INFO - Running post-action listener: find_tests_for_verification 16:55:46 INFO - Running post-action listener: set_extra_try_arguments 16:55:46 INFO - [mozharness: 2017-09-30 23:55:46.986402Z] Finished download-and-extract step (success) 16:55:46 INFO - [mozharness: 2017-09-30 23:55:46.986632Z] Running populate-webroot step. 16:55:46 INFO - Running pre-action listener: _resource_record_pre_action 16:55:46 INFO - Running main action method: populate_webroot 16:55:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:55:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:47 INFO - 'tests': ['tresize', 16:55:47 INFO - 'tcanvasmark']}, 16:55:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:55:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:47 INFO - 'tests': ['dromaeo_css', 16:55:47 INFO - 'kraken']}, 16:55:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:55:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:55:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:55:47 INFO - 'talos_options': ['--disable-stylo'], 16:55:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:55:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:55:47 INFO - 'tests': ['damp', 'tps']}, 16:55:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:55:47 INFO - 'talos_options': ['--disable-stylo'], 16:55:47 INFO - 'tests': ['damp', 'tps']}, 16:55:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:55:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:47 INFO - 'tests': ['dromaeo_dom']}, 16:55:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:55:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:47 INFO - 'tests': ['basic_compositor_video', 16:55:47 INFO - 'glvideo']}, 16:55:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:55:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:55:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:55:47 INFO - 'talos_options': ['--disable-stylo'], 16:55:47 INFO - 'tests': ['ts_paint_webext', 16:55:47 INFO - 'tp5o_webext']}, 16:55:47 INFO - 'other-e10s': {'tests': ['a11yr', 16:55:47 INFO - 'ts_paint', 16:55:47 INFO - 'tpaint', 16:55:47 INFO - 'sessionrestore', 16:55:47 INFO - 'sessionrestore_many_windows', 16:55:47 INFO - 'sessionrestore_no_auto_restore', 16:55:47 INFO - 'tabpaint', 16:55:47 INFO - 'cpstartup']}, 16:55:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:47 INFO - 'tests': ['a11yr', 16:55:47 INFO - 'ts_paint', 16:55:47 INFO - 'tpaint', 16:55:47 INFO - 'sessionrestore', 16:55:47 INFO - 'sessionrestore_many_windows', 16:55:47 INFO - 'sessionrestore_no_auto_restore', 16:55:47 INFO - 'tabpaint', 16:55:47 INFO - 'cpstartup']}, 16:55:47 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 16:55:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:55:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:47 INFO - 'tests': ['perf_reftest_singletons']}, 16:55:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:47 INFO - 'tests': ['perf_reftest']}, 16:55:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:55:47 INFO - 'tsvgr_opacity', 16:55:47 INFO - 'tart', 16:55:47 INFO - 'tscrollx', 16:55:47 INFO - 'tsvg_static']}, 16:55:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:47 INFO - 'tests': ['tsvgx', 16:55:47 INFO - 'tsvgr_opacity', 16:55:47 INFO - 'tart', 16:55:47 INFO - 'tscrollx', 16:55:47 INFO - 'tsvg_static']}, 16:55:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:55:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:55:47 INFO - 'talos_options': ['--disable-stylo'], 16:55:47 INFO - 'tests': ['tp5o']}, 16:55:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:55:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:55:47 INFO - 'talos_options': ['--mitmproxy', 16:55:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:55:47 INFO - '--firstNonBlankPaint'], 16:55:47 INFO - 'tests': ['tp6_google', 16:55:47 INFO - 'tp6_youtube', 16:55:47 INFO - 'tp6_amazon', 16:55:47 INFO - 'tp6_facebook']}, 16:55:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:55:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:55:47 INFO - 'talos_options': ['--disable-stylo', 16:55:47 INFO - '--mitmproxy', 16:55:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:55:47 INFO - '--firstNonBlankPaint'], 16:55:47 INFO - 'tests': ['tp6_google', 16:55:47 INFO - 'tp6_youtube', 16:55:47 INFO - 'tp6_amazon', 16:55:47 INFO - 'tp6_facebook']}, 16:55:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:55:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:55:47 INFO - 'talos_options': ['--stylo-threads=1', 16:55:47 INFO - '--mitmproxy', 16:55:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:55:47 INFO - '--firstNonBlankPaint'], 16:55:47 INFO - 'tests': ['tp6_google', 16:55:47 INFO - 'tp6_youtube', 16:55:47 INFO - 'tp6_amazon', 16:55:47 INFO - 'tp6_facebook']}, 16:55:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:55:47 INFO - 'talos_options': ['--xperf_path', 16:55:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:55:47 INFO - 'tests': ['tp5n']}, 16:55:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:55:47 INFO - 'talos_options': ['--disable-stylo', 16:55:47 INFO - '--xperf_path', 16:55:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:55:47 INFO - 'tests': ['tp5n']}}} 16:55:47 INFO - Running post-action listener: _resource_record_post_action 16:55:47 INFO - [mozharness: 2017-09-30 23:55:47.021437Z] Finished populate-webroot step (success) 16:55:47 INFO - [mozharness: 2017-09-30 23:55:47.021585Z] Running create-virtualenv step. 16:55:47 INFO - Running pre-action listener: _resource_record_pre_action 16:55:47 INFO - Running main action method: create_virtualenv 16:55:47 INFO - Creating virtualenv /builds/slave/test/build/venv 16:55:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:55:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:55:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:55:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:55:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:55:47 INFO - Installing distribute.............................................................................................................................................................................................done. 16:55:48 INFO - Installing pip...............done. 16:55:48 INFO - Return code: 0 16:55:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:55:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:55:48 INFO - Reading from file tmpfile_stdout 16:55:48 INFO - Output received: 16:55:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:55:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:55:48 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')]} 16:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:48 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')]} 16:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:48 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 0x254e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8d60>, '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 0x28b9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b9ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', '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 16:55:48 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 16:55:48 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 16:55:48 INFO - Using env: {'DISPLAY': ':0', 16:55:48 INFO - 'HOME': '/home/cltbld', 16:55:48 INFO - 'LANG': 'en_US.UTF-8', 16:55:48 INFO - 'LANGUAGE': 'en_US:en', 16:55:48 INFO - 'LOGNAME': 'cltbld', 16:55:48 INFO - 'MAIL': '/var/mail/cltbld', 16:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:48 INFO - 'MOZ_NO_REMOTE': '1', 16:55:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:48 INFO - 'NO_EM_RESTART': '1', 16:55:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:48 INFO - 'PWD': '/builds/slave/test', 16:55:48 INFO - 'SHELL': '/bin/bash', 16:55:48 INFO - 'SHLVL': '1', 16:55:48 INFO - 'TERM': 'linux', 16:55:48 INFO - 'TMOUT': '86400', 16:55:48 INFO - 'USER': 'cltbld', 16:55:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', 16:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:48 INFO - '_': '/tools/buildbot/bin/python'} 16:55:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:55:50 INFO - Downloading/unpacking pip>=1.5 16:55:50 INFO - Running setup.py egg_info for package pip 16:55:50 INFO - warning: no files found matching 'pip/cacert.pem' 16:55:50 INFO - warning: no files found matching '*.html' under directory 'docs' 16:55:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:55:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:55:50 INFO - Installing collected packages: pip 16:55:50 INFO - Found existing installation: pip 1.1 16:55:50 INFO - Uninstalling pip: 16:55:50 INFO - Successfully uninstalled pip 16:55:50 INFO - Running setup.py install for pip 16:55:50 INFO - warning: no files found matching 'pip/cacert.pem' 16:55:50 INFO - warning: no files found matching '*.html' under directory 'docs' 16:55:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:55:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:55:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:55:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:55:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:55:50 INFO - Successfully installed pip 16:55:50 INFO - Cleaning up... 16:55:50 INFO - Return code: 0 16:55:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:55:50 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')]} 16:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:50 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')]} 16:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:50 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 0x254e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8d60>, '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 0x28b9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b9ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', '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 16:55:50 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 16:55:50 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 16:55:50 INFO - Using env: {'DISPLAY': ':0', 16:55:50 INFO - 'HOME': '/home/cltbld', 16:55:50 INFO - 'LANG': 'en_US.UTF-8', 16:55:50 INFO - 'LANGUAGE': 'en_US:en', 16:55:50 INFO - 'LOGNAME': 'cltbld', 16:55:50 INFO - 'MAIL': '/var/mail/cltbld', 16:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:50 INFO - 'MOZ_NO_REMOTE': '1', 16:55:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:50 INFO - 'NO_EM_RESTART': '1', 16:55:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:50 INFO - 'PWD': '/builds/slave/test', 16:55:50 INFO - 'SHELL': '/bin/bash', 16:55:50 INFO - 'SHLVL': '1', 16:55:50 INFO - 'TERM': 'linux', 16:55:50 INFO - 'TMOUT': '86400', 16:55:50 INFO - 'USER': 'cltbld', 16:55:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', 16:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:50 INFO - '_': '/tools/buildbot/bin/python'} 16:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:50 INFO - Downloading/unpacking psutil>=3.1.1 16:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:55:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:55:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:55:51 INFO - Installing collected packages: psutil 16:55:51 INFO - Running setup.py install for psutil 16:55:52 INFO - building 'psutil._psutil_linux' extension 16:55:52 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 16:55:52 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 16:55:52 INFO - building 'psutil._psutil_posix' extension 16:55:52 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 16:55:52 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 16:55:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:55:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:55:52 INFO - Successfully installed psutil 16:55:52 INFO - Cleaning up... 16:55:53 INFO - Return code: 0 16:55:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:55:53 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')]} 16:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:53 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')]} 16:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:53 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 0x254e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8d60>, '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 0x28b9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b9ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', '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 16:55:53 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 16:55:53 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 16:55:53 INFO - Using env: {'DISPLAY': ':0', 16:55:53 INFO - 'HOME': '/home/cltbld', 16:55:53 INFO - 'LANG': 'en_US.UTF-8', 16:55:53 INFO - 'LANGUAGE': 'en_US:en', 16:55:53 INFO - 'LOGNAME': 'cltbld', 16:55:53 INFO - 'MAIL': '/var/mail/cltbld', 16:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:53 INFO - 'MOZ_NO_REMOTE': '1', 16:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:53 INFO - 'NO_EM_RESTART': '1', 16:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:53 INFO - 'PWD': '/builds/slave/test', 16:55:53 INFO - 'SHELL': '/bin/bash', 16:55:53 INFO - 'SHLVL': '1', 16:55:53 INFO - 'TERM': 'linux', 16:55:53 INFO - 'TMOUT': '86400', 16:55:53 INFO - 'USER': 'cltbld', 16:55:53 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', 16:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:53 INFO - '_': '/tools/buildbot/bin/python'} 16:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:55:54 INFO - Installing collected packages: mozsystemmonitor 16:55:54 INFO - Running setup.py install for mozsystemmonitor 16:55:55 INFO - Successfully installed mozsystemmonitor 16:55:55 INFO - Cleaning up... 16:55:55 INFO - Return code: 0 16:55:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:55: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')]} 16:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55: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')]} 16:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8d60>, '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 0x28b9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b9ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', '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 16:55:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:55:55 INFO - Using env: {'DISPLAY': ':0', 16:55:55 INFO - 'HOME': '/home/cltbld', 16:55:55 INFO - 'LANG': 'en_US.UTF-8', 16:55:55 INFO - 'LANGUAGE': 'en_US:en', 16:55:55 INFO - 'LOGNAME': 'cltbld', 16:55:55 INFO - 'MAIL': '/var/mail/cltbld', 16:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:55 INFO - 'MOZ_NO_REMOTE': '1', 16:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:55 INFO - 'NO_EM_RESTART': '1', 16:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:55 INFO - 'PWD': '/builds/slave/test', 16:55:55 INFO - 'SHELL': '/bin/bash', 16:55:55 INFO - 'SHLVL': '1', 16:55:55 INFO - 'TERM': 'linux', 16:55:55 INFO - 'TMOUT': '86400', 16:55:55 INFO - 'USER': 'cltbld', 16:55:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', 16:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:55 INFO - '_': '/tools/buildbot/bin/python'} 16:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:56 INFO - Downloading/unpacking jsonschema==2.5.1 16:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:55:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:55: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 16:55: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 16:55: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 16:55: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 16:55:57 INFO - Downloading functools32-3.2.3-2.tar.gz 16:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:55:57 INFO - warning: no files found matching '*.txt' 16:55:57 INFO - no previously-included directories found matching 'build' 16:55:57 INFO - no previously-included directories found matching 'dist' 16:55:57 INFO - no previously-included directories found matching '.git*' 16:55:57 INFO - Installing collected packages: jsonschema, functools32 16:55:57 INFO - Running setup.py install for functools32 16:55:57 INFO - warning: no files found matching '*.txt' 16:55:57 INFO - no previously-included directories found matching 'build' 16:55:57 INFO - no previously-included directories found matching 'dist' 16:55:57 INFO - no previously-included directories found matching '.git*' 16:55:57 INFO - Successfully installed jsonschema functools32 16:55:57 INFO - Cleaning up... 16:55:57 INFO - Return code: 0 16:55:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8d60>, '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 0x28b9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b9ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', '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 16:55:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:55:57 INFO - Using env: {'DISPLAY': ':0', 16:55:57 INFO - 'HOME': '/home/cltbld', 16:55:57 INFO - 'LANG': 'en_US.UTF-8', 16:55:57 INFO - 'LANGUAGE': 'en_US:en', 16:55:57 INFO - 'LOGNAME': 'cltbld', 16:55:57 INFO - 'MAIL': '/var/mail/cltbld', 16:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:57 INFO - 'MOZ_NO_REMOTE': '1', 16:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:57 INFO - 'NO_EM_RESTART': '1', 16:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:57 INFO - 'PWD': '/builds/slave/test', 16:55:57 INFO - 'SHELL': '/bin/bash', 16:55:57 INFO - 'SHLVL': '1', 16:55:57 INFO - 'TERM': 'linux', 16:55:57 INFO - 'TMOUT': '86400', 16:55:57 INFO - 'USER': 'cltbld', 16:55:57 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', 16:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:57 INFO - '_': '/tools/buildbot/bin/python'} 16:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:55:57 INFO - Cleaning up... 16:55:57 INFO - Return code: 0 16:55:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8d60>, '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 0x28b9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b9ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', '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 16:55:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:55:57 INFO - Using env: {'DISPLAY': ':0', 16:55:57 INFO - 'HOME': '/home/cltbld', 16:55:57 INFO - 'LANG': 'en_US.UTF-8', 16:55:57 INFO - 'LANGUAGE': 'en_US:en', 16:55:57 INFO - 'LOGNAME': 'cltbld', 16:55:57 INFO - 'MAIL': '/var/mail/cltbld', 16:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:57 INFO - 'MOZ_NO_REMOTE': '1', 16:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:57 INFO - 'NO_EM_RESTART': '1', 16:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:57 INFO - 'PWD': '/builds/slave/test', 16:55:57 INFO - 'SHELL': '/bin/bash', 16:55:57 INFO - 'SHLVL': '1', 16:55:57 INFO - 'TERM': 'linux', 16:55:57 INFO - 'TMOUT': '86400', 16:55:57 INFO - 'USER': 'cltbld', 16:55:57 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', 16:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:57 INFO - '_': '/tools/buildbot/bin/python'} 16:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:58 INFO - Downloading/unpacking blobuploader==1.2.4 16:55: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 16:55: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 16:55: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 16:55: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 16:55:59 INFO - Downloading blobuploader-1.2.4.tar.gz 16:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:55:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:55: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 16:55: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 16:55: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 16:55: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 16:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:55:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:55: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 16:55: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 16:55: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 16:55: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 16:55:59 INFO - Downloading docopt-0.6.1.tar.gz 16:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:55:59 INFO - Installing collected packages: blobuploader, requests, docopt 16:55:59 INFO - Running setup.py install for blobuploader 16:55:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:55:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:55:59 INFO - Running setup.py install for requests 16:56:00 INFO - Running setup.py install for docopt 16:56:00 INFO - Successfully installed blobuploader requests docopt 16:56:00 INFO - Cleaning up... 16:56:00 INFO - Return code: 0 16:56:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8d60>, '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 0x28b9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b9ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', '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 16:56:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:56:00 INFO - Using env: {'DISPLAY': ':0', 16:56:00 INFO - 'HOME': '/home/cltbld', 16:56:00 INFO - 'LANG': 'en_US.UTF-8', 16:56:00 INFO - 'LANGUAGE': 'en_US:en', 16:56:00 INFO - 'LOGNAME': 'cltbld', 16:56:00 INFO - 'MAIL': '/var/mail/cltbld', 16:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:00 INFO - 'MOZ_NO_REMOTE': '1', 16:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:00 INFO - 'NO_EM_RESTART': '1', 16:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:00 INFO - 'PWD': '/builds/slave/test', 16:56:00 INFO - 'SHELL': '/bin/bash', 16:56:00 INFO - 'SHLVL': '1', 16:56:00 INFO - 'TERM': 'linux', 16:56:00 INFO - 'TMOUT': '86400', 16:56:00 INFO - 'USER': 'cltbld', 16:56:00 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', 16:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:00 INFO - '_': '/tools/buildbot/bin/python'} 16:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:00 INFO - Running setup.py (path:/tmp/pip-8aSgjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:00 INFO - Running setup.py (path:/tmp/pip-jmo5hM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:00 INFO - Running setup.py (path:/tmp/pip-E7LCt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:00 INFO - Running setup.py (path:/tmp/pip-oqfeGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:00 INFO - Running setup.py (path:/tmp/pip-ekwlyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:00 INFO - Running setup.py (path:/tmp/pip-eYLvNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:01 INFO - Running setup.py (path:/tmp/pip-t5gqKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:01 INFO - Running setup.py (path:/tmp/pip-hGqiGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:01 INFO - Running setup.py (path:/tmp/pip-aNe_hU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:01 INFO - Running setup.py (path:/tmp/pip-n_twEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:01 INFO - Running setup.py (path:/tmp/pip-K9rHBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:01 INFO - Running setup.py (path:/tmp/pip-MYW8SL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:01 INFO - Running setup.py (path:/tmp/pip-uYtXjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:01 INFO - Running setup.py (path:/tmp/pip-AkumNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:01 INFO - Running setup.py (path:/tmp/pip-JBW8t2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:01 INFO - Running setup.py (path:/tmp/pip-daN8UU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:01 INFO - Running setup.py (path:/tmp/pip-eqWeSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:56:01 INFO - Running setup.py install for manifestparser 16:56:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:56:01 INFO - Running setup.py install for mozcrash 16:56:01 INFO - Running setup.py install for mozdebug 16:56:02 INFO - Running setup.py install for mozdevice 16:56:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:56:02 INFO - Running setup.py install for mozfile 16:56:02 INFO - Running setup.py install for mozhttpd 16:56:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:56:02 INFO - Running setup.py install for mozinfo 16:56:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:56:02 INFO - Running setup.py install for mozInstall 16:56:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:56:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:56:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:56:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:56:02 INFO - Running setup.py install for mozleak 16:56:02 INFO - Running setup.py install for mozlog 16:56:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:56:02 INFO - Running setup.py install for moznetwork 16:56:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:56:02 INFO - Running setup.py install for mozprocess 16:56:03 INFO - Running setup.py install for mozprofile 16:56:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:56:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:56:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:56:03 INFO - Running setup.py install for mozrunner 16:56:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:56:03 INFO - Running setup.py install for mozscreenshot 16:56:03 INFO - Running setup.py install for moztest 16:56:03 INFO - Running setup.py install for mozversion 16:56:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:56:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:56:03 INFO - Cleaning up... 16:56:03 INFO - Return code: 0 16:56:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8d60>, '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 0x28b9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b9ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', '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 16:56:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:56:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:56:03 INFO - Using env: {'DISPLAY': ':0', 16:56:03 INFO - 'HOME': '/home/cltbld', 16:56:03 INFO - 'LANG': 'en_US.UTF-8', 16:56:03 INFO - 'LANGUAGE': 'en_US:en', 16:56:03 INFO - 'LOGNAME': 'cltbld', 16:56:03 INFO - 'MAIL': '/var/mail/cltbld', 16:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:03 INFO - 'MOZ_NO_REMOTE': '1', 16:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:03 INFO - 'NO_EM_RESTART': '1', 16:56:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:03 INFO - 'PWD': '/builds/slave/test', 16:56:03 INFO - 'SHELL': '/bin/bash', 16:56:03 INFO - 'SHLVL': '1', 16:56:03 INFO - 'TERM': 'linux', 16:56:03 INFO - 'TMOUT': '86400', 16:56:03 INFO - 'USER': 'cltbld', 16:56:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', 16:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:03 INFO - '_': '/tools/buildbot/bin/python'} 16:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:03 INFO - Running setup.py (path:/tmp/pip-WSZ3tC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:03 INFO - Running setup.py (path:/tmp/pip-dneCHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:03 INFO - Running setup.py (path:/tmp/pip-2F9Orf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:04 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)) 16:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:04 INFO - Running setup.py (path:/tmp/pip-HOn7G5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:04 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)) 16:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:04 INFO - Running setup.py (path:/tmp/pip-jgZyc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:04 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)) 16:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:04 INFO - Running setup.py (path:/tmp/pip-TarTtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:04 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)) 16:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:04 INFO - Running setup.py (path:/tmp/pip-EQzkw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:04 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)) 16:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:04 INFO - Running setup.py (path:/tmp/pip-ls6_9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:04 INFO - Running setup.py (path:/tmp/pip-ilG1NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:04 INFO - Running setup.py (path:/tmp/pip-IeF9iW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:04 INFO - Running setup.py (path:/tmp/pip-dIFSmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:04 INFO - Running setup.py (path:/tmp/pip-eJPSKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:04 INFO - Running setup.py (path:/tmp/pip-UcXjnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:04 INFO - Running setup.py (path:/tmp/pip-Wv8SXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:04 INFO - Running setup.py (path:/tmp/pip-k2bOXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:04 INFO - Running setup.py (path:/tmp/pip-F6lBA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:04 INFO - Running setup.py (path:/tmp/pip-6Yf11V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:56:05 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 16:56:05 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 16:56:05 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 16:56:05 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 16:56:06 INFO - Downloading blessings-1.6.tar.gz 16:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:56:06 INFO - Installing collected packages: blessings 16:56:06 INFO - Running setup.py install for blessings 16:56:06 INFO - Successfully installed blessings 16:56:06 INFO - Cleaning up... 16:56:06 INFO - Return code: 0 16:56:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:56:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:06 INFO - Reading from file tmpfile_stdout 16:56:06 INFO - Current package versions: 16:56:06 INFO - argparse == 1.2.1 16:56:06 INFO - blessings == 1.6 16:56:06 INFO - blobuploader == 1.2.4 16:56:06 INFO - docopt == 0.6.1 16:56:06 INFO - functools32 == 3.2.3-2 16:56:06 INFO - jsonschema == 2.5.1 16:56:06 INFO - manifestparser == 1.1 16:56:06 INFO - mozInstall == 1.13 16:56:06 INFO - mozcrash == 1.0 16:56:06 INFO - mozdebug == 0.1 16:56:06 INFO - mozdevice == 0.51 16:56:06 INFO - mozfile == 1.2 16:56:06 INFO - mozhttpd == 0.7 16:56:06 INFO - mozinfo == 0.10 16:56:06 INFO - mozleak == 0.1 16:56:06 INFO - mozlog == 3.5 16:56:06 INFO - moznetwork == 0.27 16:56:06 INFO - mozprocess == 0.25 16:56:06 INFO - mozprofile == 0.28 16:56:06 INFO - mozrunner == 6.13 16:56:06 INFO - mozscreenshot == 0.1 16:56:06 INFO - mozsystemmonitor == 0.3 16:56:06 INFO - moztest == 0.8 16:56:06 INFO - mozversion == 1.4 16:56:06 INFO - psutil == 3.1.1 16:56:06 INFO - requests == 1.2.3 16:56:06 INFO - wsgiref == 0.1.2 16:56:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8d60>, '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 0x28b9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b9ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', '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 16:56:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:56:06 INFO - Using env: {'DISPLAY': ':0', 16:56:06 INFO - 'HOME': '/home/cltbld', 16:56:06 INFO - 'LANG': 'en_US.UTF-8', 16:56:06 INFO - 'LANGUAGE': 'en_US:en', 16:56:06 INFO - 'LOGNAME': 'cltbld', 16:56:06 INFO - 'MAIL': '/var/mail/cltbld', 16:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:06 INFO - 'MOZ_NO_REMOTE': '1', 16:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:06 INFO - 'NO_EM_RESTART': '1', 16:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:06 INFO - 'PWD': '/builds/slave/test', 16:56:06 INFO - 'SHELL': '/bin/bash', 16:56:06 INFO - 'SHLVL': '1', 16:56:06 INFO - 'TERM': 'linux', 16:56:06 INFO - 'TMOUT': '86400', 16:56:06 INFO - 'USER': 'cltbld', 16:56:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', 16:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:06 INFO - '_': '/tools/buildbot/bin/python'} 16:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:56:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:56: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 16:56: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 16:56: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 16:56: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 16:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:56:07 INFO - Installing collected packages: simplejson 16:56:07 INFO - Running setup.py install for simplejson 16:56:08 INFO - building 'simplejson._speedups' extension 16:56:08 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 16:56:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 16:56:08 INFO - Successfully installed simplejson 16:56:08 INFO - Cleaning up... 16:56:09 INFO - Return code: 0 16:56:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:56:09 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')]} 16:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:09 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')]} 16:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:09 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 0x254e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8d60>, '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 0x28b9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b9ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', '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 16:56:09 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 16:56:09 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 16:56:09 INFO - Using env: {'DISPLAY': ':0', 16:56:09 INFO - 'HOME': '/home/cltbld', 16:56:09 INFO - 'LANG': 'en_US.UTF-8', 16:56:09 INFO - 'LANGUAGE': 'en_US:en', 16:56:09 INFO - 'LOGNAME': 'cltbld', 16:56:09 INFO - 'MAIL': '/var/mail/cltbld', 16:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:09 INFO - 'MOZ_NO_REMOTE': '1', 16:56:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:09 INFO - 'NO_EM_RESTART': '1', 16:56:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:09 INFO - 'PWD': '/builds/slave/test', 16:56:09 INFO - 'SHELL': '/bin/bash', 16:56:09 INFO - 'SHLVL': '1', 16:56:09 INFO - 'TERM': 'linux', 16:56:09 INFO - 'TMOUT': '86400', 16:56:09 INFO - 'USER': 'cltbld', 16:56:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', 16:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:09 INFO - '_': '/tools/buildbot/bin/python'} 16:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:56:09 INFO - Cleaning up... 16:56:09 INFO - Return code: 0 16:56:09 INFO - Running post-action listener: _resource_record_post_action 16:56:09 INFO - Running post-action listener: _start_resource_monitoring 16:56:09 INFO - Starting resource monitoring. 16:56:09 INFO - [mozharness: 2017-09-30 23:56:09.271412Z] Finished create-virtualenv step (success) 16:56:09 INFO - [mozharness: 2017-09-30 23:56:09.271877Z] Running install step. 16:56:09 INFO - Running pre-action listener: _resource_record_pre_action 16:56:09 INFO - Running main action method: install 16:56:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:09 INFO - Reading from file tmpfile_stdout 16:56:09 INFO - Detecting whether we're running mozinstall >=1.0... 16:56:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:56:09 INFO - Reading from file tmpfile_stdout 16:56:09 INFO - Output received: 16:56:09 INFO - Usage: mozinstall [options] installer 16:56:09 INFO - Options: 16:56:09 INFO - -h, --help show this help message and exit 16:56:09 INFO - -d DEST, --destination=DEST 16:56:09 INFO - Directory to install application into. [default: 16:56:09 INFO - "/builds/slave/test"] 16:56:09 INFO - --app=APP Application being installed. [default: firefox] 16:56:09 INFO - mkdir: /builds/slave/test/build/application 16:56:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:56:27 INFO - Reading from file tmpfile_stdout 16:56:27 INFO - Output received: 16:56:27 INFO - /builds/slave/test/build/application/firefox/firefox 16:56:27 INFO - Running post-action listener: _resource_record_post_action 16:56:27 INFO - [mozharness: 2017-09-30 23:56:27.390664Z] Finished install step (success) 16:56:27 INFO - [mozharness: 2017-09-30 23:56:27.390916Z] Running setup-mitmproxy step. 16:56:27 INFO - Running pre-action listener: _resource_record_pre_action 16:56:27 INFO - Running main action method: setup_mitmproxy 16:56:27 INFO - Skipping: mitmproxy is not required 16:56:27 INFO - Running post-action listener: _resource_record_post_action 16:56:27 INFO - [mozharness: 2017-09-30 23:56:27.392056Z] Finished setup-mitmproxy step (success) 16:56:27 INFO - [mozharness: 2017-09-30 23:56:27.392290Z] Running run-tests step. 16:56:27 INFO - Running pre-action listener: _resource_record_pre_action 16:56:27 INFO - Running pre-action listener: _set_gcov_prefix 16:56:27 INFO - Running main action method: run_tests 16:56:27 WARNING - Try message not found. 16:56:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:56:27 INFO - Python 2.7.3 16:56:27 INFO - Return code: 0 16:56:27 INFO - grabbing minidump binary from tooltool 16:56:27 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')]} 16:56:27 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 0x28b8d60>, '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 0x28b9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b9ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:56:27 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 16:56:27 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 16:56:27 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 16:56:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:56:27 INFO - Return code: 0 16:56:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:56:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:56:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:56:27 INFO - ENV: RUST_BACKTRACE is now full 16:56:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:56:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:56:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:56:27 INFO - Using env: {'DISPLAY': ':0', 16:56:27 INFO - 'HOME': '/home/cltbld', 16:56:27 INFO - 'LANG': 'en_US.UTF-8', 16:56:27 INFO - 'LANGUAGE': 'en_US:en', 16:56:27 INFO - 'LOGNAME': 'cltbld', 16:56:27 INFO - 'MAIL': '/var/mail/cltbld', 16:56:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:56:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:56:27 INFO - 'MOZ_ACCELERATED': '1', 16:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:27 INFO - 'MOZ_NO_REMOTE': '1', 16:56:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:56:27 INFO - 'MOZ_WEBRENDER': '1', 16:56:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:27 INFO - 'NO_EM_RESTART': '1', 16:56:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:27 INFO - 'PWD': '/builds/slave/test', 16:56:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:56:27 INFO - 'RUST_BACKTRACE': 'full', 16:56:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:56:27 INFO - 'SHELL': '/bin/bash', 16:56:27 INFO - 'SHLVL': '1', 16:56:27 INFO - 'TERM': 'linux', 16:56:27 INFO - 'TMOUT': '86400', 16:56:27 INFO - 'USER': 'cltbld', 16:56:27 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', 16:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:27 INFO - '_': '/tools/buildbot/bin/python'} 16:56:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:56:27 INFO - mozversion application_buildid: 20170930230214 16:56:27 INFO - mozversion application_changeset: 179dccc17c7f261347436b4b1c33029c8272960b 16:56:27 INFO - mozversion application_display_name: FirefoxNightly 16:56:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:56:27 INFO - mozversion application_name: Firefox 16:56:27 INFO - mozversion application_remotingname: firefox 16:56:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:56:27 INFO - mozversion application_vendor: Mozilla 16:56:27 INFO - mozversion application_version: 58.0a1 16:56:27 INFO - mozversion platform_buildid: 20170930230214 16:56:27 INFO - mozversion platform_changeset: 179dccc17c7f261347436b4b1c33029c8272960b 16:56:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:56:27 INFO - mozversion platform_version: 58.0a1 16:56:27 INFO - using testdate: 1506815787 16:56:27 INFO - actual date: 1506815787 16:56:27 INFO - starting webserver on 'localhost:51106' 16:56:27 INFO - SUITE-START | Running 2 tests 16:56:27 INFO - TEST-START | dromaeo_css 16:56:27 INFO - Initialising browser for dromaeo_css test... 16:56:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51106/getInfo.html -profile /tmp/tmpa6rchy/profile 16:56:27 INFO - TEST-INFO | started process 4688 (/builds/slave/test/build/application/firefox/firefox http://localhost:51106/getInfo.html) 16:56:34 INFO - TEST-INFO | 4688: exit 0 16:56:34 INFO - Browser initialized. 16:56:34 INFO - Running cycle 1/1 for dromaeo_css test... 16:56:34 INFO - Using env: {'DISPLAY': ':0', 16:56:34 INFO - 'HOME': '/home/cltbld', 16:56:34 INFO - 'JSGC_DISABLE_POISONING': '1', 16:56:34 INFO - 'LANG': 'en_US.UTF-8', 16:56:34 INFO - 'LANGUAGE': 'en_US:en', 16:56:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:56:34 INFO - 'LOGNAME': 'cltbld', 16:56:34 INFO - 'MAIL': '/var/mail/cltbld', 16:56:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:56:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:56:34 INFO - 'MOZ_ACCELERATED': '1', 16:56:34 INFO - 'MOZ_CRASHREPORTER': '1', 16:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:56:34 INFO - 'MOZ_NO_REMOTE': '1', 16:56:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:56:34 INFO - 'MOZ_WEBRENDER': '1', 16:56:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:34 INFO - 'NO_EM_RESTART': '1', 16:56:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:34 INFO - 'PWD': '/builds/slave/test', 16:56:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:56:34 INFO - 'RUST_BACKTRACE': 'full', 16:56:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:56:34 INFO - 'SHELL': '/bin/bash', 16:56:34 INFO - 'SHLVL': '1', 16:56:34 INFO - 'TERM': 'linux', 16:56:34 INFO - 'TMOUT': '86400', 16:56:34 INFO - 'USER': 'cltbld', 16:56:34 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', 16:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:34 INFO - '_': '/tools/buildbot/bin/python'} 16:56:34 INFO - TEST-INFO | started process 4932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa6rchy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:35 INFO - PID 4932 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:56:35 INFO - PID 4932 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:56:35 INFO - PID 4932 | 16:56:35 INFO - PID 4932 | (/builds/slave/test/build/application/firefox/firefox:4990): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:56:35 INFO - PID 4932 | 16:56:45 INFO - PID 4932 | RSS: Main: 194285568 16:56:45 INFO - PID 4932 | 16:59:43 INFO - PID 4932 | Cycle 1(1): loaded http://localhost:51106/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51106/tests/dromaeo/cssquery-ext.html) 16:59:44 INFO - PID 4932 | RSS: Main: 190873600 16:59:44 INFO - PID 4932 | 17:02:46 INFO - PID 4932 | Cycle 1(1): loaded http://localhost:51106/tests/dromaeo/cssquery-ext.html (next: http://localhost:51106/tests/dromaeo/cssquery-jquery.html) 17:02:47 INFO - PID 4932 | RSS: Main: 189321216 17:02:47 INFO - PID 4932 | 17:05:49 INFO - PID 4932 | Cycle 1(1): loaded http://localhost:51106/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51106/tests/dromaeo/cssquery-mootools.html) 17:05:50 INFO - PID 4932 | RSS: Main: 190521344 17:05:50 INFO - PID 4932 | 17:08:52 INFO - PID 4932 | Cycle 1(1): loaded http://localhost:51106/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51106/tests/dromaeo/cssquery-prototype.html) 17:08:52 INFO - PID 4932 | RSS: Main: 190844928 17:08:52 INFO - PID 4932 | 17:11:56 INFO - PID 4932 | Cycle 1(1): loaded http://localhost:51106/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51106/tests/dromaeo/cssquery-yui.html) 17:11:56 INFO - PID 4932 | RSS: Main: 193126400 17:11:56 INFO - PID 4932 | 17:14:58 INFO - PID 4932 | Cycle 1(1): loaded http://localhost:51106/tests/dromaeo/cssquery-yui.html (next: http://localhost:51106/tests/dromaeo/cssquery-dojo.html) 17:14:58 INFO - PID 4932 | RSS: Main: 193753088 17:14:58 INFO - PID 4932 | 17:14:58 INFO - PID 4932 | __start_tp_report 17:14:58 INFO - PID 4932 | _x_x_mozilla_page_load 17:14:58 INFO - PID 4932 | _x_x_mozilla_page_load_details 17:14:58 INFO - PID 4932 | |i|pagename|runs| 17:14:58 INFO - PID 4932 | |0;dojo.html;3158.0683698308994;3181.077487528617;3186.932377653486;3192.9042128736132;3204.0708194623553;6046.455818976291;6166.075088736692;6202.5348098892655;6212.65830379329;6229.1279220909055;6114.327423983358;6117.5717699761035;6169.16716243307;6171.9382806171925;6173.444390004899;5675.772969081232;5695.515881150107;5714.342850572186;5724.284464441945;5825.621334613258;5748;5771.82684519463;5776.220210271602;5839.124131380306;5868.618539794899;749.058078130988;5591.384947655754;5715.9428405716035;5770.365259821417;5775.855603609902;5581.748821303051;5644.6330988485615;5717.256756621654;5766.731319109831;5779.075347944308;5673.801416950429;5676.631018983753;5723.399043100498;5742.2247996520355;5760.913586296167;6091.482224010964;6136.079588061782;6247.750089996394;6266.717997690115;6290.811275661737;6510.739570417178;6593.241777195588;6617.569857959217;6640.966795166041;6713.530052896299;6597.769078082244;6616.536842421033;6653.168353955755;6756.425703815182;6774.5257831951785;5915.852103697399;6044.516438684895;6115.143879856823;6133.049377346519;6239.719212635442;6792.830179245559;6802.319768023158;6802.625855577891;6882.105326307548;6889.069975553336;6525.21697396306;6527.379898909596;6565.704543295563;6604.174478190226;6622.072909792633;6651.467882569383;6656.500762442836;6715.46276297895;6728.596284222865;6749.2238392584495;6361.554691171574;6506.804795856132;6563.442107420828;6641.734330626818;6703.028060931235;6489.740410383626;6570.211574611078;6574.572652777554;6577.638229897401;6591.472682185414;5102.158143906214;5141.537261646395;5145.588352931756;5156.9742151289;5156.9742151289;4491.079328737601;4533.320001999727;4540.205464043779;4552.590266875997;4555.794989225493;5575.4424557544735;5581.274434323512;5654.264945557134;5670.149477578314;5713.4000929902595;6603.7358505660195;6641.767538136142;6678.232003319583;6693.732250710014;6749.392554670103;5687.7156142192725;5713.143028545752;5730.684812335361;5736.885262294814;5746.482816546531;5631.267935168484;5681.488666020078;5733.741981610838;5734.197212390269;5737.913931291034;6306.054091886162;6326.746930122744;6430.967845160744;6449.258335291408;6457.61254324742;6405.423511883952;6577.704003319958;6599.340065993362;6620.801375958633;6720.529562930548;6368.458681011981;6381.968090159519;6387.93612063892;6391.2330520336;6401.775937842153;6435.388638079375;6452.838679033061;6516.478681705357;6527.3472652734345;6547.508936829661;6626.900596491153;6638.269790323157;6662.500312476487;6666.533342665967;6685.63229022389;6452.483801295791;6476.06097115925;6534.640594767334;6542.803715888531;6546.738130474918;6261.060840873905;6334.746610135728;6382.329855365306;6432;6443.226812782309;6311.463525600192;6386.87226255463;6461.289258181502;6475.09348691193;6482.254540727877;6472.805815825533;6496.545241833026;6499.1551098358805;6562.409383155539;6625.105610742488;6361.554691171574;6361.777337793155;6379.362063793769;6387.872242555216;6427.967860160669 17:14:58 INFO - PID 4932 | |1;ext.html;883.1301168349177;896.5606852642205;897.7935074932765;899.0425197165023;900.3472482450225;37712.245755084885;40807.18385632286;40911.38632920509;41030.794846025805;41139.58860411395;37876.24247515048;38704.41943370845;38717;38737.612623873756;38758;7204.711811527546;7305.232950540197;7325.523840950348;7334.119905611307;7348.228436014222;7088.1494220693585;7234.927650723478;7244.492885498017;7252.782416527512;7253.601051942141;7200.171980222289;7261.564306141622;7315.451341149408;7759.88360174595;8012.919870801305;7902.960485197537;7915.564643944581;7963;7978.720744773963;7979.441439099265;7878.4485086044;7954.164812694699;7973.481723687942;7976.6809327626825;7982.840343193162;37362.065948351235;37516;37674;37706.62293377059;37795.24409511822;3583.7849729016343;3596.047047532406;3598.730095242841;3620.7646502977486;3642.817859107034;31261.218469538442;31675;31837.840810796028;31904.84047579747;31905;5081.695098294114;5086;5141.537261646432;5161.922571161435;5162.586993040585;197428.01285993622;198977;199147;199489;200648;42227.788861055495;42808.78595607002;43093;47887;48758.5124148754;52262.738686307086;52851.03617228723;52943.20585191225;53032.469675303524;53037.46962530325;15787.894847360574;15959.44141955026;15967.920160399124;15981.840181598267;15985.040897546185;13088.934555327163;13139.67150821218;13159.078864479587;13198;13222.801657975138;14375.64060898465;14457.92771036138;14502.85497145036;14526;14542.854571454362;5765.221695071112;5825.941740582624;5889.911651325234;5896.262967129109;5950.285965684146;984.542187882638;1007.9899201008043;1014.9847752283722;1032.339302846179;1035.5236591167995;22974.540509189723;23118.959646815598;23176.53646927052;23280.3015909523;23423.06307747671;1111.5776005118164;1125.898669119783;1129.1926272714884;1129.836173754801;1132.7904337697553;12000.63998080059;12204;12293;12348.691282718004;12371.75256494865;236530;237754;238555;238975;239243;52552.73723631357;52973.205401919;53061.2040819388;53139.734301328244;53497.1975420369;1406.507722297188;1484.621421537501;1490.470882836599;1491.507802425197;1504.127605988524;22445.5510889778;22528.887355563773;22677.319680409615;22797.88601056984;23033.88483057574;36734;36992.26015479729;37007;37140.257194856495;37252.62747372492;196227;197712;198110;198846;199166;29671.703282966893;30161.245968850955;32541.02376928696;32739.672603273662;32875.34249315048;41726.95682607959;41816;42049;42148;42509.36235956401;30590;30677.23306917345;30916.845415773678;31269.374612508076;31415.68584314219;30101;30672.386552268385;30903.845480772452;30945.381092377575;31116.53325200169;33901.15247118842;33924.66075339215;34083.48874766831;34240.657593424745;34552;29476.263093422836;29530.114096577137;30094.69905300919;30399.54400684036;30656;22816.31551053471;23233.18683846125;23298.534029319657;23603.52792944097;23748.881255593613 17:14:58 INFO - PID 4932 | |2;jquery.html;569.5671289819736;571.4742436958;581.1950448628648;586.870888404551;603.2700432476704;22331.776682233172;23171.652425213593;23213.18753843616;23242.30273091808;23248.883755581242;23969.880150599267;24771.380715482075;24953.87523062382;25010;25185.370365740866;6520.413162815334;6719;6726.596404215763;6740.865182696343;6773.288804675512;6633.701483433257;6730.899036514456;6735.427488663469;6737.2925842786535;6740.1237839081095;6322.241331040282;6566.5075119366;6599.9670001650165;6628.966855165718;6642.468602511812;6563.442107420875;6593.934060659404;6600.735970561172;6600.966995165018;6608.9339106608795;5861.472467477947;6130.417610327012;6148.8770224595255;6178.165947597062;6180.9381906180815;27996.160115196577;28117.85941070302;28232;28645.14064578066;28687.426251475063;2066.6486697261503;2083.864548804338;2086.1655337864822;2093.675480300556;2097.685347197917;18726.719099213522;19335.226590936345;19403.4178974631;19660.213591456326;19770;2479.7024357077084;2492.2523243027017;2547.299492639539;2548.8215824892263;2558.4883023395396;127220.36389817992;132397;132867;133121.33439332838;150567;14526.918456038855;14720.55888223553;14833.035852669758;15015.699686006219;15415;23702;23764.405889852547;23777.40556486067;23792;23842.52314953691;9883.901160988442;10017.499125043718;10139.695809125738;10147.441890696082;10210.744731381626;9314.693283884259;9358.719238422858;9416.529173541296;9457.290703197288;9479.668211612561;8893.421927574687;8957.462552246887;9004.63981440735;9080.909190908007;9099.909000910038;2717.877695503707;2737.438825040862;2778.8054836161677;2779.6942336342986;2788.8745006474755;945.1446440970932;958.678842587741;963.3738070254391;969.1762002297991;978.471625322318;19099.522511937314;19469.610607788047;19488.610227795365;19549.120289587;19642.21431142767;1010.8122955527373;1016.8779746430475;1018.2617602238317;1030.3766221435924;1039.5581877702098;10195.439250841275;10424.166066714644;10507.211959102944;10556.683299501028;10576.682699519026;457699;466123;468274;473589;478679;117444;118285;123211.38394307971;123932.38033809773;126281;1031.2626472072504;1075.5482697267166;1092.4428541443922;1101.251149218539;1129.5989923577176;19732.802671973095;19756.604867902275;19897.303594374127;20226.39320820378;20455.28406505765;56393.436065638816;58235.417645823;58569.70715146397;59395.218143455764;59792.40207597868;70567.64716176386;70615;70707.64646176736;71130;71388;13978.930105349815;14358.928205358907;14376.424943002163;14488.565343039725;14544.127352358892;20579;21624.243151489623;22054.448638784157;22281.665775013065;22420.775792242523;17412.82587174163;18173.727394089365;18285.725714114564;18305.450836474927;18314.45056648303;15144.242787860783;16065;16332.836671633608;16656.41702540405;16827.747583786007;18320.26718931228;18428.078596070412;18516.907415462836;18528.07359631986;18677.439676809718;14029.158250505003;14071.577852664437;14128.50550230737;14135.575932722035;14207.928960355131;17744.46766597004;17839.910800445916;17850.19674114642;17976.550586235448;18122.550195984553 17:14:58 INFO - PID 4932 | |3;mootools.html;1299.2853930338315;1363.4116254563435;1365.0512893538994;1366.9384877680504;1374.869387408197;14087.788683169747;14566.781498277534;15239.92380038101;15305.464308749197;15560.455384061546;14968.550943471686;15229.923850380761;15258.237088145575;15266.465673701423;15281.312340944656;2674.1710069878304;2737.603047558103;2739.6986331503517;2744.286485513771;2744.8490333031773;2680.8391496510176;2838.730320619538;2841.0908509277037;2857.942561252329;2868.19690486663;2750.766184874278;2758.3242105684135;2773.4314465534517;2774.0429551804596;2776.7362100600412;2728.959065614017;2735.042735042739;2754.986225068872;2772.334639686481;2786.3730660601304;2677.718839521842;2694.5032134445705;2704.148193319098;2719.524083285417;2719.5376785946437;13941.233232172226;14082.436702531886;14214.502492412716;14287.071340362947;14313;7664.616769161576;7920.80197995049;7946.6424010919645;7949;8003.279704826536;5307.522322990911;5360.338295128523;5415.566754659618;5558.777648894039;5602.299712535933;1929.5658476842739;1948.6979518174705;1977.3178253502663;1989.2838578111869;1996.4908948218113;24429.877850610632;24648.630270545957;24785.380365490826;24916.003359865583;25107.497850042895;6462.644554549545;6749.93250067493;6791;6836.623985680835;6980.371766541036;16526.091064991302;16533;16653.33386664544;16672.916635416987;16719.16404179786;7726.343260822893;7821.804454888559;7868.370530357558;7898.131205567383;7930.484518506279;7184.928150718531;7259.854802904018;7393.223711510214;7434.516756410924;7479.925200748032;5082.2122571001555;5239.292695486137;5266.4996825302305;5267.631265811433;5273.890443822502;1495.7681559358316;1508.4117194294233;1512.2665507228985;1532.7930729351617;1548.2181498343489;860.767592749954;897.4211633496358;918.2195134136065;922.6032805893531;927.0405130689704;7486.13909400415;7516.849663006709;8221.424500284922;8630.352723545633;8632.309415246766;695.7321431248904;710.1052673631261;720.121451828768;732.2896790113688;739.0244876762729;4622.768861556909;4682.461516925598;4683.484816670163;4708;4764.094821983881;19028;20201;20314.593708125754;20357.287494937606;20358.18567257323;18997.715034274497;19459.51351216231;19650.508737281398;19723.802761972198;19753.50616234577;10990.395528245863;11032.117430605533;11059.170562207866;11287.774244515227;11447.313161210353;8133.34933205354;8206.261436470746;8246.134155913544;8335.374846886387;8354.331653467587;16925.492235232963;17159.31362745476;17658.82341176572;17707.557311067325;18207.90896045511;17992.10039498046;17999.10004499796;18084.54788630295;18346.633067338844;18489.72265416047;10611.31026483276;10852.186086043735;10856.294340867818;10867.565297388015;10868.782624347627;12942.935285323512;13219;13275.867241327463;13320.666983325495;13331;10368.066873981377;10812.837807432737;10816.08063314627;10929.83605245906;11083.33499989971;10652.360858348524;10784.406857622593;10967.945160274148;10977.725556861142;10984.231103822656;9692.612295508383;9776;9999.20006399501;10006.249531285328;10009.149222316184;7004.509684322048;7056.6118863463;7056.7530136444975;7070.222275549582;7092.04257425241;7183.640817959185;7202.747903823341;7296.817579560341;7387.482876198615;7388 17:14:58 INFO - PID 4932 | |4;prototype.html;512.7337169709882;525.3328273093174;532.2774010934072;534.3861538154773;537.4303238567117;6204.813855584329;6287.2710004748715;6317.52618553608;6336.9683151584295;6345.175127233465;6093.329733729297;6201.046670298864;6210.378962103799;6210.5342099342615;6250.156228909096;5116.1302578561545;5153.304303918979;5204.739763011853;5228.294180285669;5235.685858848481;5149.40781810091;5218.243354713564;5220.843374698765;5231.3259756877815;5251.606129540281;4778.593819525345;4963.305137280766;4970.527799859007;5001.324821149153;5117.181250999841;4907.2639104134305;4919.056972495844;4969.62727795415;4973.353464049686;4997.900041999158;4414.271645178574;4450.821967121311;4480.708753930984;4514.45826500822;4528.615067719248;5851.561132915049;5995.880082398371;6061.787837425713;6138.8772224555705;6147.446729794296;5645.802396916089;5679.119736440858;5680.318361796611;5694.117411801178;5713.057345537981;6414.679266036726;6423.261324947597;6465.256495502983;6539.64031978241;6548.508861835381;4849.272609108627;4868.464468908417;4887.633427492952;4908.705477671351;4916.164252077156;6600.4389626881775;6642.169728783902;6660.86852207289;6694.93305066948;6695.665216739192;4972.825951091694;5006.424261209934;5017.422996355393;5053.494650534991;5058.367704036996;5085.771140298695;5094.439611642791;5099.617528685363;5112.951844871793;5132.204508301219;5598.412166722517;5665.235193248858;5680.801171959044;5681.431856814285;5720.771169153188;6533;6572.14562106923;6573.309802470767;6610.7025183866845;6660.83347916306;1751.824817518238;1754.5701303180801;1761.5419990802484;1763.1096296370508;1774.8846324988835;1182.633383651071;1220.2190598017276;1233.9814902776466;1237.307108019512;1242.8943539799218;5602.1036634139155;5656.519195868315;5657.773689052392;5662.686104992986;5685.516731077904;6543.509236807258;6565.80302590923;6573.868522629617;6595.274519802818;6621.020540756679;5529.695866727368;5590.97204513983;5597.160425936061;5598.58010649203;5680.68756218412;3422.4695172247843;3492.196794737174;3516.4725291206523;3516.771409858351;3518.5249991251367;6185.381461853869;6279.96860015697;6332.525060620472;6361.395667411589;6379.71291291893;6354.459870911024;6649.168853893263;6692.122387373379;6736.5958042517605;6821.249662537117;6266.021076616382;6318.704665543644;6324.272708638474;6335.606166643515;6408;6625.4037136657935;6635.469162467088;6682.766103186365;6688.2276196806915;6712.49656275791;6519.7392104315295;6577.835554111186;6579.638119903451;6622.602643841385;6665.400113989765;6383.616982981036;6452.22573291208;6488.156539649815;6503.2196136462035;6503.219613646393;4919.852404427873;4921.212605983025;4973.577245934136;4975.0547395994645;4985.975070124626;6387.936120638734;6611.471082313307;6623.735050597922;6636.535442518977;6658.700358483783;6121.663308518075;6364.904526432015;6371.171747672773;6376.840578985562;6419.165508483868;6368.331325210971;6405.679716014274;6449.645269510222;6462.386073323027;6486.708098135501;6409.198850143732;6413.775517856852;6421.743130274736;6470.6441145737435;6527;6464.8707025858275;6471;6506.772262970773;6529.444997175293;6549.574277671936;6153.292371377349;6232.563720539519;6333.271673757393;6350.142730731292;6354.90467642995 17:14:58 INFO - PID 4932 | |5;yui.html;903.5256490342565;910.6994691751722;939.6523286384039;941.9434833909966;946.3233787841692;18660.720089198658;19212.90393548032;19218;19252.518687032814;19319.227230910747;16750.413735519258;16875.928714609123;17159.57101072474;18405.26378944844;18900.243990240375;970.7281961050882;976.3409698453551;976.4385478349959;980.0836218136066;983.4345251480391;963.3593660215948;968.1045033344163;972.8832540095199;973.095021629884;978.0806042320196;999.9950000250025;1021.254484226515;1025.5948900184424;1040.3549799124517;1042.681981995491;1019.50553981319;1024.2778840917135;1025.5026312238558;1031.587365053977;1033.8035773203067;721.0482163544124;750.4371721209093;750.8685979953486;752.5334292738482;755.1806290175167;19330.226790928347;19356.4193074208;19360.903195484072;19384.418467445998;19441.708374374397;21273.68089478659;21408.46478838026;22480.662790058162;22551.661725074136;22772.20297289587;17285.740713889303;17695.115244237735;17702.91148544262;17703.468895933143;17822.287108515775;3771.358868992278;3788.3749181385037;3792.336341140317;3805.086779173006;3807.733458657895;136531.31734341363;140342.99999999898;141816.29091854577;142846;145626;16300.755488667679;16666;16674.082925438976;16699.165041747863;16825;31055;31280;31478.842605786824;31702.682973170435;32112;8666.306695464347;8857.424267422597;8916.955415222883;8917.777055573662;8920.197182253629;4179.937300940488;4198.349255865346;4204.07510347723;4256.063665993476;4275.016746148403;4938.530839570235;5098.260752190911;5153.227015947563;5160.767765450564;5204.557612602971;1025.6102680981328;1064.5582083435288;1068.1614932278123;1079.5088234853124;1085.2565992295304;658.6673729766437;680.8910574308087;688.4629988608893;688.5765254368628;689.2452764223168;11596.304221746723;11810.713341547118;11935.403229838474;12809.679758005937;13138.474461021453;674.8211723893172;677.3362105136895;677.461418172554;682.7507959594712;692.6121372031578;5706.771729130788;5895.528357731371;5906.379830117776;5910.8817823643285;5995.61028533144;126724.36637816751;129711;131268.343658283;131815.3409232967;137047.94428083586;109804.4509777446;110051;110368;112399.87600124057;113940;95221.0477895226;95413;97569.51215243878;99381;100414;10895.836562451728;10934;11049.83425248638;11061;11250.94374528155;44035;45942.85142871321;46734.76632616815;46969.53030469651;47335.52664473449;60663.69668151631;60675;60703.69648151731;60857.39142608694;60948;14822.703545929236;14947.626309342353;14967;15008.474703385766;15201.391944322104;16701.5824604381;16819.495415137564;16885;16999.745003824704;17127.314907404063;15328.540143795704;15823.68352632964;15832.60418489547;15865.920670396574;16071;14308.785368219276;14340.56978290653;14398.352074156897;14543.909206809743;14567;14144.717105658036;14233.50182743599;14264.429422823387;14322.069065510708;14438.711225775636;10939.945300273448;10990.780184396428;11063.834042489209;11135;11220.775584488429;10431.63489277902;10531.315464494783;10689.839652405375;10777.46112694378;10895.78208435811 17:14:58 INFO - PID 4932 | __end_tp_report 17:14:58 INFO - PID 4932 | __start_cc_report 17:14:58 INFO - PID 4932 | _x_x_mozilla_cycle_collect,295 17:14:58 INFO - PID 4932 | __end_cc_report 17:14:58 INFO - PID 4932 | __startTimestamp1506816898961__endTimestamp 17:14:58 INFO - PID 4932 | 17:14:58 INFO - PID 4932 | ------- Summary: start ------- 17:14:58 INFO - PID 4932 | Number of tests: 6 17:14:58 INFO - PID 4932 | 17:14:58 INFO - PID 4932 | [#0] dojo.html Cycles:165 Average:6064.48 Median:6368.46 stddev:833.78 (13.1%) stddev-sans-first:804.56 17:14:58 INFO - PID 4932 | Values: 3158.1 3181.1 3186.9 3192.9 3204.1 6046.5 6166.1 6202.5 6212.7 6229.1 6114.3 6117.6 6169.2 6171.9 6173.4 5675.8 5695.5 5714.3 5724.3 5825.6 5748.0 5771.8 5776.2 5839.1 5868.6 749.1 5591.4 5715.9 5770.4 5775.9 5581.7 5644.6 5717.3 5766.7 5779.1 5673.8 5676.6 5723.4 5742.2 5760.9 6091.5 6136.1 6247.8 6266.7 6290.8 6510.7 6593.2 6617.6 6641.0 6713.5 6597.8 6616.5 6653.2 6756.4 6774.5 5915.9 6044.5 6115.1 6133.0 6239.7 6792.8 6802.3 6802.6 6882.1 6889.1 6525.2 6527.4 6565.7 6604.2 6622.1 6651.5 6656.5 6715.5 6728.6 6749.2 6361.6 6506.8 6563.4 6641.7 6703.0 6489.7 6570.2 6574.6 6577.6 6591.5 5102.2 5141.5 5145.6 5157.0 5157.0 4491.1 4533.3 4540.2 4552.6 4555.8 5575.4 5581.3 5654.3 5670.1 5713.4 6603.7 6641.8 6678.2 6693.7 6749.4 5687.7 5713.1 5730.7 5736.9 5746.5 5631.3 5681.5 5733.7 5734.2 5737.9 6306.1 6326.7 6431.0 6449.3 6457.6 6405.4 6577.7 6599.3 6620.8 6720.5 6368.5 6382.0 6387.9 6391.2 6401.8 6435.4 6452.8 6516.5 6527.3 6547.5 6626.9 6638.3 6662.5 6666.5 6685.6 6452.5 6476.1 6534.6 6542.8 6546.7 6261.1 6334.7 6382.3 6432.0 6443.2 6311.5 6386.9 6461.3 6475.1 6482.3 6472.8 6496.5 6499.2 6562.4 6625.1 6361.6 6361.8 6379.4 6387.9 6428.0 17:14:58 INFO - PID 4932 | 17:14:58 INFO - PID 4932 | [#1] ext.html Cycles:180 Average:37584.87 Median:34004.07 stddev:55125.70 (162.1%) stddev-sans-first:55211.46 17:14:58 INFO - PID 4932 | Values: 883.1 896.6 897.8 899.0 900.3 37712.2 40807.2 40911.4 41030.8 41139.6 37876.2 38704.4 38717.0 38737.6 38758.0 7204.7 7305.2 7325.5 7334.1 7348.2 7088.1 7234.9 7244.5 7252.8 7253.6 7200.2 7261.6 7315.5 7759.9 8012.9 7903.0 7915.6 7963.0 7978.7 7979.4 7878.4 7954.2 7973.5 7976.7 7982.8 37362.1 37516.0 37674.0 37706.6 37795.2 3583.8 3596.0 3598.7 3620.8 3642.8 31261.2 31675.0 31837.8 31904.8 31905.0 5081.7 5086.0 5141.5 5161.9 5162.6 197428.0 198977.0 199147.0 199489.0 200648.0 42227.8 42808.8 43093.0 47887.0 48758.5 52262.7 52851.0 52943.2 53032.5 53037.5 15787.9 15959.4 15967.9 15981.8 15985.0 13088.9 13139.7 13159.1 13198.0 13222.8 14375.6 14457.9 14502.9 14526.0 14542.9 5765.2 5825.9 5889.9 5896.3 5950.3 984.5 1008.0 1015.0 1032.3 1035.5 22974.5 23119.0 23176.5 23280.3 23423.1 1111.6 1125.9 1129.2 1129.8 1132.8 12000.6 12204.0 12293.0 12348.7 12371.8 236530.0 237754.0 238555.0 238975.0 239243.0 52552.7 52973.2 53061.2 53139.7 53497.2 1406.5 1484.6 1490.5 1491.5 1504.1 22445.6 22528.9 22677.3 22797.9 23033.9 36734.0 36992.3 37007.0 37140.3 37252.6 196227.0 197712.0 198110.0 198846.0 199166.0 29671.7 30161.2 32541.0 32739.7 32875.3 41727.0 41816.0 42049.0 42148.0 42509.4 30590.0 30677.2 30916.8 31269.4 31415.7 30101.0 30672.4 30903.8 30945.4 31116.5 33901.2 33924.7 34083.5 34240.7 34552.0 29476.3 29530.1 30094.7 30399.5 30656.0 22816.3 23233.2 23298.5 23603.5 23748.9 17:14:58 INFO - PID 4932 | 17:14:58 INFO - PID 4932 | [#2] jquery.html Cycles:180 Average:34237.81 Median:23192.42 stddev:79450.50 (342.6%) stddev-sans-first:79633.16 17:14:58 INFO - PID 4932 | Values: 569.6 571.5 581.2 586.9 603.3 22331.8 23171.7 23213.2 23242.3 23248.9 23969.9 24771.4 24953.9 25010.0 25185.4 6520.4 6719.0 6726.6 6740.9 6773.3 6633.7 6730.9 6735.4 6737.3 6740.1 6322.2 6566.5 6600.0 6629.0 6642.5 6563.4 6593.9 6600.7 6601.0 6608.9 5861.5 6130.4 6148.9 6178.2 6180.9 27996.2 28117.9 28232.0 28645.1 28687.4 2066.6 2083.9 2086.2 2093.7 2097.7 18726.7 19335.2 19403.4 19660.2 19770.0 2479.7 2492.3 2547.3 2548.8 2558.5 127220.4 132397.0 132867.0 133121.3 150567.0 14526.9 14720.6 14833.0 15015.7 15415.0 23702.0 23764.4 23777.4 23792.0 23842.5 9883.9 10017.5 10139.7 10147.4 10210.7 9314.7 9358.7 9416.5 9457.3 9479.7 8893.4 8957.5 9004.6 9080.9 9099.9 2717.9 2737.4 2778.8 2779.7 2788.9 945.1 958.7 963.4 969.2 978.5 19099.5 19469.6 19488.6 19549.1 19642.2 1010.8 1016.9 1018.3 1030.4 1039.6 10195.4 10424.2 10507.2 10556.7 10576.7 457699.0 466123.0 468274.0 473589.0 478679.0 117444.0 118285.0 123211.4 123932.4 126281.0 1031.3 1075.5 1092.4 1101.3 1129.6 19732.8 19756.6 19897.3 20226.4 20455.3 56393.4 58235.4 58569.7 59395.2 59792.4 70567.6 70615.0 70707.6 71130.0 71388.0 13978.9 14358.9 14376.4 14488.6 14544.1 20579.0 21624.2 22054.4 22281.7 22420.8 17412.8 18173.7 18285.7 18305.5 18314.5 15144.2 16065.0 16332.8 16656.4 16827.7 18320.3 18428.1 18516.9 18528.1 18677.4 14029.2 14071.6 14128.5 14135.6 14207.9 17744.5 17839.9 17850.2 17976.6 18122.6 17:14:58 INFO - PID 4932 | 17:14:58 INFO - PID 4932 | [#3] mootools.html Cycles:180 Average:8998.09 Median:2699.33 stddev:6228.90 (230.8%) stddev-sans-first:6219.51 17:14:58 INFO - PID 4932 | Values: 1299.3 1363.4 1365.1 1366.9 1374.9 14087.8 14566.8 15239.9 15305.5 15560.5 14968.6 15229.9 15258.2 15266.5 15281.3 2674.2 2737.6 2739.7 2744.3 2744.8 2680.8 2838.7 2841.1 2857.9 2868.2 2750.8 2758.3 2773.4 2774.0 2776.7 2729.0 2735.0 2755.0 2772.3 2786.4 2677.7 2694.5 2704.1 2719.5 2719.5 13941.2 14082.4 14214.5 14287.1 14313.0 7664.6 7920.8 7946.6 7949.0 8003.3 5307.5 5360.3 5415.6 5558.8 5602.3 1929.6 1948.7 1977.3 1989.3 1996.5 24429.9 24648.6 24785.4 24916.0 25107.5 6462.6 6749.9 6791.0 6836.6 6980.4 16526.1 16533.0 16653.3 16672.9 16719.2 7726.3 7821.8 7868.4 7898.1 7930.5 7184.9 7259.9 7393.2 7434.5 7479.9 5082.2 5239.3 5266.5 5267.6 5273.9 1495.8 1508.4 1512.3 1532.8 1548.2 860.8 897.4 918.2 922.6 927.0 7486.1 7516.8 8221.4 8630.4 8632.3 695.7 710.1 720.1 732.3 739.0 4622.8 4682.5 4683.5 4708.0 4764.1 19028.0 20201.0 20314.6 20357.3 20358.2 18997.7 19459.5 19650.5 19723.8 19753.5 10990.4 11032.1 11059.2 11287.8 11447.3 8133.3 8206.3 8246.1 8335.4 8354.3 16925.5 17159.3 17658.8 17707.6 18207.9 17992.1 17999.1 18084.5 18346.6 18489.7 10611.3 10852.2 10856.3 10867.6 10868.8 12942.9 13219.0 13275.9 13320.7 13331.0 10368.1 10812.8 10816.1 10929.8 11083.3 10652.4 10784.4 10967.9 10977.7 10984.2 9692.6 9776.0 9999.2 10006.2 10009.1 7004.5 7056.6 7056.8 7070.2 7092.0 7183.6 7202.7 7296.8 7387.5 7388.0 17:14:58 INFO - PID 4932 | 17:14:58 INFO - PID 4932 | [#4] prototype.html Cycles:180 Average:5467.19 Median:6143.16 stddev:1509.21 (24.6%) stddev-sans-first:1466.91 17:14:58 INFO - PID 4932 | Values: 512.7 525.3 532.3 534.4 537.4 6204.8 6287.3 6317.5 6337.0 6345.2 6093.3 6201.0 6210.4 6210.5 6250.2 5116.1 5153.3 5204.7 5228.3 5235.7 5149.4 5218.2 5220.8 5231.3 5251.6 4778.6 4963.3 4970.5 5001.3 5117.2 4907.3 4919.1 4969.6 4973.4 4997.9 4414.3 4450.8 4480.7 4514.5 4528.6 5851.6 5995.9 6061.8 6138.9 6147.4 5645.8 5679.1 5680.3 5694.1 5713.1 6414.7 6423.3 6465.3 6539.6 6548.5 4849.3 4868.5 4887.6 4908.7 4916.2 6600.4 6642.2 6660.9 6694.9 6695.7 4972.8 5006.4 5017.4 5053.5 5058.4 5085.8 5094.4 5099.6 5113.0 5132.2 5598.4 5665.2 5680.8 5681.4 5720.8 6533.0 6572.1 6573.3 6610.7 6660.8 1751.8 1754.6 1761.5 1763.1 1774.9 1182.6 1220.2 1234.0 1237.3 1242.9 5602.1 5656.5 5657.8 5662.7 5685.5 6543.5 6565.8 6573.9 6595.3 6621.0 5529.7 5591.0 5597.2 5598.6 5680.7 3422.5 3492.2 3516.5 3516.8 3518.5 6185.4 6280.0 6332.5 6361.4 6379.7 6354.5 6649.2 6692.1 6736.6 6821.2 6266.0 6318.7 6324.3 6335.6 6408.0 6625.4 6635.5 6682.8 6688.2 6712.5 6519.7 6577.8 6579.6 6622.6 6665.4 6383.6 6452.2 6488.2 6503.2 6503.2 4919.9 4921.2 4973.6 4975.1 4986.0 6387.9 6611.5 6623.7 6636.5 6658.7 6121.7 6364.9 6371.2 6376.8 6419.2 6368.3 6405.7 6449.6 6462.4 6486.7 6409.2 6413.8 6421.7 6470.6 6527.0 6464.9 6471.0 6506.8 6529.4 6549.6 6153.3 6232.6 6333.3 6350.1 6354.9 17:14:58 INFO - PID 4932 | 17:14:58 INFO - PID 4932 | [#5] yui.html Cycles:180 Average:24723.55 Median:19056.57 stddev:36615.46 (192.1%) stddev-sans-first:36674.49 17:14:58 INFO - PID 4932 | Values: 903.5 910.7 939.7 941.9 946.3 18660.7 19212.9 19218.0 19252.5 19319.2 16750.4 16875.9 17159.6 18405.3 18900.2 970.7 976.3 976.4 980.1 983.4 963.4 968.1 972.9 973.1 978.1 1000.0 1021.3 1025.6 1040.4 1042.7 1019.5 1024.3 1025.5 1031.6 1033.8 721.0 750.4 750.9 752.5 755.2 19330.2 19356.4 19360.9 19384.4 19441.7 21273.7 21408.5 22480.7 22551.7 22772.2 17285.7 17695.1 17702.9 17703.5 17822.3 3771.4 3788.4 3792.3 3805.1 3807.7 136531.3 140343.0 141816.3 142846.0 145626.0 16300.8 16666.0 16674.1 16699.2 16825.0 31055.0 31280.0 31478.8 31702.7 32112.0 8666.3 8857.4 8917.0 8917.8 8920.2 4179.9 4198.3 4204.1 4256.1 4275.0 4938.5 5098.3 5153.2 5160.8 5204.6 1025.6 1064.6 1068.2 1079.5 1085.3 658.7 680.9 688.5 688.6 689.2 11596.3 11810.7 11935.4 12809.7 13138.5 674.8 677.3 677.5 682.8 692.6 5706.8 5895.5 5906.4 5910.9 5995.6 126724.4 129711.0 131268.3 131815.3 137047.9 109804.5 110051.0 110368.0 112399.9 113940.0 95221.0 95413.0 97569.5 99381.0 100414.0 10895.8 10934.0 11049.8 11061.0 11250.9 44035.0 45942.9 46734.8 46969.5 47335.5 60663.7 60675.0 60703.7 60857.4 60948.0 14822.7 14947.6 14967.0 15008.5 15201.4 16701.6 16819.5 16885.0 16999.7 17127.3 15328.5 15823.7 15832.6 15865.9 16071.0 14308.8 14340.6 14398.4 14543.9 14567.0 14144.7 14233.5 14264.4 14322.1 14438.7 10939.9 10990.8 11063.8 11135.0 11220.8 10431.6 10531.3 10689.8 10777.5 10895.8 17:14:58 INFO - PID 4932 | -------- Summary: end -------- 17:14:58 INFO - PID 4932 | 17:14:59 INFO - TEST-INFO | 4932: exit 0 17:14:59 INFO - TEST-OK | dromaeo_css | took 1111911ms 17:14:59 INFO - TEST-START | kraken 17:14:59 INFO - Initialising browser for kraken test... 17:14:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51106/getInfo.html -profile /tmp/tmp0_IL4p/profile 17:14:59 INFO - TEST-INFO | started process 5303 (/builds/slave/test/build/application/firefox/firefox http://localhost:51106/getInfo.html) 17:15:05 INFO - TEST-INFO | 5303: exit 0 17:15:05 INFO - Browser initialized. 17:15:05 INFO - Running cycle 1/1 for kraken test... 17:15:05 INFO - Using env: {'DISPLAY': ':0', 17:15:05 INFO - 'HOME': '/home/cltbld', 17:15:05 INFO - 'JSGC_DISABLE_POISONING': '1', 17:15:05 INFO - 'LANG': 'en_US.UTF-8', 17:15:05 INFO - 'LANGUAGE': 'en_US:en', 17:15:05 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:15:05 INFO - 'LOGNAME': 'cltbld', 17:15:05 INFO - 'MAIL': '/var/mail/cltbld', 17:15:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:15:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:15:05 INFO - 'MOZ_ACCELERATED': '1', 17:15:05 INFO - 'MOZ_CRASHREPORTER': '1', 17:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:05 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:15:05 INFO - 'MOZ_NO_REMOTE': '1', 17:15:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:15:05 INFO - 'MOZ_WEBRENDER': '1', 17:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:05 INFO - 'NO_EM_RESTART': '1', 17:15:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:05 INFO - 'PWD': '/builds/slave/test', 17:15:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:15:05 INFO - 'RUST_BACKTRACE': 'full', 17:15:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:15:05 INFO - 'SHELL': '/bin/bash', 17:15:05 INFO - 'SHLVL': '1', 17:15:05 INFO - 'TERM': 'linux', 17:15:05 INFO - 'TMOUT': '86400', 17:15:05 INFO - 'USER': 'cltbld', 17:15:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283', 17:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:05 INFO - '_': '/tools/buildbot/bin/python'} 17:15:05 INFO - TEST-INFO | started process 5551 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0_IL4p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:06 INFO - PID 5551 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:15:06 INFO - PID 5551 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:15:06 INFO - PID 5551 | 17:15:06 INFO - PID 5551 | (/builds/slave/test/build/application/firefox/firefox:5610): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:15:06 INFO - PID 5551 | 17:15:16 INFO - PID 5551 | RSS: Main: 198389760 17:15:16 INFO - PID 5551 | 17:15:19 INFO - PID 5551 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51106/tests/kraken/driver.html?testName=audio-beat-detection) 17:15:20 INFO - PID 5551 | RSS: Main: 195198976 17:15:20 INFO - PID 5551 | 17:15:23 INFO - PID 5551 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51106/tests/kraken/driver.html?testName=audio-dft) 17:15:23 INFO - PID 5551 | RSS: Main: 195375104 17:15:23 INFO - PID 5551 | 17:15:26 INFO - PID 5551 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51106/tests/kraken/driver.html?testName=audio-fft) 17:15:27 INFO - PID 5551 | RSS: Main: 192761856 17:15:27 INFO - PID 5551 | 17:15:29 INFO - PID 5551 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51106/tests/kraken/driver.html?testName=audio-oscillator) 17:15:30 INFO - PID 5551 | RSS: Main: 192684032 17:15:30 INFO - PID 5551 | 17:15:32 INFO - PID 5551 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51106/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:15:33 INFO - PID 5551 | RSS: Main: 192782336 17:15:33 INFO - PID 5551 | 17:15:36 INFO - PID 5551 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51106/tests/kraken/driver.html?testName=imaging-darkroom) 17:15:37 INFO - PID 5551 | RSS: Main: 194920448 17:15:37 INFO - PID 5551 | 17:15:40 INFO - PID 5551 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51106/tests/kraken/driver.html?testName=imaging-desaturate) 17:15:41 INFO - PID 5551 | RSS: Main: 194260992 17:15:41 INFO - PID 5551 | 17:15:44 INFO - PID 5551 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51106/tests/kraken/driver.html?testName=json-parse-financial) 17:15:45 INFO - PID 5551 | RSS: Main: 195100672 17:15:45 INFO - PID 5551 | 17:15:46 INFO - PID 5551 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51106/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:15:47 INFO - PID 5551 | RSS: Main: 195690496 17:15:47 INFO - PID 5551 | 17:15:48 INFO - PID 5551 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51106/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:15:49 INFO - PID 5551 | RSS: Main: 192786432 17:15:49 INFO - PID 5551 | 17:15:51 INFO - PID 5551 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51106/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:15:52 INFO - PID 5551 | RSS: Main: 192585728 17:15:52 INFO - PID 5551 | 17:15:54 INFO - PID 5551 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:15:55 INFO - PID 5551 | RSS: Main: 193007616 17:15:55 INFO - PID 5551 | 17:15:58 INFO - PID 5551 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:15:59 INFO - PID 5551 | RSS: Main: 192847872 17:15:59 INFO - PID 5551 | 17:16:00 INFO - PID 5551 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51106/tests/kraken/driver.html?testName=ai-astar) 17:16:01 INFO - PID 5551 | RSS: Main: 193822720 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | __start_tp_report 17:16:01 INFO - PID 5551 | _x_x_mozilla_page_load 17:16:01 INFO - PID 5551 | _x_x_mozilla_page_load_details 17:16:01 INFO - PID 5551 | |i|pagename|runs| 17:16:01 INFO - PID 5551 | |0;ai-astar;111;115;110;113;107;111;117;112;110;109 17:16:01 INFO - PID 5551 | |1;audio-beat-detection;119;118;125;122;117;127;116;122;115;145 17:16:01 INFO - PID 5551 | |2;audio-dft;170;170;166;167;170;164;164;168;168;164 17:16:01 INFO - PID 5551 | |3;audio-fft;89;77;83;74;83;82;82;84;84;76 17:16:01 INFO - PID 5551 | |4;audio-oscillator;81;82;84;78;83;88;78;79;81;79 17:16:01 INFO - PID 5551 | |5;imaging-gaussian-blur;121;112;111;111;111;112;126;118;117;119 17:16:01 INFO - PID 5551 | |6;imaging-darkroom;148;151;150;148;148;147;149;164;149;155 17:16:01 INFO - PID 5551 | |7;imaging-desaturate;94;100;94;97;102;95;101;98;97;95 17:16:01 INFO - PID 5551 | |8;json-parse-financial;55;56;51;50;52;51;58;51;52;50 17:16:01 INFO - PID 5551 | |9;json-stringify-tinderbox;42;45;37;48;37;41;40;37;47;46 17:16:01 INFO - PID 5551 | |10;stanford-crypto-aes;76;75;76;76;74;75;78;73;77;79 17:16:01 INFO - PID 5551 | |11;stanford-crypto-ccm;115;111;120;111;126;108;111;113;117;111 17:16:01 INFO - PID 5551 | |12;stanford-crypto-pbkdf2;176;164;168;168;167;168;181;168;176;169 17:16:01 INFO - PID 5551 | |13;stanford-crypto-sha256-iterative;64;63;63;64;74;66;69;70;63;67 17:16:01 INFO - PID 5551 | __end_tp_report 17:16:01 INFO - PID 5551 | __start_cc_report 17:16:01 INFO - PID 5551 | _x_x_mozilla_cycle_collect,738 17:16:01 INFO - PID 5551 | __end_cc_report 17:16:01 INFO - PID 5551 | __startTimestamp1506816961235__endTimestamp 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | ------- Summary: start ------- 17:16:01 INFO - PID 5551 | Number of tests: 14 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.50 stddev:2.92 (2.6%) stddev-sans-first:3.09 17:16:01 INFO - PID 5551 | Values: 111.0 115.0 110.0 113.0 107.0 111.0 117.0 112.0 110.0 109.0 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | [#1] audio-beat-detection Cycles:10 Average:122.60 Median:122.00 stddev:8.78 (7.2%) stddev-sans-first:9.22 17:16:01 INFO - PID 5551 | Values: 119.0 118.0 125.0 122.0 117.0 127.0 116.0 122.0 115.0 145.0 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | [#2] audio-dft Cycles:10 Average:167.10 Median:168.00 stddev:2.51 (1.5%) stddev-sans-first:2.44 17:16:01 INFO - PID 5551 | Values: 170.0 170.0 166.0 167.0 170.0 164.0 164.0 168.0 168.0 164.0 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | [#3] audio-fft Cycles:10 Average:81.40 Median:83.00 stddev:4.48 (5.4%) stddev-sans-first:3.81 17:16:01 INFO - PID 5551 | Values: 89.0 77.0 83.0 74.0 83.0 82.0 82.0 84.0 84.0 76.0 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:81.50 stddev:3.13 (3.8%) stddev-sans-first:3.32 17:16:01 INFO - PID 5551 | Values: 81.0 82.0 84.0 78.0 83.0 88.0 78.0 79.0 81.0 79.0 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:117.50 stddev:5.22 (4.4%) stddev-sans-first:5.19 17:16:01 INFO - PID 5551 | Values: 121.0 112.0 111.0 111.0 111.0 112.0 126.0 118.0 117.0 119.0 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:149.50 stddev:5.13 (3.4%) stddev-sans-first:5.33 17:16:01 INFO - PID 5551 | Values: 148.0 151.0 150.0 148.0 148.0 147.0 149.0 164.0 149.0 155.0 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:95.00 stddev:2.91 (3.1%) stddev-sans-first:2.83 17:16:01 INFO - PID 5551 | Values: 94.0 100.0 94.0 97.0 102.0 95.0 101.0 98.0 97.0 95.0 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:52.00 stddev:2.76 (5.3%) stddev-sans-first:2.78 17:16:01 INFO - PID 5551 | Values: 55.0 56.0 51.0 50.0 52.0 51.0 58.0 51.0 52.0 50.0 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | [#9] json-stringify-tinderbox Cycles:10 Average:42.00 Median:43.50 stddev:4.29 (9.9%) stddev-sans-first:4.56 17:16:01 INFO - PID 5551 | Values: 42.0 45.0 37.0 48.0 37.0 41.0 40.0 37.0 47.0 46.0 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:76.00 stddev:1.79 (2.4%) stddev-sans-first:1.90 17:16:01 INFO - PID 5551 | Values: 76.0 75.0 76.0 76.0 74.0 75.0 78.0 73.0 77.0 79.0 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | [#11] stanford-crypto-ccm Cycles:10 Average:114.30 Median:114.00 stddev:5.40 (4.7%) stddev-sans-first:5.72 17:16:01 INFO - PID 5551 | Values: 115.0 111.0 120.0 111.0 126.0 108.0 111.0 113.0 117.0 111.0 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:168.50 stddev:5.30 (3.1%) stddev-sans-first:5.23 17:16:01 INFO - PID 5551 | Values: 176.0 164.0 168.0 168.0 167.0 168.0 181.0 168.0 176.0 169.0 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:3.71 (5.6%) stddev-sans-first:3.84 17:16:01 INFO - PID 5551 | Values: 64.0 63.0 63.0 64.0 74.0 66.0 69.0 70.0 63.0 67.0 17:16:01 INFO - PID 5551 | -------- Summary: end -------- 17:16:01 INFO - PID 5551 | 17:16:01 INFO - PID 5551 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:16:02 INFO - TEST-INFO | 5551: exit 0 17:16:02 INFO - TEST-OK | kraken | took 62420ms 17:16:02 INFO - SUITE-END | took 1174s 17:16:02 INFO - Completed test suite (00:19:34) 17:16:02 INFO - javascript benchmark 17:16:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8410.109892563403, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3158.0683698308994, 3181.077487528617, 3186.932377653486, 3192.9042128736132, 3204.0708194623553, 6046.455818976291, 6166.075088736692, 6202.5348098892655, 6212.65830379329, 6229.1279220909055, 6114.327423983358, 6117.5717699761035, 6169.16716243307, 6171.9382806171925, 6173.444390004899, 5675.772969081232, 5695.515881150107, 5714.342850572186, 5724.284464441945, 5825.621334613258, 5748.0, 5771.82684519463, 5776.220210271602, 5839.124131380306, 5868.618539794899, 749.058078130988, 5591.384947655754, 5715.9428405716035, 5770.365259821417, 5775.855603609902, 5581.748821303051, 5644.6330988485615, 5717.256756621654, 5766.731319109831, 5779.075347944308, 5673.801416950429, 5676.631018983753, 5723.399043100498, 5742.2247996520355, 5760.913586296167, 6091.482224010964, 6136.079588061782, 6247.750089996394, 6266.717997690115, 6290.811275661737, 6510.739570417178, 6593.241777195588, 6617.569857959217, 6640.966795166041, 6713.530052896299, 6597.769078082244, 6616.536842421033, 6653.168353955755, 6756.425703815182, 6774.5257831951785, 5915.852103697399, 6044.516438684895, 6115.143879856823, 6133.049377346519, 6239.719212635442, 6792.830179245559, 6802.319768023158, 6802.625855577891, 6882.105326307548, 6889.069975553336, 6525.21697396306, 6527.379898909596, 6565.704543295563, 6604.174478190226, 6622.072909792633, 6651.467882569383, 6656.500762442836, 6715.46276297895, 6728.596284222865, 6749.2238392584495, 6361.554691171574, 6506.804795856132, 6563.442107420828, 6641.734330626818, 6703.028060931235, 6489.740410383626, 6570.211574611078, 6574.572652777554, 6577.638229897401, 6591.472682185414, 5102.158143906214, 5141.537261646395, 5145.588352931756, 5156.9742151289, 5156.9742151289, 4491.079328737601, 4533.320001999727, 4540.205464043779, 4552.590266875997, 4555.794989225493, 5575.4424557544735, 5581.274434323512, 5654.264945557134, 5670.149477578314, 5713.4000929902595, 6603.7358505660195, 6641.767538136142, 6678.232003319583, 6693.732250710014, 6749.392554670103, 5687.7156142192725, 5713.143028545752, 5730.684812335361, 5736.885262294814, 5746.482816546531, 5631.267935168484, 5681.488666020078, 5733.741981610838, 5734.197212390269, 5737.913931291034, 6306.054091886162, 6326.746930122744, 6430.967845160744, 6449.258335291408, 6457.61254324742, 6405.423511883952, 6577.704003319958, 6599.340065993362, 6620.801375958633, 6720.529562930548, 6368.458681011981, 6381.968090159519, 6387.93612063892, 6391.2330520336, 6401.775937842153, 6435.388638079375, 6452.838679033061, 6516.478681705357, 6527.3472652734345, 6547.508936829661, 6626.900596491153, 6638.269790323157, 6662.500312476487, 6666.533342665967, 6685.63229022389, 6452.483801295791, 6476.06097115925, 6534.640594767334, 6542.803715888531, 6546.738130474918, 6261.060840873905, 6334.746610135728, 6382.329855365306, 6432.0, 6443.226812782309, 6311.463525600192, 6386.87226255463, 6461.289258181502, 6475.09348691193, 6482.254540727877, 6472.805815825533, 6496.545241833026, 6499.1551098358805, 6562.409383155539, 6625.105610742488, 6361.554691171574, 6361.777337793155, 6379.362063793769, 6387.872242555216, 6427.967860160669], "value": 6005.838219887362, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [883.1301168349177, 896.5606852642205, 897.7935074932765, 899.0425197165023, 900.3472482450225, 37712.245755084885, 40807.18385632286, 40911.38632920509, 41030.794846025805, 41139.58860411395, 37876.24247515048, 38704.41943370845, 38717.0, 38737.612623873756, 38758.0, 7204.711811527546, 7305.232950540197, 7325.523840950348, 7334.119905611307, 7348.228436014222, 7088.1494220693585, 7234.927650723478, 7244.492885498017, 7252.782416527512, 7253.601051942141, 7200.171980222289, 7261.564306141622, 7315.451341149408, 7759.88360174595, 8012.919870801305, 7902.960485197537, 7915.564643944581, 7963.0, 7978.720744773963, 7979.441439099265, 7878.4485086044, 7954.164812694699, 7973.481723687942, 7976.6809327626825, 7982.840343193162, 37362.065948351235, 37516.0, 37674.0, 37706.62293377059, 37795.24409511822, 3583.7849729016343, 3596.047047532406, 3598.730095242841, 3620.7646502977486, 3642.817859107034, 31261.218469538442, 31675.0, 31837.840810796028, 31904.84047579747, 31905.0, 5081.695098294114, 5086.0, 5141.537261646432, 5161.922571161435, 5162.586993040585, 197428.01285993622, 198977.0, 199147.0, 199489.0, 200648.0, 42227.788861055495, 42808.78595607002, 43093.0, 47887.0, 48758.5124148754, 52262.738686307086, 52851.03617228723, 52943.20585191225, 53032.469675303524, 53037.46962530325, 15787.894847360574, 15959.44141955026, 15967.920160399124, 15981.840181598267, 15985.040897546185, 13088.934555327163, 13139.67150821218, 13159.078864479587, 13198.0, 13222.801657975138, 14375.64060898465, 14457.92771036138, 14502.85497145036, 14526.0, 14542.854571454362, 5765.221695071112, 5825.941740582624, 5889.911651325234, 5896.262967129109, 5950.285965684146, 984.542187882638, 1007.9899201008043, 1014.9847752283722, 1032.339302846179, 1035.5236591167995, 22974.540509189723, 23118.959646815598, 23176.53646927052, 23280.3015909523, 23423.06307747671, 1111.5776005118164, 1125.898669119783, 1129.1926272714884, 1129.836173754801, 1132.7904337697553, 12000.63998080059, 12204.0, 12293.0, 12348.691282718004, 12371.75256494865, 236530.0, 237754.0, 238555.0, 238975.0, 239243.0, 52552.73723631357, 52973.205401919, 53061.2040819388, 53139.734301328244, 53497.1975420369, 1406.507722297188, 1484.621421537501, 1490.470882836599, 1491.507802425197, 1504.127605988524, 22445.5510889778, 22528.887355563773, 22677.319680409615, 22797.88601056984, 23033.88483057574, 36734.0, 36992.26015479729, 37007.0, 37140.257194856495, 37252.62747372492, 196227.0, 197712.0, 198110.0, 198846.0, 199166.0, 29671.703282966893, 30161.245968850955, 32541.02376928696, 32739.672603273662, 32875.34249315048, 41726.95682607959, 41816.0, 42049.0, 42148.0, 42509.36235956401, 30590.0, 30677.23306917345, 30916.845415773678, 31269.374612508076, 31415.68584314219, 30101.0, 30672.386552268385, 30903.845480772452, 30945.381092377575, 31116.53325200169, 33901.15247118842, 33924.66075339215, 34083.48874766831, 34240.657593424745, 34552.0, 29476.263093422836, 29530.114096577137, 30094.69905300919, 30399.54400684036, 30656.0, 22816.31551053471, 23233.18683846125, 23298.534029319657, 23603.52792944097, 23748.881255593613], "value": 17000.821218387115, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.5671289819736, 571.4742436958, 581.1950448628648, 586.870888404551, 603.2700432476704, 22331.776682233172, 23171.652425213593, 23213.18753843616, 23242.30273091808, 23248.883755581242, 23969.880150599267, 24771.380715482075, 24953.87523062382, 25010.0, 25185.370365740866, 6520.413162815334, 6719.0, 6726.596404215763, 6740.865182696343, 6773.288804675512, 6633.701483433257, 6730.899036514456, 6735.427488663469, 6737.2925842786535, 6740.1237839081095, 6322.241331040282, 6566.5075119366, 6599.9670001650165, 6628.966855165718, 6642.468602511812, 6563.442107420875, 6593.934060659404, 6600.735970561172, 6600.966995165018, 6608.9339106608795, 5861.472467477947, 6130.417610327012, 6148.8770224595255, 6178.165947597062, 6180.9381906180815, 27996.160115196577, 28117.85941070302, 28232.0, 28645.14064578066, 28687.426251475063, 2066.6486697261503, 2083.864548804338, 2086.1655337864822, 2093.675480300556, 2097.685347197917, 18726.719099213522, 19335.226590936345, 19403.4178974631, 19660.213591456326, 19770.0, 2479.7024357077084, 2492.2523243027017, 2547.299492639539, 2548.8215824892263, 2558.4883023395396, 127220.36389817992, 132397.0, 132867.0, 133121.33439332838, 150567.0, 14526.918456038855, 14720.55888223553, 14833.035852669758, 15015.699686006219, 15415.0, 23702.0, 23764.405889852547, 23777.40556486067, 23792.0, 23842.52314953691, 9883.901160988442, 10017.499125043718, 10139.695809125738, 10147.441890696082, 10210.744731381626, 9314.693283884259, 9358.719238422858, 9416.529173541296, 9457.290703197288, 9479.668211612561, 8893.421927574687, 8957.462552246887, 9004.63981440735, 9080.909190908007, 9099.909000910038, 2717.877695503707, 2737.438825040862, 2778.8054836161677, 2779.6942336342986, 2788.8745006474755, 945.1446440970932, 958.678842587741, 963.3738070254391, 969.1762002297991, 978.471625322318, 19099.522511937314, 19469.610607788047, 19488.610227795365, 19549.120289587, 19642.21431142767, 1010.8122955527373, 1016.8779746430475, 1018.2617602238317, 1030.3766221435924, 1039.5581877702098, 10195.439250841275, 10424.166066714644, 10507.211959102944, 10556.683299501028, 10576.682699519026, 457699.0, 466123.0, 468274.0, 473589.0, 478679.0, 117444.0, 118285.0, 123211.38394307971, 123932.38033809773, 126281.0, 1031.2626472072504, 1075.5482697267166, 1092.4428541443922, 1101.251149218539, 1129.5989923577176, 19732.802671973095, 19756.604867902275, 19897.303594374127, 20226.39320820378, 20455.28406505765, 56393.436065638816, 58235.417645823, 58569.70715146397, 59395.218143455764, 59792.40207597868, 70567.64716176386, 70615.0, 70707.64646176736, 71130.0, 71388.0, 13978.930105349815, 14358.928205358907, 14376.424943002163, 14488.565343039725, 14544.127352358892, 20579.0, 21624.243151489623, 22054.448638784157, 22281.665775013065, 22420.775792242523, 17412.82587174163, 18173.727394089365, 18285.725714114564, 18305.450836474927, 18314.45056648303, 15144.242787860783, 16065.0, 16332.836671633608, 16656.41702540405, 16827.747583786007, 18320.26718931228, 18428.078596070412, 18516.907415462836, 18528.07359631986, 18677.439676809718, 14029.158250505003, 14071.577852664437, 14128.50550230737, 14135.575932722035, 14207.928960355131, 17744.46766597004, 17839.910800445916, 17850.19674114642, 17976.550586235448, 18122.550195984553], "value": 11928.532621065351, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.2853930338315, 1363.4116254563435, 1365.0512893538994, 1366.9384877680504, 1374.869387408197, 14087.788683169747, 14566.781498277534, 15239.92380038101, 15305.464308749197, 15560.455384061546, 14968.550943471686, 15229.923850380761, 15258.237088145575, 15266.465673701423, 15281.312340944656, 2674.1710069878304, 2737.603047558103, 2739.6986331503517, 2744.286485513771, 2744.8490333031773, 2680.8391496510176, 2838.730320619538, 2841.0908509277037, 2857.942561252329, 2868.19690486663, 2750.766184874278, 2758.3242105684135, 2773.4314465534517, 2774.0429551804596, 2776.7362100600412, 2728.959065614017, 2735.042735042739, 2754.986225068872, 2772.334639686481, 2786.3730660601304, 2677.718839521842, 2694.5032134445705, 2704.148193319098, 2719.524083285417, 2719.5376785946437, 13941.233232172226, 14082.436702531886, 14214.502492412716, 14287.071340362947, 14313.0, 7664.616769161576, 7920.80197995049, 7946.6424010919645, 7949.0, 8003.279704826536, 5307.522322990911, 5360.338295128523, 5415.566754659618, 5558.777648894039, 5602.299712535933, 1929.5658476842739, 1948.6979518174705, 1977.3178253502663, 1989.2838578111869, 1996.4908948218113, 24429.877850610632, 24648.630270545957, 24785.380365490826, 24916.003359865583, 25107.497850042895, 6462.644554549545, 6749.93250067493, 6791.0, 6836.623985680835, 6980.371766541036, 16526.091064991302, 16533.0, 16653.33386664544, 16672.916635416987, 16719.16404179786, 7726.343260822893, 7821.804454888559, 7868.370530357558, 7898.131205567383, 7930.484518506279, 7184.928150718531, 7259.854802904018, 7393.223711510214, 7434.516756410924, 7479.925200748032, 5082.2122571001555, 5239.292695486137, 5266.4996825302305, 5267.631265811433, 5273.890443822502, 1495.7681559358316, 1508.4117194294233, 1512.2665507228985, 1532.7930729351617, 1548.2181498343489, 860.767592749954, 897.4211633496358, 918.2195134136065, 922.6032805893531, 927.0405130689704, 7486.13909400415, 7516.849663006709, 8221.424500284922, 8630.352723545633, 8632.309415246766, 695.7321431248904, 710.1052673631261, 720.121451828768, 732.2896790113688, 739.0244876762729, 4622.768861556909, 4682.461516925598, 4683.484816670163, 4708.0, 4764.094821983881, 19028.0, 20201.0, 20314.593708125754, 20357.287494937606, 20358.18567257323, 18997.715034274497, 19459.51351216231, 19650.508737281398, 19723.802761972198, 19753.50616234577, 10990.395528245863, 11032.117430605533, 11059.170562207866, 11287.774244515227, 11447.313161210353, 8133.34933205354, 8206.261436470746, 8246.134155913544, 8335.374846886387, 8354.331653467587, 16925.492235232963, 17159.31362745476, 17658.82341176572, 17707.557311067325, 18207.90896045511, 17992.10039498046, 17999.10004499796, 18084.54788630295, 18346.633067338844, 18489.72265416047, 10611.31026483276, 10852.186086043735, 10856.294340867818, 10867.565297388015, 10868.782624347627, 12942.935285323512, 13219.0, 13275.867241327463, 13320.666983325495, 13331.0, 10368.066873981377, 10812.837807432737, 10816.08063314627, 10929.83605245906, 11083.33499989971, 10652.360858348524, 10784.406857622593, 10967.945160274148, 10977.725556861142, 10984.231103822656, 9692.612295508383, 9776.0, 9999.20006399501, 10006.249531285328, 10009.149222316184, 7004.509684322048, 7056.6118863463, 7056.7530136444975, 7070.222275549582, 7092.04257425241, 7183.640817959185, 7202.747903823341, 7296.817579560341, 7387.482876198615, 7388.0], "value": 6498.070347049879, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [512.7337169709882, 525.3328273093174, 532.2774010934072, 534.3861538154773, 537.4303238567117, 6204.813855584329, 6287.2710004748715, 6317.52618553608, 6336.9683151584295, 6345.175127233465, 6093.329733729297, 6201.046670298864, 6210.378962103799, 6210.5342099342615, 6250.156228909096, 5116.1302578561545, 5153.304303918979, 5204.739763011853, 5228.294180285669, 5235.685858848481, 5149.40781810091, 5218.243354713564, 5220.843374698765, 5231.3259756877815, 5251.606129540281, 4778.593819525345, 4963.305137280766, 4970.527799859007, 5001.324821149153, 5117.181250999841, 4907.2639104134305, 4919.056972495844, 4969.62727795415, 4973.353464049686, 4997.900041999158, 4414.271645178574, 4450.821967121311, 4480.708753930984, 4514.45826500822, 4528.615067719248, 5851.561132915049, 5995.880082398371, 6061.787837425713, 6138.8772224555705, 6147.446729794296, 5645.802396916089, 5679.119736440858, 5680.318361796611, 5694.117411801178, 5713.057345537981, 6414.679266036726, 6423.261324947597, 6465.256495502983, 6539.64031978241, 6548.508861835381, 4849.272609108627, 4868.464468908417, 4887.633427492952, 4908.705477671351, 4916.164252077156, 6600.4389626881775, 6642.169728783902, 6660.86852207289, 6694.93305066948, 6695.665216739192, 4972.825951091694, 5006.424261209934, 5017.422996355393, 5053.494650534991, 5058.367704036996, 5085.771140298695, 5094.439611642791, 5099.617528685363, 5112.951844871793, 5132.204508301219, 5598.412166722517, 5665.235193248858, 5680.801171959044, 5681.431856814285, 5720.771169153188, 6533.0, 6572.14562106923, 6573.309802470767, 6610.7025183866845, 6660.83347916306, 1751.824817518238, 1754.5701303180801, 1761.5419990802484, 1763.1096296370508, 1774.8846324988835, 1182.633383651071, 1220.2190598017276, 1233.9814902776466, 1237.307108019512, 1242.8943539799218, 5602.1036634139155, 5656.519195868315, 5657.773689052392, 5662.686104992986, 5685.516731077904, 6543.509236807258, 6565.80302590923, 6573.868522629617, 6595.274519802818, 6621.020540756679, 5529.695866727368, 5590.97204513983, 5597.160425936061, 5598.58010649203, 5680.68756218412, 3422.4695172247843, 3492.196794737174, 3516.4725291206523, 3516.771409858351, 3518.5249991251367, 6185.381461853869, 6279.96860015697, 6332.525060620472, 6361.395667411589, 6379.71291291893, 6354.459870911024, 6649.168853893263, 6692.122387373379, 6736.5958042517605, 6821.249662537117, 6266.021076616382, 6318.704665543644, 6324.272708638474, 6335.606166643515, 6408.0, 6625.4037136657935, 6635.469162467088, 6682.766103186365, 6688.2276196806915, 6712.49656275791, 6519.7392104315295, 6577.835554111186, 6579.638119903451, 6622.602643841385, 6665.400113989765, 6383.616982981036, 6452.22573291208, 6488.156539649815, 6503.2196136462035, 6503.219613646393, 4919.852404427873, 4921.212605983025, 4973.577245934136, 4975.0547395994645, 4985.975070124626, 6387.936120638734, 6611.471082313307, 6623.735050597922, 6636.535442518977, 6658.700358483783, 6121.663308518075, 6364.904526432015, 6371.171747672773, 6376.840578985562, 6419.165508483868, 6368.331325210971, 6405.679716014274, 6449.645269510222, 6462.386073323027, 6486.708098135501, 6409.198850143732, 6413.775517856852, 6421.743130274736, 6470.6441145737435, 6527.0, 6464.8707025858275, 6471.0, 6506.772262970773, 6529.444997175293, 6549.574277671936, 6153.292371377349, 6232.563720539519, 6333.271673757393, 6350.142730731292, 6354.90467642995], "value": 5027.07161230701, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [903.5256490342565, 910.6994691751722, 939.6523286384039, 941.9434833909966, 946.3233787841692, 18660.720089198658, 19212.90393548032, 19218.0, 19252.518687032814, 19319.227230910747, 16750.413735519258, 16875.928714609123, 17159.57101072474, 18405.26378944844, 18900.243990240375, 970.7281961050882, 976.3409698453551, 976.4385478349959, 980.0836218136066, 983.4345251480391, 963.3593660215948, 968.1045033344163, 972.8832540095199, 973.095021629884, 978.0806042320196, 999.9950000250025, 1021.254484226515, 1025.5948900184424, 1040.3549799124517, 1042.681981995491, 1019.50553981319, 1024.2778840917135, 1025.5026312238558, 1031.587365053977, 1033.8035773203067, 721.0482163544124, 750.4371721209093, 750.8685979953486, 752.5334292738482, 755.1806290175167, 19330.226790928347, 19356.4193074208, 19360.903195484072, 19384.418467445998, 19441.708374374397, 21273.68089478659, 21408.46478838026, 22480.662790058162, 22551.661725074136, 22772.20297289587, 17285.740713889303, 17695.115244237735, 17702.91148544262, 17703.468895933143, 17822.287108515775, 3771.358868992278, 3788.3749181385037, 3792.336341140317, 3805.086779173006, 3807.733458657895, 136531.31734341363, 140342.99999999898, 141816.29091854577, 142846.0, 145626.0, 16300.755488667679, 16666.0, 16674.082925438976, 16699.165041747863, 16825.0, 31055.0, 31280.0, 31478.842605786824, 31702.682973170435, 32112.0, 8666.306695464347, 8857.424267422597, 8916.955415222883, 8917.777055573662, 8920.197182253629, 4179.937300940488, 4198.349255865346, 4204.07510347723, 4256.063665993476, 4275.016746148403, 4938.530839570235, 5098.260752190911, 5153.227015947563, 5160.767765450564, 5204.557612602971, 1025.6102680981328, 1064.5582083435288, 1068.1614932278123, 1079.5088234853124, 1085.2565992295304, 658.6673729766437, 680.8910574308087, 688.4629988608893, 688.5765254368628, 689.2452764223168, 11596.304221746723, 11810.713341547118, 11935.403229838474, 12809.679758005937, 13138.474461021453, 674.8211723893172, 677.3362105136895, 677.461418172554, 682.7507959594712, 692.6121372031578, 5706.771729130788, 5895.528357731371, 5906.379830117776, 5910.8817823643285, 5995.61028533144, 126724.36637816751, 129711.0, 131268.343658283, 131815.3409232967, 137047.94428083586, 109804.4509777446, 110051.0, 110368.0, 112399.87600124057, 113940.0, 95221.0477895226, 95413.0, 97569.51215243878, 99381.0, 100414.0, 10895.836562451728, 10934.0, 11049.83425248638, 11061.0, 11250.94374528155, 44035.0, 45942.85142871321, 46734.76632616815, 46969.53030469651, 47335.52664473449, 60663.69668151631, 60675.0, 60703.69648151731, 60857.39142608694, 60948.0, 14822.703545929236, 14947.626309342353, 14967.0, 15008.474703385766, 15201.391944322104, 16701.5824604381, 16819.495415137564, 16885.0, 16999.745003824704, 17127.314907404063, 15328.540143795704, 15823.68352632964, 15832.60418489547, 15865.920670396574, 16071.0, 14308.785368219276, 14340.56978290653, 14398.352074156897, 14543.909206809743, 14567.0, 14144.717105658036, 14233.50182743599, 14264.429422823387, 14322.069065510708, 14438.711225775636, 10939.945300273448, 10990.780184396428, 11063.834042489209, 11135.0, 11220.775584488429, 10431.63489277902, 10531.315464494783, 10689.839652405375, 10777.46112694378, 10895.78208435811], "value": 8893.106816605812, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1449.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 110.0, 113.0, 107.0, 111.0, 117.0, 112.0, 110.0, 109.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 125.0, 122.0, 117.0, 127.0, 116.0, 122.0, 115.0, 145.0], "value": 122.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 166.0, 167.0, 170.0, 164.0, 164.0, 168.0, 168.0, 164.0], "value": 167.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 77.0, 83.0, 74.0, 83.0, 82.0, 82.0, 84.0, 84.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 84.0, 78.0, 83.0, 88.0, 78.0, 79.0, 81.0, 79.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 112.0, 111.0, 111.0, 111.0, 112.0, 126.0, 118.0, 117.0, 119.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 150.0, 148.0, 148.0, 147.0, 149.0, 164.0, 149.0, 155.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 100.0, 94.0, 97.0, 102.0, 95.0, 101.0, 98.0, 97.0, 95.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 51.0, 50.0, 52.0, 51.0, 58.0, 51.0, 52.0, 50.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 45.0, 37.0, 48.0, 37.0, 41.0, 40.0, 37.0, 47.0, 46.0], "value": 42.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 76.0, 74.0, 75.0, 78.0, 73.0, 77.0, 79.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 120.0, 111.0, 126.0, 108.0, 111.0, 113.0, 117.0, 111.0], "value": 114.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 164.0, 168.0, 168.0, 167.0, 168.0, 181.0, 168.0, 176.0, 169.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 64.0, 74.0, 66.0, 69.0, 70.0, 63.0, 67.0], "value": 66.3, "unit": "score"}]}]} 17:16:02 INFO - Return code: 0 17:16:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:16:02 INFO - # TBPL SUCCESS # 17:16:02 INFO - Running post-action listener: _package_coverage_data 17:16:02 INFO - Running post-action listener: _resource_record_post_action 17:16:02 INFO - [mozharness: 2017-10-01 00:16:02.526124Z] Finished run-tests step (success) 17:16:02 INFO - Running post-run listener: _resource_record_post_run 17:16:02 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 346767360; Read time: 16; Write time: 240672 17:16:02 INFO - TinderboxPrint: CPU usage
13.2% 17:16:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:16:02 INFO - TinderboxPrint: I/O write bytes / time
346,767,360 / 240,672 17:16:02 INFO - TinderboxPrint: CPU idle
8,249.0 (86.8%) 17:16:02 INFO - TinderboxPrint: CPU user
1,197.4 (12.6%) 17:16:02 INFO - TinderboxPrint: Swap in / out
0 / 0 17:16:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13205504; Read time: 0; Write time: 1100 17:16:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:16:02 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 333557760; Read time: 0; Write time: 239572 17:16:03 INFO - Running post-run listener: _upload_blobber_files 17:16:03 INFO - Blob upload gear active. 17:16:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:16:03 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 17:16:03 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'] 17:16:03 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 17:16:03 INFO - (blobuploader) - INFO - Open directory for files ... 17:16:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:16:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:16:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:04 INFO - (blobuploader) - INFO - Done attempting. 17:16:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:16:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:16:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:05 INFO - (blobuploader) - INFO - Done attempting. 17:16:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:16:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:16:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:07 INFO - (blobuploader) - INFO - Done attempting. 17:16:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:16:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:16:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:14 INFO - (blobuploader) - INFO - Done attempting. 17:16:14 INFO - (blobuploader) - INFO - Iteration through files over. 17:16:14 INFO - Return code: 0 17:16:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:16:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:16:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88e07693fd4f63592780e9b982e49e000e612b01bd7bcd6ea5dc3c4ac0263c84ccdb3fd69ad497213700f3e3dc4cb06d39ff30fbfa6358af9cd6f74a60f16e2c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9eb009272335eef2b25d2f89155e49798ed15c3b179ac1814cbcf87c825e9388c4a78d4e75994fdce65a8c03ee8b475dbfca181b6e5b0821ecd6419efdbc0e4b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/280162541bbfe29408a8f6cd9cdc0ad8718ba7dd28e5149911377d8346c1d360ea8661202510be60ea7bfd3ed0df8876d78228888ba20e6546d4bc218b807486", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b2a01abfccda6bd78c05af131b917fdcc03b704231a0a39efdb7ef07c04b262f49be0fa28cd93215e8361eff41acfa4887de3041d32d8aed4ebdb1092fca3e2"} 17:16:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:16:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:16:14 INFO - Contents: 17:16:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88e07693fd4f63592780e9b982e49e000e612b01bd7bcd6ea5dc3c4ac0263c84ccdb3fd69ad497213700f3e3dc4cb06d39ff30fbfa6358af9cd6f74a60f16e2c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9eb009272335eef2b25d2f89155e49798ed15c3b179ac1814cbcf87c825e9388c4a78d4e75994fdce65a8c03ee8b475dbfca181b6e5b0821ecd6419efdbc0e4b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/280162541bbfe29408a8f6cd9cdc0ad8718ba7dd28e5149911377d8346c1d360ea8661202510be60ea7bfd3ed0df8876d78228888ba20e6546d4bc218b807486", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b2a01abfccda6bd78c05af131b917fdcc03b704231a0a39efdb7ef07c04b262f49be0fa28cd93215e8361eff41acfa4887de3041d32d8aed4ebdb1092fca3e2"} 17:16:14 INFO - Running post-run listener: copy_logs_to_upload_dir 17:16:14 INFO - Copying logs to upload dir... 17:16:14 INFO - mkdir: /builds/slave/test/build/upload/logs 17:16:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.738804 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-30 17:16:14.271563) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-30 17:16:14.274255) ========= 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=c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88e07693fd4f63592780e9b982e49e000e612b01bd7bcd6ea5dc3c4ac0263c84ccdb3fd69ad497213700f3e3dc4cb06d39ff30fbfa6358af9cd6f74a60f16e2c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9eb009272335eef2b25d2f89155e49798ed15c3b179ac1814cbcf87c825e9388c4a78d4e75994fdce65a8c03ee8b475dbfca181b6e5b0821ecd6419efdbc0e4b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/280162541bbfe29408a8f6cd9cdc0ad8718ba7dd28e5149911377d8346c1d360ea8661202510be60ea7bfd3ed0df8876d78228888ba20e6546d4bc218b807486", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b2a01abfccda6bd78c05af131b917fdcc03b704231a0a39efdb7ef07c04b262f49be0fa28cd93215e8361eff41acfa4887de3041d32d8aed4ebdb1092fca3e2"} build_url:https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/Oy_3fd7dS46Shpt74MAsbg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88e07693fd4f63592780e9b982e49e000e612b01bd7bcd6ea5dc3c4ac0263c84ccdb3fd69ad497213700f3e3dc4cb06d39ff30fbfa6358af9cd6f74a60f16e2c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9eb009272335eef2b25d2f89155e49798ed15c3b179ac1814cbcf87c825e9388c4a78d4e75994fdce65a8c03ee8b475dbfca181b6e5b0821ecd6419efdbc0e4b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/280162541bbfe29408a8f6cd9cdc0ad8718ba7dd28e5149911377d8346c1d360ea8661202510be60ea7bfd3ed0df8876d78228888ba20e6546d4bc218b807486", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b2a01abfccda6bd78c05af131b917fdcc03b704231a0a39efdb7ef07c04b262f49be0fa28cd93215e8361eff41acfa4887de3041d32d8aed4ebdb1092fca3e2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-30 17:16:14.302182) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 17:16:14.302492) ========= 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=c6927cf182745ad25b1d38b9000001fe-1506814682.617560-1748714283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 17:16:14.385729) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-30 17:16:14.386045) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-30 17:16:14.386342) ========= ========= Total master_lag: 0.24 =========