builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1507741168.1 results: success (0) revision: 973f61d8b175a1aa0109d4a6f1a3b3a75a3fc782 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-11 09:59:28.100986) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-11 09:59:28.101409) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-11 09:59:28.101722) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-11 09:59:28.120419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 09:59:28.120708) ========= 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=41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-11 09:59:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-10-11 09:59:28 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143160 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 09:59:28.307827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 09:59:28.308123) ========= 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=41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014286 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 09:59:28.357300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-11 09:59:28.357589) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 973f61d8b175a1aa0109d4a6f1a3b3a75a3fc782 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 973f61d8b175a1aa0109d4a6f1a3b3a75a3fc782 --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=41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-11 09:59:28,409 truncating revision to first 12 chars 2017-10-11 09:59:28,409 Setting DEBUG logging. 2017-10-11 09:59:28,409 attempt 1/10 2017-10-11 09:59:28,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/973f61d8b175?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-11 09:59:29,183 unpacking tar archive at: mozilla-beta-973f61d8b175/testing/mozharness/ program finished with exit code 0 elapsedTime=1.042420 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-11 09:59:29.417278) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-11 09:59:29.417610) ========= script_repo_revision: 973f61d8b175a1aa0109d4a6f1a3b3a75a3fc782 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-11 09:59:29.417984) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-11 09:59:29.418245) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-11 09:59:29.432786) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2017-10-11 09:59:29.433061) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:59:29 INFO - MultiFileLogger online at 20171011 09:59:29 in /builds/slave/test 09:59:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 09:59:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:59:29 INFO - {'append_to_log': False, 09:59:29 INFO - 'base_work_dir': '/builds/slave/test', 09:59:29 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 09:59:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:59:29 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 09:59:29 INFO - 'buildbot_json_path': 'buildprops.json', 09:59:29 INFO - 'code_coverage': False, 09:59:29 INFO - 'config_files': ('talos/linux_config.py',), 09:59:29 INFO - 'default_actions': ('clobber', 09:59:29 INFO - 'read-buildbot-config', 09:59:29 INFO - 'download-and-extract', 09:59:29 INFO - 'populate-webroot', 09:59:29 INFO - 'create-virtualenv', 09:59:29 INFO - 'install', 09:59:29 INFO - 'setup-mitmproxy', 09:59:29 INFO - 'run-tests'), 09:59:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:59:29 INFO - 'disable_ccov_upload': False, 09:59:29 INFO - 'disable_stylo': False, 09:59:29 INFO - 'download_minidump_stackwalk': True, 09:59:29 INFO - 'download_symbols': 'ondemand', 09:59:29 INFO - 'enable_stylo': False, 09:59:29 INFO - 'enable_webrender': False, 09:59:29 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 09:59:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:59:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:59:29 INFO - 'gecko_profile': False, 09:59:29 INFO - 'gecko_profile_interval': 0, 09:59:29 INFO - 'installer_path': 'installer.exe', 09:59:29 INFO - 'log_level': 'info', 09:59:29 INFO - 'log_name': 'talos', 09:59:29 INFO - 'log_to_console': True, 09:59:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:59:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:59:29 INFO - 'opt_config_files': (), 09:59:29 INFO - 'pip_index': False, 09:59:29 INFO - 'suite': 'dromaeojs-e10s', 09:59:29 INFO - 'system_bits': '32', 09:59:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:59:29 INFO - 'title': 'talos-linux64-ix-026', 09:59:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:59:29 INFO - 'use_talos_json': True, 09:59:29 INFO - 'verify': 'False', 09:59:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:59:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:59:29 INFO - 'work_dir': 'build'} 09:59:29 INFO - [mozharness: 2017-10-11 16:59:29.627925Z] Running clobber step. 09:59:29 INFO - Running pre-action listener: _resource_record_pre_action 09:59:29 INFO - Running main action method: clobber 09:59:29 INFO - rmtree: /builds/slave/test/build 09:59:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:59:30 INFO - Running post-action listener: _resource_record_post_action 09:59:30 INFO - [mozharness: 2017-10-11 16:59:30.639148Z] Finished clobber step (success) 09:59:30 INFO - [mozharness: 2017-10-11 16:59:30.639262Z] Running read-buildbot-config step. 09:59:30 INFO - Running pre-action listener: _resource_record_pre_action 09:59:30 INFO - Running main action method: read_buildbot_config 09:59:30 INFO - Using buildbot properties: 09:59:30 INFO - { 09:59:30 INFO - "project": "", 09:59:30 INFO - "product": "firefox", 09:59:30 INFO - "who": "archaeopteryx@coole-files.de", 09:59:30 INFO - "installer_path": "public/build/target.tar.bz2", 09:59:30 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:59:30 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 09:59:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 09:59:30 INFO - "stage_platform": "linux64", 09:59:30 INFO - "basedir": "/builds/slave/test", 09:59:30 INFO - "buildnumber": 133, 09:59:30 INFO - "platform": "ubuntu64_hw", 09:59:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:59:30 INFO - "slavebuilddir": "test", 09:59:30 INFO - "taskId": "Gc5hJf4lQzqyRBWswo9x2w", 09:59:30 INFO - "branch": "mozilla-beta", 09:59:30 INFO - "script_repo_revision": "production", 09:59:30 INFO - "revision": "973f61d8b175a1aa0109d4a6f1a3b3a75a3fc782", 09:59:30 INFO - "slavename": "talos-linux64-ix-026", 09:59:30 INFO - "repo_path": "releases/mozilla-beta" 09:59:30 INFO - } 09:59:30 INFO - Finding installer, test and symbols from parent task. 09:59:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gc5hJf4lQzqyRBWswo9x2w'}, attempt #1 09:59:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gc5hJf4lQzqyRBWswo9x2w'}, attempt #1 09:59:31 INFO - Task dependencies: MR05ycnkThuhW1N_ueEuNw 09:59:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw'}, attempt #1 09:59:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.tar.bz2 09:59:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.test_packages.json 09:59:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.crashreporter-symbols.zip 09:59:32 INFO - Running post-action listener: _resource_record_post_action 09:59:32 INFO - [mozharness: 2017-10-11 16:59:32.076289Z] Finished read-buildbot-config step (success) 09:59:32 INFO - [mozharness: 2017-10-11 16:59:32.076505Z] Running download-and-extract step. 09:59:32 INFO - Running pre-action listener: _resource_record_pre_action 09:59:32 INFO - Running main action method: download_and_extract 09:59:32 INFO - mkdir: /builds/slave/test/build/tests 09:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:32 INFO - trying https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.test_packages.json 09:59:32 INFO - Downloading https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:59:32 INFO - Downloaded 989 bytes. 09:59:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:59:32 INFO - Using the following test package requirements: 09:59:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:59:32 INFO - u'common': [u'target.common.tests.zip'], 09:59:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:59:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:59:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:59:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:59:32 INFO - u'mozbase': [u'target.common.tests.zip'], 09:59:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:59:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:59:32 INFO - u'web-platform': [u'target.common.tests.zip', 09:59:32 INFO - u'target.web-platform.tests.tar.gz'], 09:59:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:59:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 09:59:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.common.tests.zip 09:59:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:59:32 INFO - Fetch https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.common.tests.zip into memory 09:59:33 INFO - Content-Length response header: 55183526 09:59:33 INFO - Bytes received: 55183526 09:59:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.talos.tests.zip 09:59:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:59:44 INFO - Fetch https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.talos.tests.zip into memory 09:59:45 INFO - Content-Length response header: 14509251 09:59:45 INFO - Bytes received: 14509251 09:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:45 INFO - trying https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.tar.bz2 09:59:45 INFO - Downloading https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:59:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:59:47 INFO - Downloaded 53692763 bytes. 09:59:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.tar.bz2 09:59:47 INFO - mkdir: /builds/slave/test/properties 09:59:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:59:47 INFO - Writing to file /builds/slave/test/properties/build_url 09:59:47 INFO - Contents: 09:59:47 INFO - build_url:https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.tar.bz2 09:59:47 INFO - Running post-action listener: _resource_record_post_action 09:59:47 INFO - Running post-action listener: find_tests_for_verification 09:59:47 INFO - Running post-action listener: set_extra_try_arguments 09:59:47 INFO - [mozharness: 2017-10-11 16:59:47.551812Z] Finished download-and-extract step (success) 09:59:47 INFO - [mozharness: 2017-10-11 16:59:47.551999Z] Running populate-webroot step. 09:59:47 INFO - Running pre-action listener: _resource_record_pre_action 09:59:47 INFO - Running main action method: populate_webroot 09:59:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:59:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:59:47 INFO - 'tests': ['tresize', 09:59:47 INFO - 'tcanvasmark']}, 09:59:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:59:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:59:47 INFO - 'tests': ['dromaeo_css', 09:59:47 INFO - 'kraken']}, 09:59:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:59:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:59:47 INFO - 'talos_options': ['--disable-stylo'], 09:59:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:59:47 INFO - 'tests': ['damp', 'tps']}, 09:59:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:59:47 INFO - 'talos_options': ['--disable-stylo'], 09:59:47 INFO - 'tests': ['damp', 'tps']}, 09:59:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:59:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:59:47 INFO - 'tests': ['dromaeo_dom']}, 09:59:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:59:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:59:47 INFO - 'tests': ['basic_compositor_video', 09:59:47 INFO - 'glvideo']}, 09:59:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:59:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:59:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:59:47 INFO - 'talos_options': ['--disable-stylo'], 09:59:47 INFO - 'tests': ['ts_paint_webext', 09:59:47 INFO - 'tp5o_webext']}, 09:59:47 INFO - 'other-e10s': {'tests': ['a11yr', 09:59:47 INFO - 'ts_paint', 09:59:47 INFO - 'tpaint', 09:59:47 INFO - 'sessionrestore', 09:59:47 INFO - 'sessionrestore_many_windows', 09:59:47 INFO - 'sessionrestore_no_auto_restore', 09:59:47 INFO - 'tabpaint']}, 09:59:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:59:47 INFO - 'tests': ['a11yr', 09:59:47 INFO - 'ts_paint', 09:59:47 INFO - 'tpaint', 09:59:47 INFO - 'sessionrestore', 09:59:47 INFO - 'sessionrestore_many_windows', 09:59:47 INFO - 'sessionrestore_no_auto_restore', 09:59:47 INFO - 'tabpaint']}, 09:59:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:59:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 09:59:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:59:47 INFO - 'tests': ['perf_reftest_singletons']}, 09:59:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:59:47 INFO - 'tests': ['bloom_basic']}, 09:59:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:59:47 INFO - 'tsvgr_opacity', 09:59:47 INFO - 'tart', 09:59:47 INFO - 'tscrollx', 09:59:47 INFO - 'tsvg_static']}, 09:59:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:59:47 INFO - 'tests': ['tsvgx', 09:59:47 INFO - 'tsvgr_opacity', 09:59:47 INFO - 'tart', 09:59:47 INFO - 'tscrollx', 09:59:47 INFO - 'tsvg_static']}, 09:59:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:59:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:59:47 INFO - 'talos_options': ['--disable-stylo'], 09:59:47 INFO - 'tests': ['tp5o']}, 09:59:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:59:47 INFO - 'talos_options': ['--mitmproxy', 09:59:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:59:47 INFO - '--firstNonBlankPaint'], 09:59:47 INFO - 'tests': ['tp6_google', 09:59:47 INFO - 'tp6_youtube', 09:59:47 INFO - 'tp6_amazon', 09:59:47 INFO - 'tp6_facebook']}, 09:59:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:59:47 INFO - 'talos_options': ['--disable-stylo', 09:59:47 INFO - '--mitmproxy', 09:59:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:59:47 INFO - '--firstNonBlankPaint'], 09:59:47 INFO - 'tests': ['tp6_google', 09:59:47 INFO - 'tp6_youtube', 09:59:47 INFO - 'tp6_amazon', 09:59:47 INFO - 'tp6_facebook']}, 09:59:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:59:47 INFO - 'talos_options': ['--stylo-threads=1', 09:59:47 INFO - '--mitmproxy', 09:59:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:59:47 INFO - '--firstNonBlankPaint'], 09:59:47 INFO - 'tests': ['tp6_google', 09:59:47 INFO - 'tp6_youtube', 09:59:47 INFO - 'tp6_amazon', 09:59:47 INFO - 'tp6_facebook']}, 09:59:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:59:47 INFO - 'talos_options': ['--xperf_path', 09:59:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:47 INFO - 'tests': ['tp5n']}, 09:59:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:59:47 INFO - 'talos_options': ['--disable-stylo', 09:59:47 INFO - '--xperf_path', 09:59:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:47 INFO - 'tests': ['tp5n']}}} 09:59:47 INFO - Running post-action listener: _resource_record_post_action 09:59:47 INFO - [mozharness: 2017-10-11 16:59:47.572956Z] Finished populate-webroot step (success) 09:59:47 INFO - [mozharness: 2017-10-11 16:59:47.573061Z] Running create-virtualenv step. 09:59:47 INFO - Running pre-action listener: _resource_record_pre_action 09:59:47 INFO - Running main action method: create_virtualenv 09:59:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:59:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:59:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 09:59:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:59:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:59:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:59:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:59:48 INFO - Installing pip...............done. 09:59:48 INFO - Return code: 0 09:59:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:59:48 INFO - Reading from file tmpfile_stdout 09:59:48 INFO - Output received: 09:59: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) 09:59:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:59: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')]} 09:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59: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')]} 09:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59: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 0x24c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830090>, '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 0x2830d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282af90>, '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': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', '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 09:59: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 09:59: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 09:59:48 INFO - Using env: {'DISPLAY': ':0', 09:59:48 INFO - 'HOME': '/home/cltbld', 09:59:48 INFO - 'LANG': 'en_US.UTF-8', 09:59:48 INFO - 'LANGUAGE': 'en_US:en', 09:59:48 INFO - 'LOGNAME': 'cltbld', 09:59:48 INFO - 'MAIL': '/var/mail/cltbld', 09:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:48 INFO - 'MOZ_NO_REMOTE': '1', 09:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:48 INFO - 'NO_EM_RESTART': '1', 09:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:48 INFO - 'PWD': '/builds/slave/test', 09:59:48 INFO - 'SHELL': '/bin/bash', 09:59:48 INFO - 'SHLVL': '1', 09:59:48 INFO - 'TERM': 'linux', 09:59:48 INFO - 'TMOUT': '86400', 09:59:48 INFO - 'USER': 'cltbld', 09:59:48 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', 09:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:48 INFO - '_': '/tools/buildbot/bin/python'} 09:59:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 09:59:50 INFO - Downloading/unpacking pip>=1.5 09:59:50 INFO - Running setup.py egg_info for package pip 09:59:50 INFO - warning: no files found matching 'pip/cacert.pem' 09:59:50 INFO - warning: no files found matching '*.html' under directory 'docs' 09:59:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:59:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:59:50 INFO - Installing collected packages: pip 09:59:50 INFO - Found existing installation: pip 1.1 09:59:50 INFO - Uninstalling pip: 09:59:50 INFO - Successfully uninstalled pip 09:59:50 INFO - Running setup.py install for pip 09:59:50 INFO - warning: no files found matching 'pip/cacert.pem' 09:59:50 INFO - warning: no files found matching '*.html' under directory 'docs' 09:59:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:59:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:59:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 09:59:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 09:59:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 09:59:50 INFO - Successfully installed pip 09:59:50 INFO - Cleaning up... 09:59:50 INFO - Return code: 0 09:59:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:59: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')]} 09:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59: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')]} 09:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59: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 0x24c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830090>, '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 0x2830d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282af90>, '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': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', '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 09:59: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 09:59: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 09:59:50 INFO - Using env: {'DISPLAY': ':0', 09:59:50 INFO - 'HOME': '/home/cltbld', 09:59:50 INFO - 'LANG': 'en_US.UTF-8', 09:59:50 INFO - 'LANGUAGE': 'en_US:en', 09:59:50 INFO - 'LOGNAME': 'cltbld', 09:59:50 INFO - 'MAIL': '/var/mail/cltbld', 09:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:50 INFO - 'MOZ_NO_REMOTE': '1', 09:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:50 INFO - 'NO_EM_RESTART': '1', 09:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:50 INFO - 'PWD': '/builds/slave/test', 09:59:50 INFO - 'SHELL': '/bin/bash', 09:59:50 INFO - 'SHLVL': '1', 09:59:50 INFO - 'TERM': 'linux', 09:59:50 INFO - 'TMOUT': '86400', 09:59:50 INFO - 'USER': 'cltbld', 09:59:50 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', 09:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:50 INFO - '_': '/tools/buildbot/bin/python'} 09:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:50 INFO - Downloading/unpacking psutil>=3.1.1 09:59: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 09:59: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 09:59: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 09:59: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 09:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:59:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:52 INFO - Installing collected packages: psutil 09:59:52 INFO - Running setup.py install for psutil 09:59:52 INFO - building 'psutil._psutil_linux' extension 09:59: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 09:59: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 09:59:52 INFO - building 'psutil._psutil_posix' extension 09:59: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 09:59: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 09:59:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:52 INFO - Successfully installed psutil 09:59:52 INFO - Cleaning up... 09:59:52 INFO - Return code: 0 09:59:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830090>, '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 0x2830d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282af90>, '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': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', '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 09:59:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:59:52 INFO - Using env: {'DISPLAY': ':0', 09:59:52 INFO - 'HOME': '/home/cltbld', 09:59:52 INFO - 'LANG': 'en_US.UTF-8', 09:59:52 INFO - 'LANGUAGE': 'en_US:en', 09:59:52 INFO - 'LOGNAME': 'cltbld', 09:59:52 INFO - 'MAIL': '/var/mail/cltbld', 09:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:52 INFO - 'MOZ_NO_REMOTE': '1', 09:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:52 INFO - 'NO_EM_RESTART': '1', 09:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:52 INFO - 'PWD': '/builds/slave/test', 09:59:52 INFO - 'SHELL': '/bin/bash', 09:59:52 INFO - 'SHLVL': '1', 09:59:52 INFO - 'TERM': 'linux', 09:59:52 INFO - 'TMOUT': '86400', 09:59:52 INFO - 'USER': 'cltbld', 09:59:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', 09:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:52 INFO - '_': '/tools/buildbot/bin/python'} 09:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:59:54 INFO - Installing collected packages: mozsystemmonitor 09:59:54 INFO - Running setup.py install for mozsystemmonitor 09:59:54 INFO - Successfully installed mozsystemmonitor 09:59:54 INFO - Cleaning up... 09:59:54 INFO - Return code: 0 09:59:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830090>, '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 0x2830d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282af90>, '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': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', '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 09:59:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:59:54 INFO - Using env: {'DISPLAY': ':0', 09:59:54 INFO - 'HOME': '/home/cltbld', 09:59:54 INFO - 'LANG': 'en_US.UTF-8', 09:59:54 INFO - 'LANGUAGE': 'en_US:en', 09:59:54 INFO - 'LOGNAME': 'cltbld', 09:59:54 INFO - 'MAIL': '/var/mail/cltbld', 09:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:54 INFO - 'MOZ_NO_REMOTE': '1', 09:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:54 INFO - 'NO_EM_RESTART': '1', 09:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:54 INFO - 'PWD': '/builds/slave/test', 09:59:54 INFO - 'SHELL': '/bin/bash', 09:59:54 INFO - 'SHLVL': '1', 09:59:54 INFO - 'TERM': 'linux', 09:59:54 INFO - 'TMOUT': '86400', 09:59:54 INFO - 'USER': 'cltbld', 09:59:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', 09:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:54 INFO - '_': '/tools/buildbot/bin/python'} 09:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:54 INFO - Downloading/unpacking jsonschema==2.5.1 09:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:59:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:55 INFO - Downloading functools32-3.2.3-2.tar.gz 09:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:59:55 INFO - warning: no files found matching '*.txt' 09:59:55 INFO - no previously-included directories found matching 'build' 09:59:55 INFO - no previously-included directories found matching 'dist' 09:59:55 INFO - no previously-included directories found matching '.git*' 09:59:55 INFO - Installing collected packages: jsonschema, functools32 09:59:55 INFO - Running setup.py install for functools32 09:59:55 INFO - warning: no files found matching '*.txt' 09:59:55 INFO - no previously-included directories found matching 'build' 09:59:55 INFO - no previously-included directories found matching 'dist' 09:59:55 INFO - no previously-included directories found matching '.git*' 09:59:55 INFO - Successfully installed jsonschema functools32 09:59:55 INFO - Cleaning up... 09:59:55 INFO - Return code: 0 09:59:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:59: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')]} 09:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59: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')]} 09:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59: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', '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 0x24c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830090>, '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 0x2830d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282af90>, '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': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', '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 09:59: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:59: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 functools32==3.2.3-2 09:59:55 INFO - Using env: {'DISPLAY': ':0', 09:59:55 INFO - 'HOME': '/home/cltbld', 09:59:55 INFO - 'LANG': 'en_US.UTF-8', 09:59:55 INFO - 'LANGUAGE': 'en_US:en', 09:59:55 INFO - 'LOGNAME': 'cltbld', 09:59:55 INFO - 'MAIL': '/var/mail/cltbld', 09:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:55 INFO - 'MOZ_NO_REMOTE': '1', 09:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:55 INFO - 'NO_EM_RESTART': '1', 09:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:55 INFO - 'PWD': '/builds/slave/test', 09:59:55 INFO - 'SHELL': '/bin/bash', 09:59:55 INFO - 'SHLVL': '1', 09:59:55 INFO - 'TERM': 'linux', 09:59:55 INFO - 'TMOUT': '86400', 09:59:55 INFO - 'USER': 'cltbld', 09:59:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', 09:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:55 INFO - '_': '/tools/buildbot/bin/python'} 09:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:59:56 INFO - Cleaning up... 09:59:56 INFO - Return code: 0 09:59:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830090>, '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 0x2830d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282af90>, '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': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', '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 09:59:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:59:56 INFO - Using env: {'DISPLAY': ':0', 09:59:56 INFO - 'HOME': '/home/cltbld', 09:59:56 INFO - 'LANG': 'en_US.UTF-8', 09:59:56 INFO - 'LANGUAGE': 'en_US:en', 09:59:56 INFO - 'LOGNAME': 'cltbld', 09:59:56 INFO - 'MAIL': '/var/mail/cltbld', 09:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:56 INFO - 'MOZ_NO_REMOTE': '1', 09:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:56 INFO - 'NO_EM_RESTART': '1', 09:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:56 INFO - 'PWD': '/builds/slave/test', 09:59:56 INFO - 'SHELL': '/bin/bash', 09:59:56 INFO - 'SHLVL': '1', 09:59:56 INFO - 'TERM': 'linux', 09:59:56 INFO - 'TMOUT': '86400', 09:59:56 INFO - 'USER': 'cltbld', 09:59:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', 09:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:56 INFO - '_': '/tools/buildbot/bin/python'} 09:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:56 INFO - Downloading/unpacking blobuploader==1.2.4 09:59: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 09:59: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 09:59: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 09:59: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 09:59:57 INFO - Downloading blobuploader-1.2.4.tar.gz 09:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:59:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:59: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 09:59: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 09:59: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 09:59: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 09:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:59:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:59: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 09:59: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 09:59: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 09:59: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 09:59:57 INFO - Downloading docopt-0.6.1.tar.gz 09:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:59:58 INFO - Installing collected packages: blobuploader, requests, docopt 09:59:58 INFO - Running setup.py install for blobuploader 09:59:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:59:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:59:58 INFO - Running setup.py install for requests 09:59:58 INFO - Running setup.py install for docopt 09:59:58 INFO - Successfully installed blobuploader requests docopt 09:59:58 INFO - Cleaning up... 09:59:58 INFO - Return code: 0 09:59:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:58 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 0x24c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830090>, '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 0x2830d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282af90>, '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': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', '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 09:59:58 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 09:59:58 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 09:59:58 INFO - Using env: {'DISPLAY': ':0', 09:59:58 INFO - 'HOME': '/home/cltbld', 09:59:58 INFO - 'LANG': 'en_US.UTF-8', 09:59:58 INFO - 'LANGUAGE': 'en_US:en', 09:59:58 INFO - 'LOGNAME': 'cltbld', 09:59:58 INFO - 'MAIL': '/var/mail/cltbld', 09:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:58 INFO - 'MOZ_NO_REMOTE': '1', 09:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:58 INFO - 'NO_EM_RESTART': '1', 09:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:58 INFO - 'PWD': '/builds/slave/test', 09:59:58 INFO - 'SHELL': '/bin/bash', 09:59:58 INFO - 'SHLVL': '1', 09:59:58 INFO - 'TERM': 'linux', 09:59:58 INFO - 'TMOUT': '86400', 09:59:58 INFO - 'USER': 'cltbld', 09:59:58 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', 09:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:58 INFO - '_': '/tools/buildbot/bin/python'} 09:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:58 INFO - Running setup.py (path:/tmp/pip-nSazNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:58 INFO - Running setup.py (path:/tmp/pip-v7g6t3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:58 INFO - Running setup.py (path:/tmp/pip-XFkErC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:59 INFO - Running setup.py (path:/tmp/pip-vfXDGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:59 INFO - Running setup.py (path:/tmp/pip-_rTE_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:59 INFO - Running setup.py (path:/tmp/pip-uFV6Tg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:59 INFO - Running setup.py (path:/tmp/pip-XahVcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:59 INFO - Running setup.py (path:/tmp/pip-JwYzao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:59 INFO - Running setup.py (path:/tmp/pip-mtsl21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:59 INFO - Running setup.py (path:/tmp/pip-O3Z5hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:59 INFO - Running setup.py (path:/tmp/pip-7uZ3uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:59 INFO - Running setup.py (path:/tmp/pip-tu2woH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:59 INFO - Running setup.py (path:/tmp/pip-8rYB3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:59 INFO - Running setup.py (path:/tmp/pip-0Wurw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:59 INFO - Running setup.py (path:/tmp/pip-EAL93M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:59 INFO - Running setup.py (path:/tmp/pip-HTO6uZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:59 INFO - Running setup.py (path:/tmp/pip-gBs4Vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:00:00 INFO - Running setup.py install for manifestparser 10:00:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:00:00 INFO - Running setup.py install for mozcrash 10:00:00 INFO - Running setup.py install for mozdebug 10:00:00 INFO - Running setup.py install for mozdevice 10:00:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:00:00 INFO - Running setup.py install for mozfile 10:00:00 INFO - Running setup.py install for mozhttpd 10:00:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:00:00 INFO - Running setup.py install for mozinfo 10:00:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:00:00 INFO - Running setup.py install for mozInstall 10:00:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:00:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:00:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:00:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:00:00 INFO - Running setup.py install for mozleak 10:00:00 INFO - Running setup.py install for mozlog 10:00:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:00:01 INFO - Running setup.py install for moznetwork 10:00:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:00:01 INFO - Running setup.py install for mozprocess 10:00:01 INFO - Running setup.py install for mozprofile 10:00:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:00:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:00:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:00:01 INFO - Running setup.py install for mozrunner 10:00:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:00:01 INFO - Running setup.py install for mozscreenshot 10:00:01 INFO - Running setup.py install for moztest 10:00:01 INFO - Running setup.py install for mozversion 10:00:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:00:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:00:01 INFO - Cleaning up... 10:00:01 INFO - Return code: 0 10:00:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:01 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 0x24c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830090>, '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 0x2830d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282af90>, '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': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', '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 10:00:01 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 10:00:01 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 10:00:01 INFO - Using env: {'DISPLAY': ':0', 10:00:01 INFO - 'HOME': '/home/cltbld', 10:00:01 INFO - 'LANG': 'en_US.UTF-8', 10:00:01 INFO - 'LANGUAGE': 'en_US:en', 10:00:01 INFO - 'LOGNAME': 'cltbld', 10:00:01 INFO - 'MAIL': '/var/mail/cltbld', 10:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:01 INFO - 'MOZ_NO_REMOTE': '1', 10:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:01 INFO - 'NO_EM_RESTART': '1', 10:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:01 INFO - 'PWD': '/builds/slave/test', 10:00:01 INFO - 'SHELL': '/bin/bash', 10:00:01 INFO - 'SHLVL': '1', 10:00:01 INFO - 'TERM': 'linux', 10:00:01 INFO - 'TMOUT': '86400', 10:00:01 INFO - 'USER': 'cltbld', 10:00:01 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', 10:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:01 INFO - '_': '/tools/buildbot/bin/python'} 10:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:02 INFO - Running setup.py (path:/tmp/pip-uovzqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:02 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)) 10:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:02 INFO - Running setup.py (path:/tmp/pip-Ub284K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:02 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)) 10:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:02 INFO - Running setup.py (path:/tmp/pip-Eb26BH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:02 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)) 10:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:02 INFO - Running setup.py (path:/tmp/pip-JuoRe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:02 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)) 10:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:02 INFO - Running setup.py (path:/tmp/pip-YVPzpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:02 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)) 10:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:02 INFO - Running setup.py (path:/tmp/pip-FDroSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:02 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)) 10:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:02 INFO - Running setup.py (path:/tmp/pip-OX7QXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:02 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)) 10:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:02 INFO - Running setup.py (path:/tmp/pip-vltM41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:02 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)) 10:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:02 INFO - Running setup.py (path:/tmp/pip-aeSnLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:02 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)) 10:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:02 INFO - Running setup.py (path:/tmp/pip-5X2Fjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:02 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)) 10:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:02 INFO - Running setup.py (path:/tmp/pip-hjm9EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:02 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)) 10:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:02 INFO - Running setup.py (path:/tmp/pip-cwhLuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:02 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)) 10:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:02 INFO - Running setup.py (path:/tmp/pip-0JuYR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:02 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)) 10:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:02 INFO - Running setup.py (path:/tmp/pip-NLajsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:03 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)) 10:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:03 INFO - Running setup.py (path:/tmp/pip-zT3OXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:03 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)) 10:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:03 INFO - Running setup.py (path:/tmp/pip-5BESHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:03 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)) 10:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:03 INFO - Running setup.py (path:/tmp/pip-w8n9O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:03 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)) 10:00:03 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)) 10:00:03 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)) 10:00:03 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)) 10:00:03 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)) 10:00:03 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)) 10:00:03 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)) 10:00:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:00:03 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 10:00:03 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 10:00:03 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 10:00:03 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 10:00:04 INFO - Downloading blessings-1.6.tar.gz 10:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:00:04 INFO - Installing collected packages: blessings 10:00:04 INFO - Running setup.py install for blessings 10:00:04 INFO - Successfully installed blessings 10:00:04 INFO - Cleaning up... 10:00:04 INFO - Return code: 0 10:00:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:00:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:04 INFO - Reading from file tmpfile_stdout 10:00:04 INFO - Current package versions: 10:00:04 INFO - argparse == 1.2.1 10:00:04 INFO - blessings == 1.6 10:00:04 INFO - blobuploader == 1.2.4 10:00:04 INFO - docopt == 0.6.1 10:00:04 INFO - functools32 == 3.2.3-2 10:00:04 INFO - jsonschema == 2.5.1 10:00:04 INFO - manifestparser == 1.1 10:00:04 INFO - mozInstall == 1.13 10:00:04 INFO - mozcrash == 1.0 10:00:04 INFO - mozdebug == 0.1 10:00:04 INFO - mozdevice == 0.51 10:00:04 INFO - mozfile == 1.2 10:00:04 INFO - mozhttpd == 0.7 10:00:04 INFO - mozinfo == 0.10 10:00:04 INFO - mozleak == 0.1 10:00:04 INFO - mozlog == 3.5 10:00:04 INFO - moznetwork == 0.27 10:00:04 INFO - mozprocess == 0.25 10:00:04 INFO - mozprofile == 0.28 10:00:04 INFO - mozrunner == 6.13 10:00:04 INFO - mozscreenshot == 0.1 10:00:04 INFO - mozsystemmonitor == 0.3 10:00:04 INFO - moztest == 0.8 10:00:04 INFO - mozversion == 1.4 10:00:04 INFO - psutil == 3.1.1 10:00:04 INFO - requests == 1.2.3 10:00:04 INFO - wsgiref == 0.1.2 10:00:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:04 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 0x24c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830090>, '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 0x2830d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282af90>, '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': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', '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 10:00:04 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 10:00:04 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 10:00:04 INFO - Using env: {'DISPLAY': ':0', 10:00:04 INFO - 'HOME': '/home/cltbld', 10:00:04 INFO - 'LANG': 'en_US.UTF-8', 10:00:04 INFO - 'LANGUAGE': 'en_US:en', 10:00:04 INFO - 'LOGNAME': 'cltbld', 10:00:04 INFO - 'MAIL': '/var/mail/cltbld', 10:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:04 INFO - 'MOZ_NO_REMOTE': '1', 10:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:04 INFO - 'NO_EM_RESTART': '1', 10:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:04 INFO - 'PWD': '/builds/slave/test', 10:00:04 INFO - 'SHELL': '/bin/bash', 10:00:04 INFO - 'SHLVL': '1', 10:00:04 INFO - 'TERM': 'linux', 10:00:04 INFO - 'TMOUT': '86400', 10:00:04 INFO - 'USER': 'cltbld', 10:00:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', 10:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:04 INFO - '_': '/tools/buildbot/bin/python'} 10:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:00:06 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)) 10:00:06 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)) 10:00:06 INFO - Installing collected packages: simplejson 10:00:06 INFO - Running setup.py install for simplejson 10:00:06 INFO - building 'simplejson._speedups' extension 10:00:06 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 10:00:07 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 10:00:07 INFO - Successfully installed simplejson 10:00:07 INFO - Cleaning up... 10:00:07 INFO - Return code: 0 10:00:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:07 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 0x24c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830090>, '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 0x2830d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282af90>, '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': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', '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 10:00:07 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 10:00:07 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 10:00:07 INFO - Using env: {'DISPLAY': ':0', 10:00:07 INFO - 'HOME': '/home/cltbld', 10:00:07 INFO - 'LANG': 'en_US.UTF-8', 10:00:07 INFO - 'LANGUAGE': 'en_US:en', 10:00:07 INFO - 'LOGNAME': 'cltbld', 10:00:07 INFO - 'MAIL': '/var/mail/cltbld', 10:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:07 INFO - 'MOZ_NO_REMOTE': '1', 10:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:07 INFO - 'NO_EM_RESTART': '1', 10:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:07 INFO - 'PWD': '/builds/slave/test', 10:00:07 INFO - 'SHELL': '/bin/bash', 10:00:07 INFO - 'SHLVL': '1', 10:00:07 INFO - 'TERM': 'linux', 10:00:07 INFO - 'TMOUT': '86400', 10:00:07 INFO - 'USER': 'cltbld', 10:00:07 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', 10:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:07 INFO - '_': '/tools/buildbot/bin/python'} 10:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:00:07 INFO - Cleaning up... 10:00:07 INFO - Return code: 0 10:00:07 INFO - Running post-action listener: _resource_record_post_action 10:00:07 INFO - Running post-action listener: _start_resource_monitoring 10:00:07 INFO - Starting resource monitoring. 10:00:07 INFO - [mozharness: 2017-10-11 17:00:07.533870Z] Finished create-virtualenv step (success) 10:00:07 INFO - [mozharness: 2017-10-11 17:00:07.534330Z] Running install step. 10:00:07 INFO - Running pre-action listener: _resource_record_pre_action 10:00:07 INFO - Running main action method: install 10:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:07 INFO - Reading from file tmpfile_stdout 10:00:07 INFO - Detecting whether we're running mozinstall >=1.0... 10:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:00:07 INFO - Reading from file tmpfile_stdout 10:00:07 INFO - Output received: 10:00:07 INFO - Usage: mozinstall [options] installer 10:00:07 INFO - Options: 10:00:07 INFO - -h, --help show this help message and exit 10:00:07 INFO - -d DEST, --destination=DEST 10:00:07 INFO - Directory to install application into. [default: 10:00:07 INFO - "/builds/slave/test"] 10:00:07 INFO - --app=APP Application being installed. [default: firefox] 10:00:07 INFO - mkdir: /builds/slave/test/build/application 10:00:07 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'] 10:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:00:22 INFO - Reading from file tmpfile_stdout 10:00:22 INFO - Output received: 10:00:22 INFO - /builds/slave/test/build/application/firefox/firefox 10:00:22 INFO - Running post-action listener: _resource_record_post_action 10:00:22 INFO - [mozharness: 2017-10-11 17:00:22.597047Z] Finished install step (success) 10:00:22 INFO - [mozharness: 2017-10-11 17:00:22.597294Z] Running setup-mitmproxy step. 10:00:22 INFO - Running pre-action listener: _resource_record_pre_action 10:00:22 INFO - Running main action method: setup_mitmproxy 10:00:22 INFO - Skipping: mitmproxy is not required 10:00:22 INFO - Running post-action listener: _resource_record_post_action 10:00:22 INFO - [mozharness: 2017-10-11 17:00:22.598393Z] Finished setup-mitmproxy step (success) 10:00:22 INFO - [mozharness: 2017-10-11 17:00:22.598615Z] Running run-tests step. 10:00:22 INFO - Running pre-action listener: _resource_record_pre_action 10:00:22 INFO - Running pre-action listener: _set_gcov_prefix 10:00:22 INFO - Running main action method: run_tests 10:00:22 WARNING - Try message not found. 10:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:00:22 INFO - Python 2.7.3 10:00:22 INFO - Return code: 0 10:00:22 INFO - grabbing minidump binary from tooltool 10:00:22 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')]} 10:00:22 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 0x2830090>, '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 0x2830d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:00:22 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 10:00:22 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 10:00:22 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 10:00:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:00:22 INFO - Return code: 0 10:00:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:00:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:00:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:00:22 INFO - ENV: RUST_BACKTRACE is now full 10:00:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:00:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 10:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 10:00:22 INFO - Using env: {'DISPLAY': ':0', 10:00:22 INFO - 'HOME': '/home/cltbld', 10:00:22 INFO - 'LANG': 'en_US.UTF-8', 10:00:22 INFO - 'LANGUAGE': 'en_US:en', 10:00:22 INFO - 'LOGNAME': 'cltbld', 10:00:22 INFO - 'MAIL': '/var/mail/cltbld', 10:00:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:00:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:22 INFO - 'MOZ_NO_REMOTE': '1', 10:00:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:22 INFO - 'NO_EM_RESTART': '1', 10:00:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:22 INFO - 'PWD': '/builds/slave/test', 10:00:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:00:22 INFO - 'RUST_BACKTRACE': 'full', 10:00:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:00:22 INFO - 'SHELL': '/bin/bash', 10:00:22 INFO - 'SHLVL': '1', 10:00:22 INFO - 'TERM': 'linux', 10:00:22 INFO - 'TMOUT': '86400', 10:00:22 INFO - 'USER': 'cltbld', 10:00:22 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', 10:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:22 INFO - '_': '/tools/buildbot/bin/python'} 10:00:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 10:00:22 INFO - mozversion application_buildid: 20171011153902 10:00:22 INFO - mozversion application_changeset: 973f61d8b175a1aa0109d4a6f1a3b3a75a3fc782 10:00:22 INFO - mozversion application_display_name: Firefox 10:00:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:00:22 INFO - mozversion application_name: Firefox 10:00:22 INFO - mozversion application_remotingname: firefox 10:00:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:00:22 INFO - mozversion application_vendor: Mozilla 10:00:22 INFO - mozversion application_version: 57.0 10:00:22 INFO - mozversion platform_buildid: 20171011153902 10:00:22 INFO - mozversion platform_changeset: 973f61d8b175a1aa0109d4a6f1a3b3a75a3fc782 10:00:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:00:22 INFO - mozversion platform_version: 57.0 10:00:22 INFO - using testdate: 1507741222 10:00:22 INFO - actual date: 1507741222 10:00:22 INFO - starting webserver on 'localhost:49952' 10:00:22 INFO - SUITE-START | Running 2 tests 10:00:22 INFO - TEST-START | dromaeo_css 10:00:22 INFO - Initialising browser for dromaeo_css test... 10:00:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49952/getInfo.html -profile /tmp/tmpVdFNgn/profile 10:00:22 INFO - TEST-INFO | started process 8334 (/builds/slave/test/build/application/firefox/firefox http://localhost:49952/getInfo.html) 10:00:28 INFO - TEST-INFO | 8334: exit 0 10:00:28 INFO - Browser initialized. 10:00:28 INFO - Running cycle 1/1 for dromaeo_css test... 10:00:28 INFO - Using env: {'DISPLAY': ':0', 10:00:28 INFO - 'HOME': '/home/cltbld', 10:00:28 INFO - 'JSGC_DISABLE_POISONING': '1', 10:00:28 INFO - 'LANG': 'en_US.UTF-8', 10:00:28 INFO - 'LANGUAGE': 'en_US:en', 10:00:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:00:28 INFO - 'LOGNAME': 'cltbld', 10:00:28 INFO - 'MAIL': '/var/mail/cltbld', 10:00:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:00:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:00:28 INFO - 'MOZ_CRASHREPORTER': '1', 10:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:00:28 INFO - 'MOZ_NO_REMOTE': '1', 10:00:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:28 INFO - 'NO_EM_RESTART': '1', 10:00:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:28 INFO - 'PWD': '/builds/slave/test', 10:00:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:00:28 INFO - 'RUST_BACKTRACE': 'full', 10:00:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:00:28 INFO - 'SHELL': '/bin/bash', 10:00:28 INFO - 'SHLVL': '1', 10:00:28 INFO - 'TERM': 'linux', 10:00:28 INFO - 'TMOUT': '86400', 10:00:28 INFO - 'USER': 'cltbld', 10:00:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', 10:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:28 INFO - '_': '/tools/buildbot/bin/python'} 10:00:28 INFO - TEST-INFO | started process 8567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVdFNgn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:00:28 INFO - PID 8567 | 10:00:28 INFO - PID 8567 | (/builds/slave/test/build/application/firefox/firefox:8615): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:00:28 INFO - PID 8567 | 10:00:39 INFO - PID 8567 | RSS: Main: 143020032 10:00:39 INFO - PID 8567 | 10:03:35 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:49952/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49952/tests/dromaeo/cssquery-ext.html) 10:03:36 INFO - PID 8567 | RSS: Main: 145563648 10:03:36 INFO - PID 8567 | 10:06:38 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:49952/tests/dromaeo/cssquery-ext.html (next: http://localhost:49952/tests/dromaeo/cssquery-jquery.html) 10:06:38 INFO - PID 8567 | RSS: Main: 144416768 10:06:38 INFO - PID 8567 | 10:09:40 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:49952/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49952/tests/dromaeo/cssquery-mootools.html) 10:09:40 INFO - PID 8567 | RSS: Main: 145395712 10:09:40 INFO - PID 8567 | 10:12:42 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:49952/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49952/tests/dromaeo/cssquery-prototype.html) 10:12:42 INFO - PID 8567 | RSS: Main: 145608704 10:12:42 INFO - PID 8567 | 10:15:45 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:49952/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49952/tests/dromaeo/cssquery-yui.html) 10:15:46 INFO - PID 8567 | RSS: Main: 147206144 10:15:46 INFO - PID 8567 | 10:18:47 INFO - PID 8567 | Cycle 1(1): loaded http://localhost:49952/tests/dromaeo/cssquery-yui.html (next: http://localhost:49952/tests/dromaeo/cssquery-dojo.html) 10:18:48 INFO - PID 8567 | RSS: Main: 148824064 10:18:48 INFO - PID 8567 | 10:18:48 INFO - PID 8567 | __start_tp_report 10:18:48 INFO - PID 8567 | _x_x_mozilla_page_load 10:18:48 INFO - PID 8567 | _x_x_mozilla_page_load_details 10:18:48 INFO - PID 8567 | |i|pagename|runs| 10:18:48 INFO - PID 8567 | |0;dojo.html;3935.5474120476138;3946.960530394696;3951.762894226347;3957.901052473686;3998.1403998140413;6357.427831495171;6369.968150159249;6407.871842563158;6422.550421470499;6434.227892652876;6367.981123020318;6369.936300636992;6371.872562548758;6506.934930650692;6522.380373864476;5642.633228840123;5684.630499017571;5777.508911742507;5802.97098514509;5885.735141918624;5644.971775141119;5713.942860571404;5735.139729040636;5766.942330576703;5774.133879918025;5699.943000570003;5768.39431859655;5841.094630332305;5851.034579294412;5868.882622347551;5729.5702822288495;5768.048272035109;5832.737526811304;5834.154047663065;5867.882642347129;5656.490915817555;5712.514436272922;5770.971145144247;5850.385709500484;5854.853628659275;6321.24145102586;6350.142730731338;6352.1742173517605;6369.93630063698;6404.359564043605;6848.657567121674;6897.275786042494;6924.203716572558;6925.619090949996;6995.02069710241;6933.618650974195;6946.826329341757;6960.408365288957;7041.753538626123;7049.154101507852;6408.487321014308;6411.6153030818305;6475.967620161916;6479.222493300834;6484.675766211718;7065.858682826315;7096.325849044332;7100.183478899992;7135.322144396274;7217.891731623925;6816.352446517573;6906.551074180162;6916.585004899622;6920.100386949765;6929.930700692928;6969.616671083139;6986.336298051779;6987.965060174666;7069.399101076363;7070.045543851617;6746.426553742888;6844.8973265401055;6876.243613202544;6945.51381403307;6949.305069493112;6820.488463365168;6882.4149947254045;6885.552439091443;6916.51584389098;6941;5130.256112863689;5171.896562068738;5192.273081768555;5199.090159222121;5208.348956380452;4635;4665.230237010923;4694.460137084279;4698.647601429906;4708.293755936637;6552.344765523505;6557.606543607399;6570.441512471398;6610.041543976096;6626.039224312448;6899.724011039602;6921.134858142732;6951.513394062367;6997.650117494105;7035.753748618774;6408.67956602168;6489.123968264318;6523.380278873499;6551.344865513411;6563.409293163638;5790.131480277908;5822.0684690449325;5844.59087863854;5892.734826932799;5931.436513531207;7113.857722845514;7194.604296763624;7203.531770434905;7292.963535182396;7327.157376901724;6879.208890977501;6929.099217101744;6963.9303606963285;7011.649417529001;7015.123109611299;7217.566945983258;7263.309985551364;7297.270272972661;7313.670884810303;7342.853142937218;6774.220964589135;6776.424003959719;6792.286809885089;6870.931290687229;6964.930350696428;6990.405815505739;7057.894131588133;7058.752943646948;7067.787966361017;7077.221505634479;6656.30108838565;6677.833054173684;6685.331466853276;6707.228668703162;6782.898256526058;6689.49828762835;6703.865922681422;6766.830829229309;6781.084553585203;6783.694733737092;6664.466842652673;6673.299303573249;6714.127163468718;6723.7646682365885;6763.391294783493;6688.398044176048;6767.796966091025;6790.796276111724;6799.912014077724;6863.794086177422;6521.119648847345;6531.020346947996;6594.142761440982;6602.8679426410245;6616.073749675145 10:18:48 INFO - PID 8567 | |1;ext.html;973.4159504297418;974.3812678948865;996.3922007575378;1028.8713910761155;1036.2642523808101;45420.545794542086;46244.306335404995;46285.53714462854;46289.999999999956;46314.53685463144;43770.56229437704;43908.341374879325;43923.34114988278;44055.559444405546;44222.55777442225;7897.881531777013;8036.196380361976;8056.315213206855;8101.02787665481;8114.715984940528;8081.111077781439;8110.472819266758;8147.307478864303;8182.7545173644585;8184.590770461483;8291.751247462556;8464.44981076228;8469.19542643451;8503.74488765338;8508.78728031798;8399.076101628816;8498.957505212496;8500.872486912733;8504.234618884268;8507.65969361231;8644.740657780214;8780.078091800397;8809.955950220208;8854.203121719076;8856.291496680315;41505;41512.58487415117;41743.791281043705;41924.37113443301;42005.78997104995;3862.7296089273764;3862.7682339059747;3868.9806550967346;3883.708721845873;3904.121572646132;34110.12394318311;34444.311113777585;34484.13789655254;34520.309593807986;34621.480677789856;5647.774089036434;5659.462351076641;5696.430356964312;5704.067769519695;5825.563082768767;240720;241146;241299.99999999825;242078;242578;54090;54112.729436352565;54209;54314;54314.45685543173;57296.42703572994;57424.712876436184;57428.13857792137;57433.13850292249;57618.135727964116;17279.91360043192;17296.308147673953;17335.56661083483;17353;17364;14170.220637865017;14173.574792756233;14181.432742690384;14264.572062837924;14318.85681143196;15667.37330506767;15895.602609934844;15910.204489775464;15938.28277727505;15973.520794376187;6304.211973503312;6421.711023003976;6422.582532135396;6443.355664433519;6466.385693359123;1100.9394483303495;1128.1877048525048;1135.9034482069117;1136.5851464215666;1144.067584918289;25930.481390372086;26372;26374.604380934303;26387.47225055488;26514.469710606067;1200.1359021504502;1223.706310485495;1226.533917111492;1238.6036468330228;1240.2806372304042;13747.312634368442;13962.790558141636;13999.580012599637;14175.71648567023;14184.787228191379;274018;274225;299486;303487;303520;64338.67830660817;64684.35315646877;64811;64911.67544162343;65576.34423655798;1536.8693661038712;1542.3984645988073;1549.7985261915878;1555.5488908216944;1573.1819453883916;30864;30984.22539436532;31043.84478077595;31059.534106988864;31186.376272474878;43534;43629;43678.56321436872;43680.344794828736;43762.78118609387;266209;268311;269773;271111;272254;38169.42745858759;38269;38464.2307153861;38669;38687.806560967016;48380;48416;48466;48747;48763.756181220284;34609.826950865085;35324.64675353316;35542.822285888404;35900.461493077106;36174.27651447009;35249;35668;35993.64006359903;36007.27985440329;36081.458778118875;41508;41581.1683766329;41981.37027944522;41995.37006944837;42129.57870421379;33620.3275934475;34019.31961360709;34068.65931340655;34146.829265853514;34617.48073778845;25733.871330643226;25945.610815838154;26088.608670869573;26137.6079358806;26279.21162365132 10:18:48 INFO - PID 8567 | |2;jquery.html;635.9315865379962;645.183431140396;648.3333497551508;649.6267365402678;651.6014817239173;25125.74874251257;25603.74396256037;25662.10182643608;25712.742872571314;25741;24034;24523.509529809395;24595.877020614917;24638.876805615946;24645.260642180765;6637.236717777445;6856.2800905904905;6968.163820341566;6975.058367120425;6991.335823096823;6901.8964715529055;7001.509894307401;7011.298870112999;7014.088168538083;7021.368076873106;6747.932520674804;6964.930350696504;6969.233384327746;6970.686319115652;6997.65011749413;7034;7075.610841403721;7082.468814838908;7083.043789088484;7084.504084714072;6608.074869518271;6610.0745895574655;6648.335166483313;6660.866782664368;6664.93335066648;30762.077137685905;31266;31840.522392164137;31842.840785796154;32231.51652725211;2297.8506397084134;2370.988145059281;2384.5946189147885;2386.4391867911027;2396.2930935374106;21257.255996040065;21773.673394899088;21788.346349609536;21798.237061702923;21929.451763705874;2604.322876052221;2675.3712877473777;2687.4490729400427;2690.0719251858077;2712.2541301142146;152074;155761.22119389445;157596.2120189403;163718;170806;16888;17105.82894171067;17253.82746172522;17446.38937637202;17634.559136021446;27235.591466128022;27325.86337068302;27470.72529274722;27530.724692752818;27669.446611067666;10717.9464102679;10732.409717465458;10889.237753357189;10948.56205751761;10955.616553420592;9637.37357071788;9686.660966866126;9777.755556111155;9784.070513301225;9856.556454959544;9794.902050979399;9982.251331150193;10135.148643515417;10230.897691022994;10398.220133490018;2896.174590241813;2898.8835853088663;2965.8368789716774;3004.9699503005127;3098.690130986883;1018.9643362482277;1048.9318194317345;1052.7894421115807;1059.9470026498643;1063.186662203415;21460.141594336365;21564.676529852066;21727.13091476323;21854;21906.78093219079;1123.938183399921;1128.2835399521364;1129.3506233915532;1130.591839382111;1136.6476392318243;11606.76786464266;11768.411579420994;11853.822192667118;11981.88018119825;12015.819762703566;599340;603073;620930;623421;625697;137863;138357;139472.30263848818;144115;144246;1235.308227392663;1279.1493656718178;1279.181323952671;1284.5953524639708;1285.9614211573669;18566.907165464087;18900.14949327311;19021.809781902004;19030.524236894187;19055;62797.372026279154;63038.68480657567;63199.368006319346;64081.35918640754;64216;80814;81097;81388.5930570367;81730.59134704288;84082;16006.279717412977;16216.270267837739;16236.51290461288;16358.427455039016;16368.345266189219;24415.145469908468;24429.14497992633;24563.140290089763;24588.1394151211;24613.13854015101;19560.902195488932;19607;19799.208031678572;20077.29729459462;20171.69742453835;17491.300347986446;17735.29058837632;17872;18239.635207296044;18274.543136421697;20394;20510.897445512677;20720.378388648365;20874.895625522382;21036.47408814792;15715.607109822346;15855.12796796141;15856.44502442409;15916;15967;19588.706169407757;19599.804001959797;19742;19753.802461975196;19782.70325945083 10:18:48 INFO - PID 8567 | |3;mootools.html;1407.1627381707883;1465.8021167142433;1471.0658731705366;1475.3066058952302;1488.8734457571106;17093.145342732874;17904.194311255993;17913.641727165465;17923.731144032834;17934.192961316738;17383.47849564512;17417;17428.56428589286;17510.82489175108;17571.2092955817;3080.3531258435755;3175.555422240888;3218.8390580471;3220.661830507798;3221.2752130770623;3044.5737596736476;3066.555349474325;3145.826979516126;3149.8425078746086;3150.7006834350814;3134.5611614374006;3161.3361194149143;3175.6506784253716;3180.570622965893;3190.6330771961175;3054.7861649684532;3064.2952121012067;3066.310080231941;3080.8921687740935;3082.152408087771;3000.834954077525;3015.9396812063856;3046.4973279408873;3059.2963618367676;3059.7858149929516;17011.064391458465;17325.7401138983;17383.73924391135;17391.565210869703;17397.565060873454;9122.86315705265;9434.150926416656;9436.150746432853;9438;9467.384619999746;5977.491913187384;6111.960966635638;6310.9684451577905;6347.873042539123;6362.5546211765195;2112.2712664131004;2161.9891900540556;2185.737711474633;2221.1226565506536;2222.3110835641005;31850;31931.52102718461;31967.680323196702;31980.840095799605;32036.359272814414;7671.117821450604;7836.960815196002;7955.960220198862;8004.51972881629;8048.154943730941;21006.789932100484;21014.78985210159;21016.684749728767;21047.78952210489;21108.261210857545;8981.910180898238;9132.543372831331;9170.08299170091;9180;9181.219596334386;8173.754787356389;8248.917510824935;8323.209295116954;8359.874601880976;8447.028591711909;5825.242718446575;5889.411058894077;5896.64620122794;5923.674197919156;5980.850478738066;1537.6463413414976;1601.455505128262;1639.3114891745495;1652.2234549761592;1656.6355401811581;1010.8483727440943;1033.6485594897772;1034.182995433614;1045.6549338718205;1046.40877903984;10003.199744020461;10300.690979270634;10338.431386273827;10468.947655261827;10534.262601617813;1100.4112799652148;1106.618216715232;1118.2731224704007;1119.1047162270152;1122.399516258814;5481.424450432647;5509.256250406143;5638.182463542763;5659.518940889988;5684.033714268584;25644.230673079837;25900.8704956474;26407.33981650474;26787.464250715268;27178.456430871272;25654.102106426184;26107.869460652575;26176;26380.60429093565;26453.33866653349;12926.741465170644;12970.286634235208;13273.867261327456;13299.800502992462;13332.600021999355;9655.565499552396;9726.902730972883;9766;9845.113939745172;10009.69970900874;22492;22533.43666408353;22615.547689046456;22748.886255568617;23031.193908213132;23675.64486532738;23819.404514887265;23826.16608418697;23902.402439939142;23910.52178956446;12577.93711031439;12665;12815.102942793916;12866.742665146458;12884.162529435556;15179.620509487351;15384.38462461489;15408;15510.689786204439;16194.595135121715;12936.547220847226;13225.669358266121;13390.397432115384;13500.729985400434;13597.864021360056;12652.936735316265;12738.172018818746;12758.425870836021;12775.61673149807;13098;11600.18798684084;11669.824952625548;11675;11818.822717659414;11866.110041747077;8506.362022848434;8600.870986935326;8696.565171741515;8749.037605863223;8786.604602792762;8473.78815529592;8617.48295102296;8643.26532244741;8671.956640216758;8730.65077396897 10:18:48 INFO - PID 8567 | |4;prototype.html;559.1696330948538;563.1159080244014;585.5549782165555;606.4238972975672;609.3997412548639;6216.347283535231;6313.179286692729;6512.902306465407;6546.54174207805;6547.148870646821;6372.617642941426;6398.808035758923;6404.903926441107;6460;6477.287498375187;5307.283516725251;5348.839534813962;5382.6232163748555;5394.05604019297;5411.648242864201;5112.642115051929;5152.536271735543;5187.187417248319;5230.686158830464;5249.868753281179;5163.638545301812;5172.586193104543;5173.870653233662;5190.71451070191;5209.244659524366;5166.870828229286;5207.687538747649;5209;5223.71269580173;5235.136202526579;4747.596454301389;4779.163646361908;4787.329773831666;4793.32893394925;4800.255960326155;6348.746050157988;6390.3609639036185;6421.261554921197;6440.4847612190915;6456.967715161441;6037.486813620848;6049.848753781191;6055.122007308915;6064.211652485193;6082.813851298998;6742.662866856637;6827.146606674166;6846.520743547953;6846.931530684679;6862.769599880059;5057.974710126463;5283.2075188722;5286.788528458857;5296.364436267634;5309.283246761715;6919.792406227822;6976.5814051157095;7070.717171313141;7130.2869713028285;7213.963930180315;5444.564434845282;5454.4545545445935;5458.617896747269;5463.781448742086;5472.124460086367;5491.807786727445;5506.284183056177;5508.55931525477;5528.917066244009;5549.5837812164245;6036.667983260875;6072.696365181723;6087.3303936566945;6095.3904609538695;6144.2319710036245;6906;6916.619585922722;6944.895826562605;6968.407685346802;6988.965055174794;1888.3862744608057;1892.8864268143955;1902.1250224896703;1911.445680752594;1933.497290704399;1314.3822403470353;1338.7255612599395;1355.8508564057945;1355.986440135586;1375.5460697969645;6316.652584107826;6466.8682980478225;6497.18785151856;6500.609963402211;6562.442192413699;6885.139357580302;6904.515529161154;6945.791626251221;6980;6987.965060174768;6430.64631445275;6508.544401891822;6548.443382312462;6554.213494380705;6557.639329836809;3670.1465759791135;3686.557613086447;3711.554613446404;3712.480252764615;3719.014461167793;7028.156621205488;7147.53541019832;7227.747028853965;7273.163586187656;7282.198958114604;7009.773289674388;7026.613536255452;7036.92963070373;7079.504434689522;7105.751298704624;7066.293370662996;7124.145102587722;7135.928640713734;7187.5687458752645;7206.315400036988;6862.656867156722;6880.724771009103;6930.584164950119;6951.687174077279;6965.22386791365;6800;6873.518853680394;6917.342852429011;6948.374646281859;7002.579845209304;7275.454340924558;7292.812156352967;7307.8538429232185;7356.632168391452;7359.889601655872;5436.238926550207;5449.04641687711;5452.482014208644;5462.453754624506;5488.121900495901;6684;6716.83207919806;6977.2673869243;6984.301569842975;7034.5427547209265;6682.997550367484;6694.192568006708;6701.698423570853;6728.865422691617;6798.286179951034;6552.8361790955605;6582.374674406115;6647.5014373921185;6716.462682985447;6755.966220168868;6616.7022483987375;6625.635590042594;6671.966640166768;6679.532432729857;6702.430293425114;6793.414445249536;6820.556663816836;6832.180138383425;6849.589024658537;6906.205786334435;6624.8343791405605;6630.270670226368;6682.565633233824;6691.899621505779;6739.966300168468 10:18:48 INFO - PID 8567 | |5;yui.html;1000.8398656215007;1037.2998226197317;1042.7914417116574;1048.035807057507;1059.3008614314551;21907.561848763016;22312.88843555784;22318.776812231892;22339.329820105384;22349.776502234974;20016.799832001674;20067.598648027066;21137.365879023615;21323.25368612099;21350.89324553375;1059.1156384419;1091.170710260204;1094.370736826324;1094.813881640123;1095.6767753512693;1031.3554028732042;1070.5236169904397;1075.688050465364;1094.5402930769055;1119.5969450997634;1139.692283083567;1141.0472255666527;1141.3209140561394;1142.0520967596917;1142.8285757136414;1130.8982191602754;1141.058626633031;1141.7431078007423;1141.948612312448;1150.0971737186353;837.6105111123356;843.6920524008692;848.3849209323253;848.9405741598091;849.5327569836627;22139.225127120633;22497.212597559006;22567.887160564256;22625.886870565708;22945.31164065081;23906.76093239063;24003;24546.631800523006;24591.38521536958;24682;19534.31629892947;19601.31395401154;19703.113359898838;19737.111829967685;19747.308844190386;4120.402541631476;4171.040660648037;4177.603127702863;4179.686523510749;4181.975416023063;158644;163764;163955;165688;167189;17574.736378954327;17640.735388969177;17737.556561086076;17792.822071779116;17923.37268195633;35044.64955350414;35310.823445882605;35619.28761424757;35674.8216258917;35688.46467302993;9759.316847820584;9796.755081123029;9888.357256778287;9892.060254275832;9937.65218217359;4799.6400269979895;4876.609871210295;4880.194767863334;4893.877653058702;4924.778384972685;6188.133661287423;6305.14880491137;6309.274433440213;6369.490440764727;6377.904331435032;1195.0618764270007;1216.1243904388825;1219.3963987826082;1221.5113954418305;1228.1157566552067;767.5739964319856;768.1972338905857;782.9725959591387;785.9056913170456;799.9800004999921;12223.511059557695;12869;13669.111507751964;14261.719804445036;14531.418743250151;790.2768966395798;793.4485532554819;799.7720649614948;800.8718605023284;809.7085049382217;6457.128287681103;6481.935180648133;6509.9023514647315;6558.475321974231;6571.80284591463;152911;153076;153769;158194;159859;105554;108855;130136.3493182547;130646;138187.30906345404;108657;109551.45224273828;115975;116471;119812.40093799475;13771.242581658105;14116;14516.709665806837;14924.776128357866;14979.775303370676;54219;55045;55621.72189139028;55694.44305557055;57936.42063579479;99190;103163;103614;104467.4776626112;106079;20171.193152273743;20218.292359767336;20250.493737656678;20496.79503204949;20561.97190140517;23178.652320215548;23590.410239743458;23689.763102368757;23732.525349492567;23751.52496950017;21798.891005544872;22120.778792211873;22376.88811555932;22398.552028959657;22408.215712449986;20843.895780521;21014.68477972862;21210.469738256666;21220.575588488453;21488.355349339545;20783.896080520106;20941.267055652977;21348.466288342916;21401.67897481508;21503.677444838653;16096;16323;16372.345106196095;16389.34442622282;16541.66916661684;15163;15538.689226215638;15734;15904.204789760235;15957 10:18:48 INFO - PID 8567 | __end_tp_report 10:18:48 INFO - PID 8567 | __start_cc_report 10:18:48 INFO - PID 8567 | _x_x_mozilla_cycle_collect,260 10:18:48 INFO - PID 8567 | __end_cc_report 10:18:48 INFO - PID 8567 | __startTimestamp1507742328081__endTimestamp 10:18:48 INFO - PID 8567 | 10:18:48 INFO - PID 8567 | ------- Summary: start ------- 10:18:48 INFO - PID 8567 | Number of tests: 6 10:18:48 INFO - PID 8567 | 10:18:48 INFO - PID 8567 | [#0] dojo.html Cycles:165 Average:6418.32 Median:6673.30 stddev:745.17 (11.2%) stddev-sans-first:721.55 10:18:48 INFO - PID 8567 | Values: 3935.5 3947.0 3951.8 3957.9 3998.1 6357.4 6370.0 6407.9 6422.6 6434.2 6368.0 6369.9 6371.9 6506.9 6522.4 5642.6 5684.6 5777.5 5803.0 5885.7 5645.0 5713.9 5735.1 5766.9 5774.1 5699.9 5768.4 5841.1 5851.0 5868.9 5729.6 5768.0 5832.7 5834.2 5867.9 5656.5 5712.5 5771.0 5850.4 5854.9 6321.2 6350.1 6352.2 6369.9 6404.4 6848.7 6897.3 6924.2 6925.6 6995.0 6933.6 6946.8 6960.4 7041.8 7049.2 6408.5 6411.6 6476.0 6479.2 6484.7 7065.9 7096.3 7100.2 7135.3 7217.9 6816.4 6906.6 6916.6 6920.1 6929.9 6969.6 6986.3 6988.0 7069.4 7070.0 6746.4 6844.9 6876.2 6945.5 6949.3 6820.5 6882.4 6885.6 6916.5 6941.0 5130.3 5171.9 5192.3 5199.1 5208.3 4635.0 4665.2 4694.5 4698.6 4708.3 6552.3 6557.6 6570.4 6610.0 6626.0 6899.7 6921.1 6951.5 6997.7 7035.8 6408.7 6489.1 6523.4 6551.3 6563.4 5790.1 5822.1 5844.6 5892.7 5931.4 7113.9 7194.6 7203.5 7293.0 7327.2 6879.2 6929.1 6963.9 7011.6 7015.1 7217.6 7263.3 7297.3 7313.7 7342.9 6774.2 6776.4 6792.3 6870.9 6964.9 6990.4 7057.9 7058.8 7067.8 7077.2 6656.3 6677.8 6685.3 6707.2 6782.9 6689.5 6703.9 6766.8 6781.1 6783.7 6664.5 6673.3 6714.1 6723.8 6763.4 6688.4 6767.8 6790.8 6799.9 6863.8 6521.1 6531.0 6594.1 6602.9 6616.1 10:18:48 INFO - PID 8567 | 10:18:48 INFO - PID 8567 | [#1] ext.html Cycles:180 Average:45287.44 Median:3862.75 stddev:69791.19 (1806.8%) stddev-sans-first:69907.66 10:18:48 INFO - PID 8567 | Values: 973.4 974.4 996.4 1028.9 1036.3 45420.5 46244.3 46285.5 46290.0 46314.5 43770.6 43908.3 43923.3 44055.6 44222.6 7897.9 8036.2 8056.3 8101.0 8114.7 8081.1 8110.5 8147.3 8182.8 8184.6 8291.8 8464.4 8469.2 8503.7 8508.8 8399.1 8499.0 8500.9 8504.2 8507.7 8644.7 8780.1 8810.0 8854.2 8856.3 41505.0 41512.6 41743.8 41924.4 42005.8 3862.7 3862.8 3869.0 3883.7 3904.1 34110.1 34444.3 34484.1 34520.3 34621.5 5647.8 5659.5 5696.4 5704.1 5825.6 240720.0 241146.0 241300.0 242078.0 242578.0 54090.0 54112.7 54209.0 54314.0 54314.5 57296.4 57424.7 57428.1 57433.1 57618.1 17279.9 17296.3 17335.6 17353.0 17364.0 14170.2 14173.6 14181.4 14264.6 14318.9 15667.4 15895.6 15910.2 15938.3 15973.5 6304.2 6421.7 6422.6 6443.4 6466.4 1100.9 1128.2 1135.9 1136.6 1144.1 25930.5 26372.0 26374.6 26387.5 26514.5 1200.1 1223.7 1226.5 1238.6 1240.3 13747.3 13962.8 13999.6 14175.7 14184.8 274018.0 274225.0 299486.0 303487.0 303520.0 64338.7 64684.4 64811.0 64911.7 65576.3 1536.9 1542.4 1549.8 1555.5 1573.2 30864.0 30984.2 31043.8 31059.5 31186.4 43534.0 43629.0 43678.6 43680.3 43762.8 266209.0 268311.0 269773.0 271111.0 272254.0 38169.4 38269.0 38464.2 38669.0 38687.8 48380.0 48416.0 48466.0 48747.0 48763.8 34609.8 35324.6 35542.8 35900.5 36174.3 35249.0 35668.0 35993.6 36007.3 36081.5 41508.0 41581.2 41981.4 41995.4 42129.6 33620.3 34019.3 34068.7 34146.8 34617.5 25733.9 25945.6 26088.6 26137.6 26279.2 10:18:48 INFO - PID 8567 | 10:18:48 INFO - PID 8567 | [#2] jquery.html Cycles:180 Average:40923.14 Median:2385.52 stddev:103244.14 (4328.0%) stddev-sans-first:103489.45 10:18:48 INFO - PID 8567 | Values: 635.9 645.2 648.3 649.6 651.6 25125.7 25603.7 25662.1 25712.7 25741.0 24034.0 24523.5 24595.9 24638.9 24645.3 6637.2 6856.3 6968.2 6975.1 6991.3 6901.9 7001.5 7011.3 7014.1 7021.4 6747.9 6964.9 6969.2 6970.7 6997.7 7034.0 7075.6 7082.5 7083.0 7084.5 6608.1 6610.1 6648.3 6660.9 6664.9 30762.1 31266.0 31840.5 31842.8 32231.5 2297.9 2371.0 2384.6 2386.4 2396.3 21257.3 21773.7 21788.3 21798.2 21929.5 2604.3 2675.4 2687.4 2690.1 2712.3 152074.0 155761.2 157596.2 163718.0 170806.0 16888.0 17105.8 17253.8 17446.4 17634.6 27235.6 27325.9 27470.7 27530.7 27669.4 10717.9 10732.4 10889.2 10948.6 10955.6 9637.4 9686.7 9777.8 9784.1 9856.6 9794.9 9982.3 10135.1 10230.9 10398.2 2896.2 2898.9 2965.8 3005.0 3098.7 1019.0 1048.9 1052.8 1059.9 1063.2 21460.1 21564.7 21727.1 21854.0 21906.8 1123.9 1128.3 1129.4 1130.6 1136.6 11606.8 11768.4 11853.8 11981.9 12015.8 599340.0 603073.0 620930.0 623421.0 625697.0 137863.0 138357.0 139472.3 144115.0 144246.0 1235.3 1279.1 1279.2 1284.6 1286.0 18566.9 18900.1 19021.8 19030.5 19055.0 62797.4 63038.7 63199.4 64081.4 64216.0 80814.0 81097.0 81388.6 81730.6 84082.0 16006.3 16216.3 16236.5 16358.4 16368.3 24415.1 24429.1 24563.1 24588.1 24613.1 19560.9 19607.0 19799.2 20077.3 20171.7 17491.3 17735.3 17872.0 18239.6 18274.5 20394.0 20510.9 20720.4 20874.9 21036.5 15715.6 15855.1 15856.4 15916.0 15967.0 19588.7 19599.8 19742.0 19753.8 19782.7 10:18:48 INFO - PID 8567 | 10:18:48 INFO - PID 8567 | [#3] mootools.html Cycles:180 Average:11020.07 Median:24777.38 stddev:8104.68 (32.7%) stddev-sans-first:8095.24 10:18:48 INFO - PID 8567 | Values: 1407.2 1465.8 1471.1 1475.3 1488.9 17093.1 17904.2 17913.6 17923.7 17934.2 17383.5 17417.0 17428.6 17510.8 17571.2 3080.4 3175.6 3218.8 3220.7 3221.3 3044.6 3066.6 3145.8 3149.8 3150.7 3134.6 3161.3 3175.7 3180.6 3190.6 3054.8 3064.3 3066.3 3080.9 3082.2 3000.8 3015.9 3046.5 3059.3 3059.8 17011.1 17325.7 17383.7 17391.6 17397.6 9122.9 9434.2 9436.2 9438.0 9467.4 5977.5 6112.0 6311.0 6347.9 6362.6 2112.3 2162.0 2185.7 2221.1 2222.3 31850.0 31931.5 31967.7 31980.8 32036.4 7671.1 7837.0 7956.0 8004.5 8048.2 21006.8 21014.8 21016.7 21047.8 21108.3 8981.9 9132.5 9170.1 9180.0 9181.2 8173.8 8248.9 8323.2 8359.9 8447.0 5825.2 5889.4 5896.6 5923.7 5980.9 1537.6 1601.5 1639.3 1652.2 1656.6 1010.8 1033.6 1034.2 1045.7 1046.4 10003.2 10300.7 10338.4 10468.9 10534.3 1100.4 1106.6 1118.3 1119.1 1122.4 5481.4 5509.3 5638.2 5659.5 5684.0 25644.2 25900.9 26407.3 26787.5 27178.5 25654.1 26107.9 26176.0 26380.6 26453.3 12926.7 12970.3 13273.9 13299.8 13332.6 9655.6 9726.9 9766.0 9845.1 10009.7 22492.0 22533.4 22615.5 22748.9 23031.2 23675.6 23819.4 23826.2 23902.4 23910.5 12577.9 12665.0 12815.1 12866.7 12884.2 15179.6 15384.4 15408.0 15510.7 16194.6 12936.5 13225.7 13390.4 13500.7 13597.9 12652.9 12738.2 12758.4 12775.6 13098.0 11600.2 11669.8 11675.0 11818.8 11866.1 8506.4 8600.9 8696.6 8749.0 8786.6 8473.8 8617.5 8643.3 8672.0 8730.7 10:18:48 INFO - PID 8567 | 10:18:48 INFO - PID 8567 | [#4] prototype.html Cycles:180 Average:5835.34 Median:6498.90 stddev:1607.96 (24.7%) stddev-sans-first:1562.94 10:18:48 INFO - PID 8567 | Values: 559.2 563.1 585.6 606.4 609.4 6216.3 6313.2 6512.9 6546.5 6547.1 6372.6 6398.8 6404.9 6460.0 6477.3 5307.3 5348.8 5382.6 5394.1 5411.6 5112.6 5152.5 5187.2 5230.7 5249.9 5163.6 5172.6 5173.9 5190.7 5209.2 5166.9 5207.7 5209.0 5223.7 5235.1 4747.6 4779.2 4787.3 4793.3 4800.3 6348.7 6390.4 6421.3 6440.5 6457.0 6037.5 6049.8 6055.1 6064.2 6082.8 6742.7 6827.1 6846.5 6846.9 6862.8 5058.0 5283.2 5286.8 5296.4 5309.3 6919.8 6976.6 7070.7 7130.3 7214.0 5444.6 5454.5 5458.6 5463.8 5472.1 5491.8 5506.3 5508.6 5528.9 5549.6 6036.7 6072.7 6087.3 6095.4 6144.2 6906.0 6916.6 6944.9 6968.4 6989.0 1888.4 1892.9 1902.1 1911.4 1933.5 1314.4 1338.7 1355.9 1356.0 1375.5 6316.7 6466.9 6497.2 6500.6 6562.4 6885.1 6904.5 6945.8 6980.0 6988.0 6430.6 6508.5 6548.4 6554.2 6557.6 3670.1 3686.6 3711.6 3712.5 3719.0 7028.2 7147.5 7227.7 7273.2 7282.2 7009.8 7026.6 7036.9 7079.5 7105.8 7066.3 7124.1 7135.9 7187.6 7206.3 6862.7 6880.7 6930.6 6951.7 6965.2 6800.0 6873.5 6917.3 6948.4 7002.6 7275.5 7292.8 7307.9 7356.6 7359.9 5436.2 5449.0 5452.5 5462.5 5488.1 6684.0 6716.8 6977.3 6984.3 7034.5 6683.0 6694.2 6701.7 6728.9 6798.3 6552.8 6582.4 6647.5 6716.5 6756.0 6616.7 6625.6 6672.0 6679.5 6702.4 6793.4 6820.6 6832.2 6849.6 6906.2 6624.8 6630.3 6682.6 6691.9 6740.0 10:18:48 INFO - PID 8567 | 10:18:48 INFO - PID 8567 | [#5] yui.html Cycles:180 Average:30202.85 Median:20672.93 stddev:43499.68 (210.4%) stddev-sans-first:43566.44 10:18:48 INFO - PID 8567 | Values: 1000.8 1037.3 1042.8 1048.0 1059.3 21907.6 22312.9 22318.8 22339.3 22349.8 20016.8 20067.6 21137.4 21323.3 21350.9 1059.1 1091.2 1094.4 1094.8 1095.7 1031.4 1070.5 1075.7 1094.5 1119.6 1139.7 1141.0 1141.3 1142.1 1142.8 1130.9 1141.1 1141.7 1141.9 1150.1 837.6 843.7 848.4 848.9 849.5 22139.2 22497.2 22567.9 22625.9 22945.3 23906.8 24003.0 24546.6 24591.4 24682.0 19534.3 19601.3 19703.1 19737.1 19747.3 4120.4 4171.0 4177.6 4179.7 4182.0 158644.0 163764.0 163955.0 165688.0 167189.0 17574.7 17640.7 17737.6 17792.8 17923.4 35044.6 35310.8 35619.3 35674.8 35688.5 9759.3 9796.8 9888.4 9892.1 9937.7 4799.6 4876.6 4880.2 4893.9 4924.8 6188.1 6305.1 6309.3 6369.5 6377.9 1195.1 1216.1 1219.4 1221.5 1228.1 767.6 768.2 783.0 785.9 800.0 12223.5 12869.0 13669.1 14261.7 14531.4 790.3 793.4 799.8 800.9 809.7 6457.1 6481.9 6509.9 6558.5 6571.8 152911.0 153076.0 153769.0 158194.0 159859.0 105554.0 108855.0 130136.3 130646.0 138187.3 108657.0 109551.5 115975.0 116471.0 119812.4 13771.2 14116.0 14516.7 14924.8 14979.8 54219.0 55045.0 55621.7 55694.4 57936.4 99190.0 103163.0 103614.0 104467.5 106079.0 20171.2 20218.3 20250.5 20496.8 20562.0 23178.7 23590.4 23689.8 23732.5 23751.5 21798.9 22120.8 22376.9 22398.6 22408.2 20843.9 21014.7 21210.5 21220.6 21488.4 20783.9 20941.3 21348.5 21401.7 21503.7 16096.0 16323.0 16372.3 16389.3 16541.7 15163.0 15538.7 15734.0 15904.2 15957.0 10:18:48 INFO - PID 8567 | -------- Summary: end -------- 10:18:48 INFO - PID 8567 | 10:18:48 INFO - TEST-INFO | 8567: exit 0 10:18:48 INFO - TEST-OK | dromaeo_css | took 1105692ms 10:18:48 INFO - TEST-START | kraken 10:18:48 INFO - Initialising browser for kraken test... 10:18:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49952/getInfo.html -profile /tmp/tmpsoO72G/profile 10:18:48 INFO - TEST-INFO | started process 8937 (/builds/slave/test/build/application/firefox/firefox http://localhost:49952/getInfo.html) 10:18:53 INFO - TEST-INFO | 8937: exit 0 10:18:53 INFO - Browser initialized. 10:18:53 INFO - Running cycle 1/1 for kraken test... 10:18:53 INFO - Using env: {'DISPLAY': ':0', 10:18:53 INFO - 'HOME': '/home/cltbld', 10:18:53 INFO - 'JSGC_DISABLE_POISONING': '1', 10:18:53 INFO - 'LANG': 'en_US.UTF-8', 10:18:53 INFO - 'LANGUAGE': 'en_US:en', 10:18:53 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:18:53 INFO - 'LOGNAME': 'cltbld', 10:18:53 INFO - 'MAIL': '/var/mail/cltbld', 10:18:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:18:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:18:53 INFO - 'MOZ_CRASHREPORTER': '1', 10:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:53 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:18:53 INFO - 'MOZ_NO_REMOTE': '1', 10:18:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:53 INFO - 'NO_EM_RESTART': '1', 10:18:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:53 INFO - 'PWD': '/builds/slave/test', 10:18:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:18:53 INFO - 'RUST_BACKTRACE': 'full', 10:18:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:18:53 INFO - 'SHELL': '/bin/bash', 10:18:53 INFO - 'SHLVL': '1', 10:18:53 INFO - 'TERM': 'linux', 10:18:53 INFO - 'TMOUT': '86400', 10:18:53 INFO - 'USER': 'cltbld', 10:18:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221', 10:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:53 INFO - '_': '/tools/buildbot/bin/python'} 10:18:53 INFO - TEST-INFO | started process 9171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsoO72G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:54 INFO - PID 9171 | 10:18:54 INFO - PID 9171 | (/builds/slave/test/build/application/firefox/firefox:9220): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:18:54 INFO - PID 9171 | 10:19:05 INFO - PID 9171 | RSS: Main: 141762560 10:19:05 INFO - PID 9171 | 10:19:07 INFO - PID 9171 | Cycle 1(1): loaded http://localhost:49952/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49952/tests/kraken/driver.html?testName=audio-beat-detection) 10:19:08 INFO - PID 9171 | RSS: Main: 147652608 10:19:08 INFO - PID 9171 | 10:19:10 INFO - PID 9171 | Cycle 1(1): loaded http://localhost:49952/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49952/tests/kraken/driver.html?testName=audio-dft) 10:19:11 INFO - PID 9171 | RSS: Main: 148250624 10:19:11 INFO - PID 9171 | 10:19:14 INFO - PID 9171 | Cycle 1(1): loaded http://localhost:49952/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49952/tests/kraken/driver.html?testName=audio-fft) 10:19:14 INFO - PID 9171 | RSS: Main: 149819392 10:19:14 INFO - PID 9171 | 10:19:17 INFO - PID 9171 | Cycle 1(1): loaded http://localhost:49952/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49952/tests/kraken/driver.html?testName=audio-oscillator) 10:19:17 INFO - PID 9171 | RSS: Main: 149626880 10:19:17 INFO - PID 9171 | 10:19:19 INFO - PID 9171 | Cycle 1(1): loaded http://localhost:49952/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49952/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:19:20 INFO - PID 9171 | RSS: Main: 149487616 10:19:20 INFO - PID 9171 | 10:19:23 INFO - PID 9171 | Cycle 1(1): loaded http://localhost:49952/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49952/tests/kraken/driver.html?testName=imaging-darkroom) 10:19:23 INFO - PID 9171 | RSS: Main: 149417984 10:19:23 INFO - PID 9171 | 10:19:27 INFO - PID 9171 | Cycle 1(1): loaded http://localhost:49952/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49952/tests/kraken/driver.html?testName=imaging-desaturate) 10:19:27 INFO - PID 9171 | RSS: Main: 149938176 10:19:27 INFO - PID 9171 | 10:19:30 INFO - PID 9171 | Cycle 1(1): loaded http://localhost:49952/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49952/tests/kraken/driver.html?testName=json-parse-financial) 10:19:31 INFO - PID 9171 | RSS: Main: 152002560 10:19:31 INFO - PID 9171 | 10:19:32 INFO - PID 9171 | Cycle 1(1): loaded http://localhost:49952/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49952/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:19:33 INFO - PID 9171 | RSS: Main: 152117248 10:19:33 INFO - PID 9171 | 10:19:35 INFO - PID 9171 | Cycle 1(1): loaded http://localhost:49952/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49952/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:19:35 INFO - PID 9171 | RSS: Main: 151912448 10:19:35 INFO - PID 9171 | 10:19:37 INFO - PID 9171 | Cycle 1(1): loaded http://localhost:49952/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49952/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:19:38 INFO - PID 9171 | RSS: Main: 148779008 10:19:38 INFO - PID 9171 | 10:19:40 INFO - PID 9171 | Cycle 1(1): loaded http://localhost:49952/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49952/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:19:41 INFO - PID 9171 | RSS: Main: 148733952 10:19:41 INFO - PID 9171 | 10:19:43 INFO - PID 9171 | Cycle 1(1): loaded http://localhost:49952/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49952/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:19:44 INFO - PID 9171 | RSS: Main: 149323776 10:19:44 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | Cycle 1(1): loaded http://localhost:49952/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49952/tests/kraken/driver.html?testName=ai-astar) 10:19:46 INFO - PID 9171 | RSS: Main: 150716416 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | __start_tp_report 10:19:46 INFO - PID 9171 | _x_x_mozilla_page_load 10:19:46 INFO - PID 9171 | _x_x_mozilla_page_load_details 10:19:46 INFO - PID 9171 | |i|pagename|runs| 10:19:46 INFO - PID 9171 | |0;ai-astar;105;107;106;104;105;107;108;106;107;106 10:19:46 INFO - PID 9171 | |1;audio-beat-detection;113;110;110;117;109;109;109;110;111;114 10:19:46 INFO - PID 9171 | |2;audio-dft;161;161;162;161;162;162;160;162;162;162 10:19:46 INFO - PID 9171 | |3;audio-fft;73;72;72;72;73;75;73;94;73;74 10:19:46 INFO - PID 9171 | |4;audio-oscillator;78;77;76;76;77;84;77;78;77;76 10:19:46 INFO - PID 9171 | |5;imaging-gaussian-blur;113;113;113;110;114;114;114;114;114;114 10:19:46 INFO - PID 9171 | |6;imaging-darkroom;149;148;147;149;151;149;149;150;150;148 10:19:46 INFO - PID 9171 | |7;imaging-desaturate;94;94;95;94;94;94;95;93;94;95 10:19:46 INFO - PID 9171 | |8;json-parse-financial;45;45;44;43;46;44;45;44;45;43 10:19:46 INFO - PID 9171 | |9;json-stringify-tinderbox;38;39;39;40;39;39;39;39;39;38 10:19:46 INFO - PID 9171 | |10;stanford-crypto-aes;70;68;77;73;70;68;70;69;67;69 10:19:46 INFO - PID 9171 | |11;stanford-crypto-ccm;105;100;101;103;102;99;99;107;104;105 10:19:46 INFO - PID 9171 | |12;stanford-crypto-pbkdf2;162;160;153;144;155;152;147;160;158;147 10:19:46 INFO - PID 9171 | |13;stanford-crypto-sha256-iterative;59;56;71;58;58;64;58;58;58;58 10:19:46 INFO - PID 9171 | __end_tp_report 10:19:46 INFO - PID 9171 | __start_cc_report 10:19:46 INFO - PID 9171 | _x_x_mozilla_cycle_collect,702 10:19:46 INFO - PID 9171 | __end_cc_report 10:19:46 INFO - PID 9171 | __startTimestamp1507742386473__endTimestamp 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | ------- Summary: start ------- 10:19:46 INFO - PID 9171 | Number of tests: 14 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | [#0] ai-astar Cycles:10 Average:106.10 Median:106.50 stddev:1.20 (1.1%) stddev-sans-first:1.20 10:19:46 INFO - PID 9171 | Values: 105.0 107.0 106.0 104.0 105.0 107.0 108.0 106.0 107.0 106.0 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | [#1] audio-beat-detection Cycles:10 Average:111.20 Median:110.50 stddev:2.66 (2.4%) stddev-sans-first:2.74 10:19:46 INFO - PID 9171 | Values: 113.0 110.0 110.0 117.0 109.0 109.0 109.0 110.0 111.0 114.0 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.71 (0.4%) stddev-sans-first:0.73 10:19:46 INFO - PID 9171 | Values: 161.0 161.0 162.0 161.0 162.0 162.0 160.0 162.0 162.0 162.0 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | [#3] audio-fft Cycles:10 Average:75.10 Median:73.00 stddev:6.71 (9.2%) stddev-sans-first:7.07 10:19:46 INFO - PID 9171 | Values: 73.0 72.0 72.0 72.0 73.0 75.0 73.0 94.0 73.0 74.0 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:77.00 stddev:2.37 (3.1%) stddev-sans-first:2.51 10:19:46 INFO - PID 9171 | Values: 78.0 77.0 76.0 76.0 77.0 84.0 77.0 78.0 77.0 76.0 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:114.00 stddev:1.25 (1.1%) stddev-sans-first:1.32 10:19:46 INFO - PID 9171 | Values: 113.0 113.0 113.0 110.0 114.0 114.0 114.0 114.0 114.0 114.0 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.15 (0.8%) stddev-sans-first:1.22 10:19:46 INFO - PID 9171 | Values: 149.0 148.0 147.0 149.0 151.0 149.0 149.0 150.0 150.0 148.0 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 10:19:46 INFO - PID 9171 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 95.0 93.0 94.0 95.0 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | [#8] json-parse-financial Cycles:10 Average:44.40 Median:45.00 stddev:0.97 (2.1%) stddev-sans-first:1.00 10:19:46 INFO - PID 9171 | Values: 45.0 45.0 44.0 43.0 46.0 44.0 45.0 44.0 45.0 43.0 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | [#9] json-stringify-tinderbox Cycles:10 Average:38.90 Median:39.00 stddev:0.57 (1.5%) stddev-sans-first:0.50 10:19:46 INFO - PID 9171 | Values: 38.0 39.0 39.0 40.0 39.0 39.0 39.0 39.0 39.0 38.0 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | [#10] stanford-crypto-aes Cycles:10 Average:70.10 Median:70.00 stddev:2.92 (4.2%) stddev-sans-first:3.10 10:19:46 INFO - PID 9171 | Values: 70.0 68.0 77.0 73.0 70.0 68.0 70.0 69.0 67.0 69.0 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | [#11] stanford-crypto-ccm Cycles:10 Average:102.50 Median:105.00 stddev:2.76 (2.6%) stddev-sans-first:2.77 10:19:46 INFO - PID 9171 | Values: 105.0 100.0 101.0 103.0 102.0 99.0 99.0 107.0 104.0 105.0 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:156.50 stddev:6.29 (4.0%) stddev-sans-first:5.93 10:19:46 INFO - PID 9171 | Values: 162.0 160.0 153.0 144.0 155.0 152.0 147.0 160.0 158.0 147.0 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.80 Median:58.00 stddev:4.44 (7.7%) stddev-sans-first:4.70 10:19:46 INFO - PID 9171 | Values: 59.0 56.0 71.0 58.0 58.0 64.0 58.0 58.0 58.0 58.0 10:19:46 INFO - PID 9171 | -------- Summary: end -------- 10:19:46 INFO - PID 9171 | 10:19:46 INFO - PID 9171 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:19:47 INFO - TEST-INFO | 9171: exit 0 10:19:47 INFO - TEST-OK | kraken | took 58616ms 10:19:47 INFO - SUITE-END | took 1164s 10:19:47 INFO - Completed test suite (00:19:24) 10:19:47 INFO - javascript benchmark 10:19:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9487.866753247179, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3935.5474120476138, 3946.960530394696, 3951.762894226347, 3957.901052473686, 3998.1403998140413, 6357.427831495171, 6369.968150159249, 6407.871842563158, 6422.550421470499, 6434.227892652876, 6367.981123020318, 6369.936300636992, 6371.872562548758, 6506.934930650692, 6522.380373864476, 5642.633228840123, 5684.630499017571, 5777.508911742507, 5802.97098514509, 5885.735141918624, 5644.971775141119, 5713.942860571404, 5735.139729040636, 5766.942330576703, 5774.133879918025, 5699.943000570003, 5768.39431859655, 5841.094630332305, 5851.034579294412, 5868.882622347551, 5729.5702822288495, 5768.048272035109, 5832.737526811304, 5834.154047663065, 5867.882642347129, 5656.490915817555, 5712.514436272922, 5770.971145144247, 5850.385709500484, 5854.853628659275, 6321.24145102586, 6350.142730731338, 6352.1742173517605, 6369.93630063698, 6404.359564043605, 6848.657567121674, 6897.275786042494, 6924.203716572558, 6925.619090949996, 6995.02069710241, 6933.618650974195, 6946.826329341757, 6960.408365288957, 7041.753538626123, 7049.154101507852, 6408.487321014308, 6411.6153030818305, 6475.967620161916, 6479.222493300834, 6484.675766211718, 7065.858682826315, 7096.325849044332, 7100.183478899992, 7135.322144396274, 7217.891731623925, 6816.352446517573, 6906.551074180162, 6916.585004899622, 6920.100386949765, 6929.930700692928, 6969.616671083139, 6986.336298051779, 6987.965060174666, 7069.399101076363, 7070.045543851617, 6746.426553742888, 6844.8973265401055, 6876.243613202544, 6945.51381403307, 6949.305069493112, 6820.488463365168, 6882.4149947254045, 6885.552439091443, 6916.51584389098, 6941.0, 5130.256112863689, 5171.896562068738, 5192.273081768555, 5199.090159222121, 5208.348956380452, 4635.0, 4665.230237010923, 4694.460137084279, 4698.647601429906, 4708.293755936637, 6552.344765523505, 6557.606543607399, 6570.441512471398, 6610.041543976096, 6626.039224312448, 6899.724011039602, 6921.134858142732, 6951.513394062367, 6997.650117494105, 7035.753748618774, 6408.67956602168, 6489.123968264318, 6523.380278873499, 6551.344865513411, 6563.409293163638, 5790.131480277908, 5822.0684690449325, 5844.59087863854, 5892.734826932799, 5931.436513531207, 7113.857722845514, 7194.604296763624, 7203.531770434905, 7292.963535182396, 7327.157376901724, 6879.208890977501, 6929.099217101744, 6963.9303606963285, 7011.649417529001, 7015.123109611299, 7217.566945983258, 7263.309985551364, 7297.270272972661, 7313.670884810303, 7342.853142937218, 6774.220964589135, 6776.424003959719, 6792.286809885089, 6870.931290687229, 6964.930350696428, 6990.405815505739, 7057.894131588133, 7058.752943646948, 7067.787966361017, 7077.221505634479, 6656.30108838565, 6677.833054173684, 6685.331466853276, 6707.228668703162, 6782.898256526058, 6689.49828762835, 6703.865922681422, 6766.830829229309, 6781.084553585203, 6783.694733737092, 6664.466842652673, 6673.299303573249, 6714.127163468718, 6723.7646682365885, 6763.391294783493, 6688.398044176048, 6767.796966091025, 6790.796276111724, 6799.912014077724, 6863.794086177422, 6521.119648847345, 6531.020346947996, 6594.142761440982, 6602.8679426410245, 6616.073749675145], "value": 6368.69756726683, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [973.4159504297418, 974.3812678948865, 996.3922007575378, 1028.8713910761155, 1036.2642523808101, 45420.545794542086, 46244.306335404995, 46285.53714462854, 46289.999999999956, 46314.53685463144, 43770.56229437704, 43908.341374879325, 43923.34114988278, 44055.559444405546, 44222.55777442225, 7897.881531777013, 8036.196380361976, 8056.315213206855, 8101.02787665481, 8114.715984940528, 8081.111077781439, 8110.472819266758, 8147.307478864303, 8182.7545173644585, 8184.590770461483, 8291.751247462556, 8464.44981076228, 8469.19542643451, 8503.74488765338, 8508.78728031798, 8399.076101628816, 8498.957505212496, 8500.872486912733, 8504.234618884268, 8507.65969361231, 8644.740657780214, 8780.078091800397, 8809.955950220208, 8854.203121719076, 8856.291496680315, 41505.0, 41512.58487415117, 41743.791281043705, 41924.37113443301, 42005.78997104995, 3862.7296089273764, 3862.7682339059747, 3868.9806550967346, 3883.708721845873, 3904.121572646132, 34110.12394318311, 34444.311113777585, 34484.13789655254, 34520.309593807986, 34621.480677789856, 5647.774089036434, 5659.462351076641, 5696.430356964312, 5704.067769519695, 5825.563082768767, 240720.0, 241146.0, 241299.99999999825, 242078.0, 242578.0, 54090.0, 54112.729436352565, 54209.0, 54314.0, 54314.45685543173, 57296.42703572994, 57424.712876436184, 57428.13857792137, 57433.13850292249, 57618.135727964116, 17279.91360043192, 17296.308147673953, 17335.56661083483, 17353.0, 17364.0, 14170.220637865017, 14173.574792756233, 14181.432742690384, 14264.572062837924, 14318.85681143196, 15667.37330506767, 15895.602609934844, 15910.204489775464, 15938.28277727505, 15973.520794376187, 6304.211973503312, 6421.711023003976, 6422.582532135396, 6443.355664433519, 6466.385693359123, 1100.9394483303495, 1128.1877048525048, 1135.9034482069117, 1136.5851464215666, 1144.067584918289, 25930.481390372086, 26372.0, 26374.604380934303, 26387.47225055488, 26514.469710606067, 1200.1359021504502, 1223.706310485495, 1226.533917111492, 1238.6036468330228, 1240.2806372304042, 13747.312634368442, 13962.790558141636, 13999.580012599637, 14175.71648567023, 14184.787228191379, 274018.0, 274225.0, 299486.0, 303487.0, 303520.0, 64338.67830660817, 64684.35315646877, 64811.0, 64911.67544162343, 65576.34423655798, 1536.8693661038712, 1542.3984645988073, 1549.7985261915878, 1555.5488908216944, 1573.1819453883916, 30864.0, 30984.22539436532, 31043.84478077595, 31059.534106988864, 31186.376272474878, 43534.0, 43629.0, 43678.56321436872, 43680.344794828736, 43762.78118609387, 266209.0, 268311.0, 269773.0, 271111.0, 272254.0, 38169.42745858759, 38269.0, 38464.2307153861, 38669.0, 38687.806560967016, 48380.0, 48416.0, 48466.0, 48747.0, 48763.756181220284, 34609.826950865085, 35324.64675353316, 35542.822285888404, 35900.461493077106, 36174.27651447009, 35249.0, 35668.0, 35993.64006359903, 36007.27985440329, 36081.458778118875, 41508.0, 41581.1683766329, 41981.37027944522, 41995.37006944837, 42129.57870421379, 33620.3275934475, 34019.31961360709, 34068.65931340655, 34146.829265853514, 34617.48073778845, 25733.871330643226, 25945.610815838154, 26088.608670869573, 26137.6079358806, 26279.21162365132], "value": 19429.67929631051, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.9315865379962, 645.183431140396, 648.3333497551508, 649.6267365402678, 651.6014817239173, 25125.74874251257, 25603.74396256037, 25662.10182643608, 25712.742872571314, 25741.0, 24034.0, 24523.509529809395, 24595.877020614917, 24638.876805615946, 24645.260642180765, 6637.236717777445, 6856.2800905904905, 6968.163820341566, 6975.058367120425, 6991.335823096823, 6901.8964715529055, 7001.509894307401, 7011.298870112999, 7014.088168538083, 7021.368076873106, 6747.932520674804, 6964.930350696504, 6969.233384327746, 6970.686319115652, 6997.65011749413, 7034.0, 7075.610841403721, 7082.468814838908, 7083.043789088484, 7084.504084714072, 6608.074869518271, 6610.0745895574655, 6648.335166483313, 6660.866782664368, 6664.93335066648, 30762.077137685905, 31266.0, 31840.522392164137, 31842.840785796154, 32231.51652725211, 2297.8506397084134, 2370.988145059281, 2384.5946189147885, 2386.4391867911027, 2396.2930935374106, 21257.255996040065, 21773.673394899088, 21788.346349609536, 21798.237061702923, 21929.451763705874, 2604.322876052221, 2675.3712877473777, 2687.4490729400427, 2690.0719251858077, 2712.2541301142146, 152074.0, 155761.22119389445, 157596.2120189403, 163718.0, 170806.0, 16888.0, 17105.82894171067, 17253.82746172522, 17446.38937637202, 17634.559136021446, 27235.591466128022, 27325.86337068302, 27470.72529274722, 27530.724692752818, 27669.446611067666, 10717.9464102679, 10732.409717465458, 10889.237753357189, 10948.56205751761, 10955.616553420592, 9637.37357071788, 9686.660966866126, 9777.755556111155, 9784.070513301225, 9856.556454959544, 9794.902050979399, 9982.251331150193, 10135.148643515417, 10230.897691022994, 10398.220133490018, 2896.174590241813, 2898.8835853088663, 2965.8368789716774, 3004.9699503005127, 3098.690130986883, 1018.9643362482277, 1048.9318194317345, 1052.7894421115807, 1059.9470026498643, 1063.186662203415, 21460.141594336365, 21564.676529852066, 21727.13091476323, 21854.0, 21906.78093219079, 1123.938183399921, 1128.2835399521364, 1129.3506233915532, 1130.591839382111, 1136.6476392318243, 11606.76786464266, 11768.411579420994, 11853.822192667118, 11981.88018119825, 12015.819762703566, 599340.0, 603073.0, 620930.0, 623421.0, 625697.0, 137863.0, 138357.0, 139472.30263848818, 144115.0, 144246.0, 1235.308227392663, 1279.1493656718178, 1279.181323952671, 1284.5953524639708, 1285.9614211573669, 18566.907165464087, 18900.14949327311, 19021.809781902004, 19030.524236894187, 19055.0, 62797.372026279154, 63038.68480657567, 63199.368006319346, 64081.35918640754, 64216.0, 80814.0, 81097.0, 81388.5930570367, 81730.59134704288, 84082.0, 16006.279717412977, 16216.270267837739, 16236.51290461288, 16358.427455039016, 16368.345266189219, 24415.145469908468, 24429.14497992633, 24563.140290089763, 24588.1394151211, 24613.13854015101, 19560.902195488932, 19607.0, 19799.208031678572, 20077.29729459462, 20171.69742453835, 17491.300347986446, 17735.29058837632, 17872.0, 18239.635207296044, 18274.543136421697, 20394.0, 20510.897445512677, 20720.378388648365, 20874.895625522382, 21036.47408814792, 15715.607109822346, 15855.12796796141, 15856.44502442409, 15916.0, 15967.0, 19588.706169407757, 19599.804001959797, 19742.0, 19753.802461975196, 19782.70325945083], "value": 13168.180626506815, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.1627381707883, 1465.8021167142433, 1471.0658731705366, 1475.3066058952302, 1488.8734457571106, 17093.145342732874, 17904.194311255993, 17913.641727165465, 17923.731144032834, 17934.192961316738, 17383.47849564512, 17417.0, 17428.56428589286, 17510.82489175108, 17571.2092955817, 3080.3531258435755, 3175.555422240888, 3218.8390580471, 3220.661830507798, 3221.2752130770623, 3044.5737596736476, 3066.555349474325, 3145.826979516126, 3149.8425078746086, 3150.7006834350814, 3134.5611614374006, 3161.3361194149143, 3175.6506784253716, 3180.570622965893, 3190.6330771961175, 3054.7861649684532, 3064.2952121012067, 3066.310080231941, 3080.8921687740935, 3082.152408087771, 3000.834954077525, 3015.9396812063856, 3046.4973279408873, 3059.2963618367676, 3059.7858149929516, 17011.064391458465, 17325.7401138983, 17383.73924391135, 17391.565210869703, 17397.565060873454, 9122.86315705265, 9434.150926416656, 9436.150746432853, 9438.0, 9467.384619999746, 5977.491913187384, 6111.960966635638, 6310.9684451577905, 6347.873042539123, 6362.5546211765195, 2112.2712664131004, 2161.9891900540556, 2185.737711474633, 2221.1226565506536, 2222.3110835641005, 31850.0, 31931.52102718461, 31967.680323196702, 31980.840095799605, 32036.359272814414, 7671.117821450604, 7836.960815196002, 7955.960220198862, 8004.51972881629, 8048.154943730941, 21006.789932100484, 21014.78985210159, 21016.684749728767, 21047.78952210489, 21108.261210857545, 8981.910180898238, 9132.543372831331, 9170.08299170091, 9180.0, 9181.219596334386, 8173.754787356389, 8248.917510824935, 8323.209295116954, 8359.874601880976, 8447.028591711909, 5825.242718446575, 5889.411058894077, 5896.64620122794, 5923.674197919156, 5980.850478738066, 1537.6463413414976, 1601.455505128262, 1639.3114891745495, 1652.2234549761592, 1656.6355401811581, 1010.8483727440943, 1033.6485594897772, 1034.182995433614, 1045.6549338718205, 1046.40877903984, 10003.199744020461, 10300.690979270634, 10338.431386273827, 10468.947655261827, 10534.262601617813, 1100.4112799652148, 1106.618216715232, 1118.2731224704007, 1119.1047162270152, 1122.399516258814, 5481.424450432647, 5509.256250406143, 5638.182463542763, 5659.518940889988, 5684.033714268584, 25644.230673079837, 25900.8704956474, 26407.33981650474, 26787.464250715268, 27178.456430871272, 25654.102106426184, 26107.869460652575, 26176.0, 26380.60429093565, 26453.33866653349, 12926.741465170644, 12970.286634235208, 13273.867261327456, 13299.800502992462, 13332.600021999355, 9655.565499552396, 9726.902730972883, 9766.0, 9845.113939745172, 10009.69970900874, 22492.0, 22533.43666408353, 22615.547689046456, 22748.886255568617, 23031.193908213132, 23675.64486532738, 23819.404514887265, 23826.16608418697, 23902.402439939142, 23910.52178956446, 12577.93711031439, 12665.0, 12815.102942793916, 12866.742665146458, 12884.162529435556, 15179.620509487351, 15384.38462461489, 15408.0, 15510.689786204439, 16194.595135121715, 12936.547220847226, 13225.669358266121, 13390.397432115384, 13500.729985400434, 13597.864021360056, 12652.936735316265, 12738.172018818746, 12758.425870836021, 12775.61673149807, 13098.0, 11600.18798684084, 11669.824952625548, 11675.0, 11818.822717659414, 11866.110041747077, 8506.362022848434, 8600.870986935326, 8696.565171741515, 8749.037605863223, 8786.604602792762, 8473.78815529592, 8617.48295102296, 8643.26532244741, 8671.956640216758, 8730.65077396897], "value": 7757.222353951457, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.1696330948538, 563.1159080244014, 585.5549782165555, 606.4238972975672, 609.3997412548639, 6216.347283535231, 6313.179286692729, 6512.902306465407, 6546.54174207805, 6547.148870646821, 6372.617642941426, 6398.808035758923, 6404.903926441107, 6460.0, 6477.287498375187, 5307.283516725251, 5348.839534813962, 5382.6232163748555, 5394.05604019297, 5411.648242864201, 5112.642115051929, 5152.536271735543, 5187.187417248319, 5230.686158830464, 5249.868753281179, 5163.638545301812, 5172.586193104543, 5173.870653233662, 5190.71451070191, 5209.244659524366, 5166.870828229286, 5207.687538747649, 5209.0, 5223.71269580173, 5235.136202526579, 4747.596454301389, 4779.163646361908, 4787.329773831666, 4793.32893394925, 4800.255960326155, 6348.746050157988, 6390.3609639036185, 6421.261554921197, 6440.4847612190915, 6456.967715161441, 6037.486813620848, 6049.848753781191, 6055.122007308915, 6064.211652485193, 6082.813851298998, 6742.662866856637, 6827.146606674166, 6846.520743547953, 6846.931530684679, 6862.769599880059, 5057.974710126463, 5283.2075188722, 5286.788528458857, 5296.364436267634, 5309.283246761715, 6919.792406227822, 6976.5814051157095, 7070.717171313141, 7130.2869713028285, 7213.963930180315, 5444.564434845282, 5454.4545545445935, 5458.617896747269, 5463.781448742086, 5472.124460086367, 5491.807786727445, 5506.284183056177, 5508.55931525477, 5528.917066244009, 5549.5837812164245, 6036.667983260875, 6072.696365181723, 6087.3303936566945, 6095.3904609538695, 6144.2319710036245, 6906.0, 6916.619585922722, 6944.895826562605, 6968.407685346802, 6988.965055174794, 1888.3862744608057, 1892.8864268143955, 1902.1250224896703, 1911.445680752594, 1933.497290704399, 1314.3822403470353, 1338.7255612599395, 1355.8508564057945, 1355.986440135586, 1375.5460697969645, 6316.652584107826, 6466.8682980478225, 6497.18785151856, 6500.609963402211, 6562.442192413699, 6885.139357580302, 6904.515529161154, 6945.791626251221, 6980.0, 6987.965060174768, 6430.64631445275, 6508.544401891822, 6548.443382312462, 6554.213494380705, 6557.639329836809, 3670.1465759791135, 3686.557613086447, 3711.554613446404, 3712.480252764615, 3719.014461167793, 7028.156621205488, 7147.53541019832, 7227.747028853965, 7273.163586187656, 7282.198958114604, 7009.773289674388, 7026.613536255452, 7036.92963070373, 7079.504434689522, 7105.751298704624, 7066.293370662996, 7124.145102587722, 7135.928640713734, 7187.5687458752645, 7206.315400036988, 6862.656867156722, 6880.724771009103, 6930.584164950119, 6951.687174077279, 6965.22386791365, 6800.0, 6873.518853680394, 6917.342852429011, 6948.374646281859, 7002.579845209304, 7275.454340924558, 7292.812156352967, 7307.8538429232185, 7356.632168391452, 7359.889601655872, 5436.238926550207, 5449.04641687711, 5452.482014208644, 5462.453754624506, 5488.121900495901, 6684.0, 6716.83207919806, 6977.2673869243, 6984.301569842975, 7034.5427547209265, 6682.997550367484, 6694.192568006708, 6701.698423570853, 6728.865422691617, 6798.286179951034, 6552.8361790955605, 6582.374674406115, 6647.5014373921185, 6716.462682985447, 6755.966220168868, 6616.7022483987375, 6625.635590042594, 6671.966640166768, 6679.532432729857, 6702.430293425114, 6793.414445249536, 6820.556663816836, 6832.180138383425, 6849.589024658537, 6906.205786334435, 6624.8343791405605, 6630.270670226368, 6682.565633233824, 6691.899621505779, 6739.966300168468], "value": 5374.154695747082, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1000.8398656215007, 1037.2998226197317, 1042.7914417116574, 1048.035807057507, 1059.3008614314551, 21907.561848763016, 22312.88843555784, 22318.776812231892, 22339.329820105384, 22349.776502234974, 20016.799832001674, 20067.598648027066, 21137.365879023615, 21323.25368612099, 21350.89324553375, 1059.1156384419, 1091.170710260204, 1094.370736826324, 1094.813881640123, 1095.6767753512693, 1031.3554028732042, 1070.5236169904397, 1075.688050465364, 1094.5402930769055, 1119.5969450997634, 1139.692283083567, 1141.0472255666527, 1141.3209140561394, 1142.0520967596917, 1142.8285757136414, 1130.8982191602754, 1141.058626633031, 1141.7431078007423, 1141.948612312448, 1150.0971737186353, 837.6105111123356, 843.6920524008692, 848.3849209323253, 848.9405741598091, 849.5327569836627, 22139.225127120633, 22497.212597559006, 22567.887160564256, 22625.886870565708, 22945.31164065081, 23906.76093239063, 24003.0, 24546.631800523006, 24591.38521536958, 24682.0, 19534.31629892947, 19601.31395401154, 19703.113359898838, 19737.111829967685, 19747.308844190386, 4120.402541631476, 4171.040660648037, 4177.603127702863, 4179.686523510749, 4181.975416023063, 158644.0, 163764.0, 163955.0, 165688.0, 167189.0, 17574.736378954327, 17640.735388969177, 17737.556561086076, 17792.822071779116, 17923.37268195633, 35044.64955350414, 35310.823445882605, 35619.28761424757, 35674.8216258917, 35688.46467302993, 9759.316847820584, 9796.755081123029, 9888.357256778287, 9892.060254275832, 9937.65218217359, 4799.6400269979895, 4876.609871210295, 4880.194767863334, 4893.877653058702, 4924.778384972685, 6188.133661287423, 6305.14880491137, 6309.274433440213, 6369.490440764727, 6377.904331435032, 1195.0618764270007, 1216.1243904388825, 1219.3963987826082, 1221.5113954418305, 1228.1157566552067, 767.5739964319856, 768.1972338905857, 782.9725959591387, 785.9056913170456, 799.9800004999921, 12223.511059557695, 12869.0, 13669.111507751964, 14261.719804445036, 14531.418743250151, 790.2768966395798, 793.4485532554819, 799.7720649614948, 800.8718605023284, 809.7085049382217, 6457.128287681103, 6481.935180648133, 6509.9023514647315, 6558.475321974231, 6571.80284591463, 152911.0, 153076.0, 153769.0, 158194.0, 159859.0, 105554.0, 108855.0, 130136.3493182547, 130646.0, 138187.30906345404, 108657.0, 109551.45224273828, 115975.0, 116471.0, 119812.40093799475, 13771.242581658105, 14116.0, 14516.709665806837, 14924.776128357866, 14979.775303370676, 54219.0, 55045.0, 55621.72189139028, 55694.44305557055, 57936.42063579479, 99190.0, 103163.0, 103614.0, 104467.4776626112, 106079.0, 20171.193152273743, 20218.292359767336, 20250.493737656678, 20496.79503204949, 20561.97190140517, 23178.652320215548, 23590.410239743458, 23689.763102368757, 23732.525349492567, 23751.52496950017, 21798.891005544872, 22120.778792211873, 22376.88811555932, 22398.552028959657, 22408.215712449986, 20843.895780521, 21014.68477972862, 21210.469738256666, 21220.575588488453, 21488.355349339545, 20783.896080520106, 20941.267055652977, 21348.466288342916, 21401.67897481508, 21503.677444838653, 16096.0, 16323.0, 16372.345106196095, 16389.34442622282, 16541.66916661684, 15163.0, 15538.689226215638, 15734.0, 15904.204789760235, 15957.0], "value": 10738.086680972032, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1357.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 107.0, 106.0, 104.0, 105.0, 107.0, 108.0, 106.0, 107.0, 106.0], "value": 106.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 110.0, 117.0, 109.0, 109.0, 109.0, 110.0, 111.0, 114.0], "value": 111.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 160.0, 162.0, 162.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 72.0, 73.0, 75.0, 73.0, 94.0, 73.0, 74.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 76.0, 77.0, 84.0, 77.0, 78.0, 77.0, 76.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 110.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 149.0, 151.0, 149.0, 149.0, 150.0, 150.0, 148.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 93.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 45.0, 44.0, 43.0, 46.0, 44.0, 45.0, 44.0, 45.0, 43.0], "value": 44.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 39.0, 40.0, 39.0, 39.0, 39.0, 39.0, 39.0, 38.0], "value": 38.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 77.0, 73.0, 70.0, 68.0, 70.0, 69.0, 67.0, 69.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 100.0, 101.0, 103.0, 102.0, 99.0, 99.0, 107.0, 104.0, 105.0], "value": 102.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 153.0, 144.0, 155.0, 152.0, 147.0, 160.0, 158.0, 147.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 56.0, 71.0, 58.0, 58.0, 64.0, 58.0, 58.0, 58.0, 58.0], "value": 59.8, "unit": "score"}]}]} 10:19:47 INFO - Return code: 0 10:19:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:19:47 INFO - # TBPL SUCCESS # 10:19:47 INFO - Running post-action listener: _package_coverage_data 10:19:47 INFO - Running post-action listener: _resource_record_post_action 10:19:47 INFO - [mozharness: 2017-10-11 17:19:47.786043Z] Finished run-tests step (success) 10:19:47 INFO - Running post-run listener: _resource_record_post_run 10:19:47 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 471040; Write bytes: 291352576; Read time: 244; Write time: 137316 10:19:47 INFO - TinderboxPrint: CPU usage
13.0% 10:19:47 INFO - TinderboxPrint: I/O read bytes / time
471,040 / 244 10:19:47 INFO - TinderboxPrint: I/O write bytes / time
291,352,576 / 137,316 10:19:47 INFO - TinderboxPrint: CPU idle
8,184.7 (87.0%) 10:19:47 INFO - TinderboxPrint: CPU user
1,177.8 (12.5%) 10:19:47 INFO - TinderboxPrint: Swap in / out
0 / 0 10:19:47 INFO - install - Wall time: 15s; CPU: 12.0%; Read bytes: 0; Write bytes: 19075072; Read time: 0; Write time: 9104 10:19:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:19:47 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 466944; Write bytes: 271654912; Read time: 232; Write time: 128116 10:19:48 INFO - Running post-run listener: _upload_blobber_files 10:19:48 INFO - Blob upload gear active. 10:19:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:19:48 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 10:19:48 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:19:48 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:19:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:19:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:19:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:19:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:49 INFO - (blobuploader) - INFO - Done attempting. 10:19:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:19:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:19:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:50 INFO - (blobuploader) - INFO - Done attempting. 10:19:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:19:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:19:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:53 INFO - (blobuploader) - INFO - Done attempting. 10:19:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:19:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:19:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:55 INFO - (blobuploader) - INFO - Done attempting. 10:19:55 INFO - (blobuploader) - INFO - Iteration through files over. 10:19:55 INFO - Return code: 0 10:19:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:19:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:19:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5ad2c149e9462f1b7e06c2e8a0a830c40be9592d0cc4fc358e700008d501e88180768c0d9cf48b80d0475ae8db3f1c715b5c49d5de489f6c8cce47445db8493b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a47493ada2bd445d39d9451772d2365ad8488c214e8ea0c210a6241fa55d70faf7a0492c1ebe8c15594bd5b3e165dd9bd7a4e7ba41ef95f0870c976ac8994c47", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/536df0bf0e4133549046475b98244d15fe001ef39d8fbdb884401a605402a8df5219085e388a8e84f7da5e72244e9bcad04ef911752c8261f70fe7ae523535fe", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9dcd3023592e3c84832db98e40e0e48dd3b690b3a39e8cc39b53289a02d26a68d4198ccfe55a9c12eba991fa5c7c6612826288414e0865280f79a5c47cc11039"} 10:19:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:19:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:19:55 INFO - Contents: 10:19:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5ad2c149e9462f1b7e06c2e8a0a830c40be9592d0cc4fc358e700008d501e88180768c0d9cf48b80d0475ae8db3f1c715b5c49d5de489f6c8cce47445db8493b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a47493ada2bd445d39d9451772d2365ad8488c214e8ea0c210a6241fa55d70faf7a0492c1ebe8c15594bd5b3e165dd9bd7a4e7ba41ef95f0870c976ac8994c47", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/536df0bf0e4133549046475b98244d15fe001ef39d8fbdb884401a605402a8df5219085e388a8e84f7da5e72244e9bcad04ef911752c8261f70fe7ae523535fe", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9dcd3023592e3c84832db98e40e0e48dd3b690b3a39e8cc39b53289a02d26a68d4198ccfe55a9c12eba991fa5c7c6612826288414e0865280f79a5c47cc11039"} 10:19:55 INFO - Running post-run listener: copy_logs_to_upload_dir 10:19:55 INFO - Copying logs to upload dir... 10:19:55 INFO - mkdir: /builds/slave/test/build/upload/logs 10:19:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.662952 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2017-10-11 10:19:55.127934) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-11 10:19:55.131026) ========= 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=41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221 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/Mozilla-Beta-Non-PGO/sha512/5ad2c149e9462f1b7e06c2e8a0a830c40be9592d0cc4fc358e700008d501e88180768c0d9cf48b80d0475ae8db3f1c715b5c49d5de489f6c8cce47445db8493b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a47493ada2bd445d39d9451772d2365ad8488c214e8ea0c210a6241fa55d70faf7a0492c1ebe8c15594bd5b3e165dd9bd7a4e7ba41ef95f0870c976ac8994c47", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/536df0bf0e4133549046475b98244d15fe001ef39d8fbdb884401a605402a8df5219085e388a8e84f7da5e72244e9bcad04ef911752c8261f70fe7ae523535fe", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9dcd3023592e3c84832db98e40e0e48dd3b690b3a39e8cc39b53289a02d26a68d4198ccfe55a9c12eba991fa5c7c6612826288414e0865280f79a5c47cc11039"} build_url:https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/MR05ycnkThuhW1N_ueEuNw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5ad2c149e9462f1b7e06c2e8a0a830c40be9592d0cc4fc358e700008d501e88180768c0d9cf48b80d0475ae8db3f1c715b5c49d5de489f6c8cce47445db8493b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a47493ada2bd445d39d9451772d2365ad8488c214e8ea0c210a6241fa55d70faf7a0492c1ebe8c15594bd5b3e165dd9bd7a4e7ba41ef95f0870c976ac8994c47", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/536df0bf0e4133549046475b98244d15fe001ef39d8fbdb884401a605402a8df5219085e388a8e84f7da5e72244e9bcad04ef911752c8261f70fe7ae523535fe", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9dcd3023592e3c84832db98e40e0e48dd3b690b3a39e8cc39b53289a02d26a68d4198ccfe55a9c12eba991fa5c7c6612826288414e0865280f79a5c47cc11039"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-11 10:19:55.160326) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 10:19:55.160627) ========= 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=41bf3e9aed84707956354da8000001c5-1507740718.95765-1789224221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 10:19:55.244240) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-11 10:19:55.244619) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-11 10:19:55.245182) ========= ========= Total master_lag: 0.23 =========