builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1505440110.56 results: success (0) revision: e85c29016601de4367a96ff4bc37a440206f3304 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 18:48:30.561029) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 18:48:30.561464) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 18:48:30.563302) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 18:48:30.582182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 18:48:30.582788) ========= 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=0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 18:48:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.8M=0s 2017-09-14 18:48:30 (54.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132737 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 18:48:30.733450) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 18:48:30.733861) ========= 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=0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015795 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 18:48:30.783585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 18:48:30.783927) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e85c29016601de4367a96ff4bc37a440206f3304 --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 e85c29016601de4367a96ff4bc37a440206f3304 --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=0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 18:48:30,846 truncating revision to first 12 chars 2017-09-14 18:48:30,847 Setting DEBUG logging. 2017-09-14 18:48:30,847 attempt 1/10 2017-09-14 18:48:30,847 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e85c29016601?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 18:48:31,448 unpacking tar archive at: mozilla-beta-e85c29016601/testing/mozharness/ program finished with exit code 0 elapsedTime=0.889537 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 18:48:31.689763) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 18:48:31.690088) ========= script_repo_revision: e85c29016601de4367a96ff4bc37a440206f3304 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 18:48:31.690513) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 18:48:31.690787) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 18:48:31.705794) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2017-09-14 18:48:31.706242) ========= /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=0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:48:31 INFO - MultiFileLogger online at 20170914 18:48:31 in /builds/slave/test 18:48:31 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 18:48:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:48:31 INFO - {'append_to_log': False, 18:48:31 INFO - 'base_work_dir': '/builds/slave/test', 18:48:31 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 18:48:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:48:31 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 18:48:31 INFO - 'buildbot_json_path': 'buildprops.json', 18:48:31 INFO - 'code_coverage': False, 18:48:31 INFO - 'config_files': ('talos/linux_config.py',), 18:48:31 INFO - 'default_actions': ('clobber', 18:48:31 INFO - 'read-buildbot-config', 18:48:31 INFO - 'download-and-extract', 18:48:31 INFO - 'populate-webroot', 18:48:31 INFO - 'create-virtualenv', 18:48:31 INFO - 'install', 18:48:31 INFO - 'setup-mitmproxy', 18:48:31 INFO - 'run-tests'), 18:48:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:48:31 INFO - 'disable_ccov_upload': False, 18:48:31 INFO - 'disable_stylo': False, 18:48:31 INFO - 'download_minidump_stackwalk': True, 18:48:31 INFO - 'download_symbols': 'ondemand', 18:48:31 INFO - 'enable_stylo': False, 18:48:31 INFO - 'enable_webrender': False, 18:48:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 18:48:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:48:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:48:31 INFO - 'gecko_profile': False, 18:48:31 INFO - 'gecko_profile_interval': 0, 18:48:31 INFO - 'installer_path': 'installer.exe', 18:48:31 INFO - 'log_level': 'info', 18:48:31 INFO - 'log_name': 'talos', 18:48:31 INFO - 'log_to_console': True, 18:48:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:48:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:48:31 INFO - 'opt_config_files': (), 18:48:31 INFO - 'pip_index': False, 18:48:31 INFO - 'suite': 'dromaeojs-e10s', 18:48:31 INFO - 'system_bits': '32', 18:48:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:48:31 INFO - 'title': 'talos-linux64-ix-017', 18:48:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:48:31 INFO - 'use_talos_json': True, 18:48:31 INFO - 'verify': 'False', 18:48:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:48:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:48:31 INFO - 'work_dir': 'build'} 18:48:31 INFO - [mozharness: 2017-09-15 01:48:31.910141Z] Running clobber step. 18:48:31 INFO - Running pre-action listener: _resource_record_pre_action 18:48:31 INFO - Running main action method: clobber 18:48:31 INFO - rmtree: /builds/slave/test/build 18:48:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:48:32 INFO - Running post-action listener: _resource_record_post_action 18:48:32 INFO - [mozharness: 2017-09-15 01:48:32.896078Z] Finished clobber step (success) 18:48:32 INFO - [mozharness: 2017-09-15 01:48:32.896175Z] Running read-buildbot-config step. 18:48:32 INFO - Running pre-action listener: _resource_record_pre_action 18:48:32 INFO - Running main action method: read_buildbot_config 18:48:32 INFO - Using buildbot properties: 18:48:32 INFO - { 18:48:32 INFO - "project": "", 18:48:32 INFO - "product": "firefox", 18:48:32 INFO - "who": "catlee@mozilla.com", 18:48:32 INFO - "installer_path": "public/build/target.tar.bz2", 18:48:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 18:48:32 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 18:48:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 18:48:32 INFO - "stage_platform": "linux64", 18:48:32 INFO - "basedir": "/builds/slave/test", 18:48:32 INFO - "buildnumber": 109, 18:48:32 INFO - "platform": "ubuntu64_hw", 18:48:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:48:32 INFO - "slavebuilddir": "test", 18:48:32 INFO - "taskId": "AB1rd4bdTUe9ZTN4tjnj7Q", 18:48:32 INFO - "branch": "mozilla-beta", 18:48:32 INFO - "script_repo_revision": "production", 18:48:32 INFO - "revision": "e85c29016601de4367a96ff4bc37a440206f3304", 18:48:32 INFO - "slavename": "talos-linux64-ix-017", 18:48:32 INFO - "repo_path": "releases/mozilla-beta" 18:48:32 INFO - } 18:48:32 INFO - Finding installer, test and symbols from parent task. 18:48:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AB1rd4bdTUe9ZTN4tjnj7Q'}, attempt #1 18:48:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AB1rd4bdTUe9ZTN4tjnj7Q'}, attempt #1 18:48:33 INFO - Task dependencies: JqZSVEnuQWW_NWeaC3HcgA 18:48:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA'}, attempt #1 18:48:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.tar.bz2 18:48:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.test_packages.json 18:48:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.crashreporter-symbols.zip 18:48:34 INFO - Running post-action listener: _resource_record_post_action 18:48:34 INFO - [mozharness: 2017-09-15 01:48:34.342947Z] Finished read-buildbot-config step (success) 18:48:34 INFO - [mozharness: 2017-09-15 01:48:34.343164Z] Running download-and-extract step. 18:48:34 INFO - Running pre-action listener: _resource_record_pre_action 18:48:34 INFO - Running main action method: download_and_extract 18:48:34 INFO - mkdir: /builds/slave/test/build/tests 18:48:34 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')]} 18:48:34 INFO - trying https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.test_packages.json 18:48:34 INFO - Downloading https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:48:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:48:34 INFO - Downloaded 989 bytes. 18:48:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:48:34 INFO - Using the following test package requirements: 18:48:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:48:34 INFO - u'common': [u'target.common.tests.zip'], 18:48:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:48:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:48:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:48:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:48:34 INFO - u'mozbase': [u'target.common.tests.zip'], 18:48:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:48:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:48:34 INFO - u'web-platform': [u'target.common.tests.zip', 18:48:34 INFO - u'target.web-platform.tests.tar.gz'], 18:48:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:48:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 18:48:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.common.tests.zip 18:48:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:48:34 INFO - Fetch https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.common.tests.zip into memory 18:49:06 INFO - Content-Length response header: 55170917 18:49:06 INFO - Bytes received: 55170917 18:49:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.talos.tests.zip 18:49:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:49:17 INFO - Fetch https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.talos.tests.zip into memory 18:49:28 INFO - Content-Length response header: 14500356 18:49:28 INFO - Bytes received: 14500356 18:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:29 INFO - trying https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.tar.bz2 18:49:29 INFO - Downloading https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:49:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:50:13 INFO - Downloaded 53358717 bytes. 18:50:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.tar.bz2 18:50:13 INFO - mkdir: /builds/slave/test/properties 18:50:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:50:13 INFO - Writing to file /builds/slave/test/properties/build_url 18:50:13 INFO - Contents: 18:50:13 INFO - build_url:https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.tar.bz2 18:50:13 INFO - Running post-action listener: _resource_record_post_action 18:50:13 INFO - Running post-action listener: find_tests_for_verification 18:50:13 INFO - Running post-action listener: set_extra_try_arguments 18:50:13 INFO - [mozharness: 2017-09-15 01:50:13.213844Z] Finished download-and-extract step (success) 18:50:13 INFO - [mozharness: 2017-09-15 01:50:13.214072Z] Running populate-webroot step. 18:50:13 INFO - Running pre-action listener: _resource_record_pre_action 18:50:13 INFO - Running main action method: populate_webroot 18:50:13 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:50:13 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:50:13 INFO - 'tests': ['tresize', 18:50:13 INFO - 'tcanvasmark']}, 18:50:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:50:13 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:50:13 INFO - 'tests': ['dromaeo_css', 18:50:13 INFO - 'kraken']}, 18:50:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:50:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:50:13 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:50:13 INFO - 'talos_options': ['--disable-stylo'], 18:50:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:50:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:50:13 INFO - 'tests': ['damp', 'tps']}, 18:50:13 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:50:13 INFO - 'talos_options': ['--disable-stylo'], 18:50:13 INFO - 'tests': ['damp', 'tps']}, 18:50:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:50:13 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:50:13 INFO - 'tests': ['dromaeo_dom']}, 18:50:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:50:13 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:50:13 INFO - 'tests': ['basic_compositor_video', 18:50:13 INFO - 'glvideo']}, 18:50:13 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:50:13 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:50:13 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:50:13 INFO - 'talos_options': ['--disable-stylo'], 18:50:13 INFO - 'tests': ['ts_paint_webext', 18:50:13 INFO - 'tp5o_webext']}, 18:50:13 INFO - 'other-e10s': {'tests': ['a11yr', 18:50:13 INFO - 'ts_paint', 18:50:13 INFO - 'tpaint', 18:50:13 INFO - 'sessionrestore', 18:50:13 INFO - 'sessionrestore_many_windows', 18:50:13 INFO - 'sessionrestore_no_auto_restore', 18:50:13 INFO - 'tabpaint']}, 18:50:13 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:50:13 INFO - 'tests': ['a11yr', 18:50:13 INFO - 'ts_paint', 18:50:13 INFO - 'tpaint', 18:50:13 INFO - 'sessionrestore', 18:50:13 INFO - 'sessionrestore_many_windows', 18:50:13 INFO - 'sessionrestore_no_auto_restore', 18:50:13 INFO - 'tabpaint']}, 18:50:13 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:50:13 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:50:13 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:50:13 INFO - 'tests': ['bloom_basic_singleton']}, 18:50:13 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:50:13 INFO - 'tests': ['bloom_basic']}, 18:50:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:50:13 INFO - 'tsvgr_opacity', 18:50:13 INFO - 'tart', 18:50:13 INFO - 'tscrollx', 18:50:13 INFO - 'tsvg_static']}, 18:50:13 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:50:13 INFO - 'tests': ['tsvgx', 18:50:13 INFO - 'tsvgr_opacity', 18:50:13 INFO - 'tart', 18:50:13 INFO - 'tscrollx', 18:50:13 INFO - 'tsvg_static']}, 18:50:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:50:13 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:50:13 INFO - 'talos_options': ['--disable-stylo'], 18:50:13 INFO - 'tests': ['tp5o']}, 18:50:13 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:50:13 INFO - 'talos_options': ['--mitmproxy', 18:50:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:50:13 INFO - '--firstNonBlankPaint'], 18:50:13 INFO - 'tests': ['tp6_google', 18:50:13 INFO - 'tp6_youtube', 18:50:13 INFO - 'tp6_amazon', 18:50:13 INFO - 'tp6_facebook']}, 18:50:13 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:50:13 INFO - 'talos_options': ['--disable-stylo', 18:50:13 INFO - '--mitmproxy', 18:50:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:50:13 INFO - '--firstNonBlankPaint'], 18:50:13 INFO - 'tests': ['tp6_google', 18:50:13 INFO - 'tp6_youtube', 18:50:13 INFO - 'tp6_amazon', 18:50:13 INFO - 'tp6_facebook']}, 18:50:13 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:50:13 INFO - 'talos_options': ['--stylo-threads=1', 18:50:13 INFO - '--mitmproxy', 18:50:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:50:13 INFO - '--firstNonBlankPaint'], 18:50:13 INFO - 'tests': ['tp6_google', 18:50:13 INFO - 'tp6_youtube', 18:50:13 INFO - 'tp6_amazon', 18:50:13 INFO - 'tp6_facebook']}, 18:50:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:50:13 INFO - 'talos_options': ['--xperf_path', 18:50:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:50:13 INFO - 'tests': ['tp5n']}, 18:50:13 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:50:13 INFO - 'talos_options': ['--disable-stylo', 18:50:13 INFO - '--xperf_path', 18:50:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:50:13 INFO - 'tests': ['tp5n']}}} 18:50:13 INFO - Running post-action listener: _resource_record_post_action 18:50:13 INFO - [mozharness: 2017-09-15 01:50:13.233454Z] Finished populate-webroot step (success) 18:50:13 INFO - [mozharness: 2017-09-15 01:50:13.233543Z] Running create-virtualenv step. 18:50:13 INFO - Running pre-action listener: _resource_record_pre_action 18:50:13 INFO - Running main action method: create_virtualenv 18:50:13 INFO - Creating virtualenv /builds/slave/test/build/venv 18:50:13 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:50:13 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 18:50:13 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:50:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:50:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:50:13 INFO - Installing distribute.............................................................................................................................................................................................done. 18:50:14 INFO - Installing pip...............done. 18:50:14 INFO - Return code: 0 18:50:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:50:14 INFO - Reading from file tmpfile_stdout 18:50:14 INFO - Output received: 18:50:14 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 18:50:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:50:14 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')]} 18:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:14 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')]} 18:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:14 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 0x1f241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293090>, '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 0x2293d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228df90>, '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': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', '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 18:50:14 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 18:50:14 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 18:50:14 INFO - Using env: {'DISPLAY': ':0', 18:50:14 INFO - 'HOME': '/home/cltbld', 18:50:14 INFO - 'LANG': 'en_US.UTF-8', 18:50:14 INFO - 'LANGUAGE': 'en_US:en', 18:50:14 INFO - 'LOGNAME': 'cltbld', 18:50:14 INFO - 'MAIL': '/var/mail/cltbld', 18:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:14 INFO - 'MOZ_NO_REMOTE': '1', 18:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:14 INFO - 'NO_EM_RESTART': '1', 18:50:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:14 INFO - 'PWD': '/builds/slave/test', 18:50:14 INFO - 'SHELL': '/bin/bash', 18:50:14 INFO - 'SHLVL': '1', 18:50:14 INFO - 'TERM': 'linux', 18:50:14 INFO - 'TMOUT': '86400', 18:50:14 INFO - 'USER': 'cltbld', 18:50:14 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', 18:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:14 INFO - '_': '/tools/buildbot/bin/python'} 18:50:15 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:50:15 INFO - Downloading/unpacking pip>=1.5 18:50:15 INFO - Running setup.py egg_info for package pip 18:50:15 INFO - warning: no files found matching 'pip/cacert.pem' 18:50:15 INFO - warning: no files found matching '*.html' under directory 'docs' 18:50:15 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:50:15 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:50:15 INFO - Installing collected packages: pip 18:50:15 INFO - Found existing installation: pip 1.1 18:50:15 INFO - Uninstalling pip: 18:50:15 INFO - Successfully uninstalled pip 18:50:15 INFO - Running setup.py install for pip 18:50:15 INFO - warning: no files found matching 'pip/cacert.pem' 18:50:15 INFO - warning: no files found matching '*.html' under directory 'docs' 18:50:15 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:50:15 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:50:15 INFO - Installing pip script to /builds/slave/test/build/venv/bin 18:50:15 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 18:50:15 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 18:50:15 INFO - Successfully installed pip 18:50:15 INFO - Cleaning up... 18:50:15 INFO - Return code: 0 18:50:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:50:15 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')]} 18:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:15 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')]} 18:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:15 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 0x1f241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293090>, '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 0x2293d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228df90>, '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': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', '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 18:50:15 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 18:50:15 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 18:50:15 INFO - Using env: {'DISPLAY': ':0', 18:50:15 INFO - 'HOME': '/home/cltbld', 18:50:15 INFO - 'LANG': 'en_US.UTF-8', 18:50:15 INFO - 'LANGUAGE': 'en_US:en', 18:50:15 INFO - 'LOGNAME': 'cltbld', 18:50:15 INFO - 'MAIL': '/var/mail/cltbld', 18:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:15 INFO - 'MOZ_NO_REMOTE': '1', 18:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:15 INFO - 'NO_EM_RESTART': '1', 18:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:15 INFO - 'PWD': '/builds/slave/test', 18:50:15 INFO - 'SHELL': '/bin/bash', 18:50:15 INFO - 'SHLVL': '1', 18:50:15 INFO - 'TERM': 'linux', 18:50:15 INFO - 'TMOUT': '86400', 18:50:15 INFO - 'USER': 'cltbld', 18:50:15 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', 18:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:15 INFO - '_': '/tools/buildbot/bin/python'} 18:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:15 INFO - Downloading/unpacking psutil>=3.1.1 18:50:15 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 18:50:15 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 18:50:15 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 18:50:15 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 18:50:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:50:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:50:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:50:16 INFO - Installing collected packages: psutil 18:50:16 INFO - Running setup.py install for psutil 18:50:16 INFO - building 'psutil._psutil_linux' extension 18:50:16 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 18:50:17 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 18:50:17 INFO - building 'psutil._psutil_posix' extension 18:50:17 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 18:50:17 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 18:50:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:50:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:50:17 INFO - Successfully installed psutil 18:50:17 INFO - Cleaning up... 18:50:17 INFO - Return code: 0 18:50:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:50:17 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')]} 18:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:17 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')]} 18:50:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:17 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 0x1f241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293090>, '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 0x2293d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228df90>, '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': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', '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 18:50:17 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 18:50:17 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 18:50:17 INFO - Using env: {'DISPLAY': ':0', 18:50:17 INFO - 'HOME': '/home/cltbld', 18:50:17 INFO - 'LANG': 'en_US.UTF-8', 18:50:17 INFO - 'LANGUAGE': 'en_US:en', 18:50:17 INFO - 'LOGNAME': 'cltbld', 18:50:17 INFO - 'MAIL': '/var/mail/cltbld', 18:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:17 INFO - 'MOZ_NO_REMOTE': '1', 18:50:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:17 INFO - 'NO_EM_RESTART': '1', 18:50:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:17 INFO - 'PWD': '/builds/slave/test', 18:50:17 INFO - 'SHELL': '/bin/bash', 18:50:17 INFO - 'SHLVL': '1', 18:50:17 INFO - 'TERM': 'linux', 18:50:17 INFO - 'TMOUT': '86400', 18:50:17 INFO - 'USER': 'cltbld', 18:50:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', 18:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:17 INFO - '_': '/tools/buildbot/bin/python'} 18:50:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:50:17 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 18:50:17 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 18:50:17 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 18:50:17 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 18:50:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:50:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:50:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:50:18 INFO - Installing collected packages: mozsystemmonitor 18:50:18 INFO - Running setup.py install for mozsystemmonitor 18:50:18 INFO - Successfully installed mozsystemmonitor 18:50:18 INFO - Cleaning up... 18:50:18 INFO - Return code: 0 18:50:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:50:18 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')]} 18:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:18 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')]} 18:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:18 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 0x1f241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293090>, '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 0x2293d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228df90>, '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': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', '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 18:50:18 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 18:50:18 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 18:50:18 INFO - Using env: {'DISPLAY': ':0', 18:50:18 INFO - 'HOME': '/home/cltbld', 18:50:18 INFO - 'LANG': 'en_US.UTF-8', 18:50:18 INFO - 'LANGUAGE': 'en_US:en', 18:50:18 INFO - 'LOGNAME': 'cltbld', 18:50:18 INFO - 'MAIL': '/var/mail/cltbld', 18:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:18 INFO - 'MOZ_NO_REMOTE': '1', 18:50:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:18 INFO - 'NO_EM_RESTART': '1', 18:50:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:18 INFO - 'PWD': '/builds/slave/test', 18:50:18 INFO - 'SHELL': '/bin/bash', 18:50:18 INFO - 'SHLVL': '1', 18:50:18 INFO - 'TERM': 'linux', 18:50:18 INFO - 'TMOUT': '86400', 18:50:18 INFO - 'USER': 'cltbld', 18:50:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', 18:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:18 INFO - '_': '/tools/buildbot/bin/python'} 18:50:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:19 INFO - Downloading/unpacking jsonschema==2.5.1 18:50:19 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 18:50:19 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 18:50:19 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 18:50:19 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 18:50:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:50:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:50:20 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 18:50:20 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 18:50:20 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 18:50:20 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 18:50:20 INFO - Downloading functools32-3.2.3-2.tar.gz 18:50:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:50:20 INFO - warning: no files found matching '*.txt' 18:50:20 INFO - no previously-included directories found matching 'build' 18:50:20 INFO - no previously-included directories found matching 'dist' 18:50:20 INFO - no previously-included directories found matching '.git*' 18:50:20 INFO - Installing collected packages: jsonschema, functools32 18:50:20 INFO - Running setup.py install for functools32 18:50:20 INFO - warning: no files found matching '*.txt' 18:50:20 INFO - no previously-included directories found matching 'build' 18:50:20 INFO - no previously-included directories found matching 'dist' 18:50:20 INFO - no previously-included directories found matching '.git*' 18:50:20 INFO - Successfully installed jsonschema functools32 18:50:20 INFO - Cleaning up... 18:50:20 INFO - Return code: 0 18:50:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:50:20 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')]} 18:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:20 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')]} 18:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:20 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 0x1f241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293090>, '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 0x2293d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228df90>, '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': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', '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 18:50:20 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 18:50:20 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 18:50:20 INFO - Using env: {'DISPLAY': ':0', 18:50:20 INFO - 'HOME': '/home/cltbld', 18:50:20 INFO - 'LANG': 'en_US.UTF-8', 18:50:20 INFO - 'LANGUAGE': 'en_US:en', 18:50:20 INFO - 'LOGNAME': 'cltbld', 18:50:20 INFO - 'MAIL': '/var/mail/cltbld', 18:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:20 INFO - 'MOZ_NO_REMOTE': '1', 18:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:20 INFO - 'NO_EM_RESTART': '1', 18:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:20 INFO - 'PWD': '/builds/slave/test', 18:50:20 INFO - 'SHELL': '/bin/bash', 18:50:20 INFO - 'SHLVL': '1', 18:50:20 INFO - 'TERM': 'linux', 18:50:20 INFO - 'TMOUT': '86400', 18:50:20 INFO - 'USER': 'cltbld', 18:50:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', 18:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:20 INFO - '_': '/tools/buildbot/bin/python'} 18:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:50:20 INFO - Cleaning up... 18:50:20 INFO - Return code: 0 18:50:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:50:20 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')]} 18:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:20 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')]} 18:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:20 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 0x1f241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293090>, '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 0x2293d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228df90>, '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': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', '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 18:50:20 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 18:50:20 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 18:50:20 INFO - Using env: {'DISPLAY': ':0', 18:50:20 INFO - 'HOME': '/home/cltbld', 18:50:20 INFO - 'LANG': 'en_US.UTF-8', 18:50:20 INFO - 'LANGUAGE': 'en_US:en', 18:50:20 INFO - 'LOGNAME': 'cltbld', 18:50:20 INFO - 'MAIL': '/var/mail/cltbld', 18:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:20 INFO - 'MOZ_NO_REMOTE': '1', 18:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:20 INFO - 'NO_EM_RESTART': '1', 18:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:20 INFO - 'PWD': '/builds/slave/test', 18:50:20 INFO - 'SHELL': '/bin/bash', 18:50:20 INFO - 'SHLVL': '1', 18:50:20 INFO - 'TERM': 'linux', 18:50:20 INFO - 'TMOUT': '86400', 18:50:20 INFO - 'USER': 'cltbld', 18:50:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', 18:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:20 INFO - '_': '/tools/buildbot/bin/python'} 18:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:20 INFO - Downloading/unpacking blobuploader==1.2.4 18:50:20 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 18:50:20 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 18:50:20 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 18:50:20 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 18:50:22 INFO - Downloading blobuploader-1.2.4.tar.gz 18:50:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:50:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:50:22 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 18:50:22 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 18:50:22 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 18:50:22 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 18:50:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:50:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:50:22 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 18:50:22 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 18:50:22 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 18:50:22 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 18:50:22 INFO - Downloading docopt-0.6.1.tar.gz 18:50:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:50:22 INFO - Installing collected packages: blobuploader, requests, docopt 18:50:22 INFO - Running setup.py install for blobuploader 18:50:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:50:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:50:22 INFO - Running setup.py install for requests 18:50:23 INFO - Running setup.py install for docopt 18:50:23 INFO - Successfully installed blobuploader requests docopt 18:50:23 INFO - Cleaning up... 18:50:23 INFO - Return code: 0 18:50:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50:23 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')]} 18:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:23 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')]} 18:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:23 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 0x1f241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293090>, '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 0x2293d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228df90>, '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': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', '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 18:50:23 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 18:50:23 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 18:50:23 INFO - Using env: {'DISPLAY': ':0', 18:50:23 INFO - 'HOME': '/home/cltbld', 18:50:23 INFO - 'LANG': 'en_US.UTF-8', 18:50:23 INFO - 'LANGUAGE': 'en_US:en', 18:50:23 INFO - 'LOGNAME': 'cltbld', 18:50:23 INFO - 'MAIL': '/var/mail/cltbld', 18:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:23 INFO - 'MOZ_NO_REMOTE': '1', 18:50:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:23 INFO - 'NO_EM_RESTART': '1', 18:50:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:23 INFO - 'PWD': '/builds/slave/test', 18:50:23 INFO - 'SHELL': '/bin/bash', 18:50:23 INFO - 'SHLVL': '1', 18:50:23 INFO - 'TERM': 'linux', 18:50:23 INFO - 'TMOUT': '86400', 18:50:23 INFO - 'USER': 'cltbld', 18:50:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', 18:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:23 INFO - '_': '/tools/buildbot/bin/python'} 18:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:50:23 INFO - Running setup.py (path:/tmp/pip-FLttI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:50:23 INFO - Running setup.py (path:/tmp/pip-bmNBTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:50:23 INFO - Running setup.py (path:/tmp/pip-S52FGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:50:23 INFO - Running setup.py (path:/tmp/pip-hrlXWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:50:23 INFO - Running setup.py (path:/tmp/pip-aMEAhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:50:23 INFO - Running setup.py (path:/tmp/pip-V0kBLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:50:23 INFO - Running setup.py (path:/tmp/pip-oeGnXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:50:23 INFO - Running setup.py (path:/tmp/pip-8tUM0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:50:24 INFO - Running setup.py (path:/tmp/pip-YB_fl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:50:24 INFO - Running setup.py (path:/tmp/pip-x2dcJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:50:24 INFO - Running setup.py (path:/tmp/pip-o9o29E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:50:24 INFO - Running setup.py (path:/tmp/pip-qQACvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:50:24 INFO - Running setup.py (path:/tmp/pip-q7HFXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:50:24 INFO - Running setup.py (path:/tmp/pip-CZoNvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:24 INFO - Running setup.py (path:/tmp/pip-RNnyvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:50:24 INFO - Running setup.py (path:/tmp/pip-SVN0n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:50:24 INFO - Running setup.py (path:/tmp/pip-SkpMLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:50:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:50:24 INFO - Running setup.py install for manifestparser 18:50:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:50:24 INFO - Running setup.py install for mozcrash 18:50:24 INFO - Running setup.py install for mozdebug 18:50:24 INFO - Running setup.py install for mozdevice 18:50:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:50:25 INFO - Running setup.py install for mozfile 18:50:25 INFO - Running setup.py install for mozhttpd 18:50:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:50:25 INFO - Running setup.py install for mozinfo 18:50:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:50:25 INFO - Running setup.py install for mozInstall 18:50:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:50:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:50:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:50:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:50:25 INFO - Running setup.py install for mozleak 18:50:25 INFO - Running setup.py install for mozlog 18:50:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:50:25 INFO - Running setup.py install for moznetwork 18:50:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:50:25 INFO - Running setup.py install for mozprocess 18:50:25 INFO - Running setup.py install for mozprofile 18:50:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:50:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:50:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:50:25 INFO - Running setup.py install for mozrunner 18:50:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:50:26 INFO - Running setup.py install for mozscreenshot 18:50:26 INFO - Running setup.py install for moztest 18:50:26 INFO - Running setup.py install for mozversion 18:50:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:50:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:50:26 INFO - Cleaning up... 18:50:26 INFO - Return code: 0 18:50:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:26 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 0x1f241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293090>, '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 0x2293d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228df90>, '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': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', '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 18:50:26 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 18:50:26 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 18:50:26 INFO - Using env: {'DISPLAY': ':0', 18:50:26 INFO - 'HOME': '/home/cltbld', 18:50:26 INFO - 'LANG': 'en_US.UTF-8', 18:50:26 INFO - 'LANGUAGE': 'en_US:en', 18:50:26 INFO - 'LOGNAME': 'cltbld', 18:50:26 INFO - 'MAIL': '/var/mail/cltbld', 18:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:26 INFO - 'MOZ_NO_REMOTE': '1', 18:50:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:26 INFO - 'NO_EM_RESTART': '1', 18:50:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:26 INFO - 'PWD': '/builds/slave/test', 18:50:26 INFO - 'SHELL': '/bin/bash', 18:50:26 INFO - 'SHLVL': '1', 18:50:26 INFO - 'TERM': 'linux', 18:50:26 INFO - 'TMOUT': '86400', 18:50:26 INFO - 'USER': 'cltbld', 18:50:26 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', 18:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:26 INFO - '_': '/tools/buildbot/bin/python'} 18:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:50:26 INFO - Running setup.py (path:/tmp/pip-HulV9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:50:26 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)) 18:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:50:26 INFO - Running setup.py (path:/tmp/pip-vbSYlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:50:26 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)) 18:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:50:26 INFO - Running setup.py (path:/tmp/pip-Aps2cF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:50:26 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)) 18:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:50:26 INFO - Running setup.py (path:/tmp/pip-r0mzAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:50:26 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)) 18:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:50:26 INFO - Running setup.py (path:/tmp/pip-o0EYQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:50:26 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)) 18:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:50:26 INFO - Running setup.py (path:/tmp/pip-8KOocq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:50:27 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)) 18:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:50:27 INFO - Running setup.py (path:/tmp/pip-cYGWch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:50:27 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)) 18:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:50:27 INFO - Running setup.py (path:/tmp/pip-_HrEqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:50:27 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)) 18:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:50:27 INFO - Running setup.py (path:/tmp/pip-CxHscl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:50:27 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)) 18:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:50:27 INFO - Running setup.py (path:/tmp/pip-xVVESe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:50:27 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)) 18:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:50:27 INFO - Running setup.py (path:/tmp/pip-ALb7lU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:50:27 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)) 18:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:50:27 INFO - Running setup.py (path:/tmp/pip-zRNtsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:50:27 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)) 18:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:50:27 INFO - Running setup.py (path:/tmp/pip-fxAFsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:50:27 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)) 18:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:50:27 INFO - Running setup.py (path:/tmp/pip-BnZoTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:50:27 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)) 18:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:27 INFO - Running setup.py (path:/tmp/pip-nyTHma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:27 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)) 18:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:50:27 INFO - Running setup.py (path:/tmp/pip-2ZoJ8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:50:27 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)) 18:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:50:27 INFO - Running setup.py (path:/tmp/pip-OzpZ1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:50:27 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)) 18:50:27 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)) 18:50:27 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)) 18:50:27 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)) 18:50:27 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)) 18:50:27 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)) 18:50:27 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)) 18:50:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:50:27 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 18:50:27 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 18:50:27 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 18:50:27 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 18:50:28 INFO - Downloading blessings-1.6.tar.gz 18:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:50:29 INFO - Installing collected packages: blessings 18:50:29 INFO - Running setup.py install for blessings 18:50:29 INFO - Successfully installed blessings 18:50:29 INFO - Cleaning up... 18:50:29 INFO - Return code: 0 18:50:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:50:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:50:29 INFO - Reading from file tmpfile_stdout 18:50:29 INFO - Current package versions: 18:50:29 INFO - argparse == 1.2.1 18:50:29 INFO - blessings == 1.6 18:50:29 INFO - blobuploader == 1.2.4 18:50:29 INFO - docopt == 0.6.1 18:50:29 INFO - functools32 == 3.2.3-2 18:50:29 INFO - jsonschema == 2.5.1 18:50:29 INFO - manifestparser == 1.1 18:50:29 INFO - mozInstall == 1.13 18:50:29 INFO - mozcrash == 1.0 18:50:29 INFO - mozdebug == 0.1 18:50:29 INFO - mozdevice == 0.51 18:50:29 INFO - mozfile == 1.2 18:50:29 INFO - mozhttpd == 0.7 18:50:29 INFO - mozinfo == 0.10 18:50:29 INFO - mozleak == 0.1 18:50:29 INFO - mozlog == 3.5 18:50:29 INFO - moznetwork == 0.27 18:50:29 INFO - mozprocess == 0.25 18:50:29 INFO - mozprofile == 0.28 18:50:29 INFO - mozrunner == 6.13 18:50:29 INFO - mozscreenshot == 0.1 18:50:29 INFO - mozsystemmonitor == 0.3 18:50:29 INFO - moztest == 0.8 18:50:29 INFO - mozversion == 1.4 18:50:29 INFO - psutil == 3.1.1 18:50:29 INFO - requests == 1.2.3 18:50:29 INFO - wsgiref == 0.1.2 18:50:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:29 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 0x1f241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293090>, '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 0x2293d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228df90>, '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': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', '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 18:50:29 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 18:50:29 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 18:50:29 INFO - Using env: {'DISPLAY': ':0', 18:50:29 INFO - 'HOME': '/home/cltbld', 18:50:29 INFO - 'LANG': 'en_US.UTF-8', 18:50:29 INFO - 'LANGUAGE': 'en_US:en', 18:50:29 INFO - 'LOGNAME': 'cltbld', 18:50:29 INFO - 'MAIL': '/var/mail/cltbld', 18:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:29 INFO - 'MOZ_NO_REMOTE': '1', 18:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:29 INFO - 'NO_EM_RESTART': '1', 18:50:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:29 INFO - 'PWD': '/builds/slave/test', 18:50:29 INFO - 'SHELL': '/bin/bash', 18:50:29 INFO - 'SHLVL': '1', 18:50:29 INFO - 'TERM': 'linux', 18:50:29 INFO - 'TMOUT': '86400', 18:50:29 INFO - 'USER': 'cltbld', 18:50:29 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', 18:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:29 INFO - '_': '/tools/buildbot/bin/python'} 18:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:50:29 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 18:50:29 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 18:50:29 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 18:50:29 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 18:50:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:50:30 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)) 18:50:30 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)) 18:50:30 INFO - Installing collected packages: simplejson 18:50:30 INFO - Running setup.py install for simplejson 18:50:30 INFO - building 'simplejson._speedups' extension 18:50:30 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 18:50:31 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 18:50:31 INFO - Successfully installed simplejson 18:50:31 INFO - Cleaning up... 18:50:31 INFO - Return code: 0 18:50:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:50:31 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')]} 18:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:31 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')]} 18:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:31 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 0x1f241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293090>, '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 0x2293d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228df90>, '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': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', '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 18:50:31 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 18:50:31 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 18:50:31 INFO - Using env: {'DISPLAY': ':0', 18:50:31 INFO - 'HOME': '/home/cltbld', 18:50:31 INFO - 'LANG': 'en_US.UTF-8', 18:50:31 INFO - 'LANGUAGE': 'en_US:en', 18:50:31 INFO - 'LOGNAME': 'cltbld', 18:50:31 INFO - 'MAIL': '/var/mail/cltbld', 18:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:31 INFO - 'MOZ_NO_REMOTE': '1', 18:50:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:31 INFO - 'NO_EM_RESTART': '1', 18:50:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:31 INFO - 'PWD': '/builds/slave/test', 18:50:31 INFO - 'SHELL': '/bin/bash', 18:50:31 INFO - 'SHLVL': '1', 18:50:31 INFO - 'TERM': 'linux', 18:50:31 INFO - 'TMOUT': '86400', 18:50:31 INFO - 'USER': 'cltbld', 18:50:31 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', 18:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:31 INFO - '_': '/tools/buildbot/bin/python'} 18:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:50:32 INFO - Cleaning up... 18:50:32 INFO - Return code: 0 18:50:32 INFO - Running post-action listener: _resource_record_post_action 18:50:32 INFO - Running post-action listener: _start_resource_monitoring 18:50:32 INFO - Starting resource monitoring. 18:50:32 INFO - [mozharness: 2017-09-15 01:50:32.089897Z] Finished create-virtualenv step (success) 18:50:32 INFO - [mozharness: 2017-09-15 01:50:32.090361Z] Running install step. 18:50:32 INFO - Running pre-action listener: _resource_record_pre_action 18:50:32 INFO - Running main action method: install 18:50:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:50:32 INFO - Reading from file tmpfile_stdout 18:50:32 INFO - Detecting whether we're running mozinstall >=1.0... 18:50:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:50:32 INFO - Reading from file tmpfile_stdout 18:50:32 INFO - Output received: 18:50:32 INFO - Usage: mozinstall [options] installer 18:50:32 INFO - Options: 18:50:32 INFO - -h, --help show this help message and exit 18:50:32 INFO - -d DEST, --destination=DEST 18:50:32 INFO - Directory to install application into. [default: 18:50:32 INFO - "/builds/slave/test"] 18:50:32 INFO - --app=APP Application being installed. [default: firefox] 18:50:32 INFO - mkdir: /builds/slave/test/build/application 18:50:32 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'] 18:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:50:46 INFO - Reading from file tmpfile_stdout 18:50:46 INFO - Output received: 18:50:46 INFO - /builds/slave/test/build/application/firefox/firefox 18:50:46 INFO - Running post-action listener: _resource_record_post_action 18:50:46 INFO - [mozharness: 2017-09-15 01:50:46.988540Z] Finished install step (success) 18:50:46 INFO - [mozharness: 2017-09-15 01:50:46.988789Z] Running setup-mitmproxy step. 18:50:46 INFO - Running pre-action listener: _resource_record_pre_action 18:50:46 INFO - Running main action method: setup_mitmproxy 18:50:46 INFO - Skipping: mitmproxy is not required 18:50:46 INFO - Running post-action listener: _resource_record_post_action 18:50:46 INFO - [mozharness: 2017-09-15 01:50:46.989976Z] Finished setup-mitmproxy step (success) 18:50:46 INFO - [mozharness: 2017-09-15 01:50:46.990197Z] Running run-tests step. 18:50:46 INFO - Running pre-action listener: _resource_record_pre_action 18:50:46 INFO - Running pre-action listener: _set_gcov_prefix 18:50:46 INFO - Running main action method: run_tests 18:50:46 WARNING - Try message not found. 18:50:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:50:46 INFO - Python 2.7.3 18:50:47 INFO - Return code: 0 18:50:47 INFO - grabbing minidump binary from tooltool 18:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:47 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 0x2293090>, '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 0x2293d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:50:47 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 18:50:47 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 18:50:47 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 18:50:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:50:47 INFO - Return code: 0 18:50:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:50:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:50:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:50:47 INFO - ENV: RUST_BACKTRACE is now full 18:50:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:50:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:50:47 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/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 18:50:47 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/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 18:50:47 INFO - Using env: {'DISPLAY': ':0', 18:50:47 INFO - 'HOME': '/home/cltbld', 18:50:47 INFO - 'LANG': 'en_US.UTF-8', 18:50:47 INFO - 'LANGUAGE': 'en_US:en', 18:50:47 INFO - 'LOGNAME': 'cltbld', 18:50:47 INFO - 'MAIL': '/var/mail/cltbld', 18:50:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:50:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:47 INFO - 'MOZ_NO_REMOTE': '1', 18:50:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:47 INFO - 'NO_EM_RESTART': '1', 18:50:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:47 INFO - 'PWD': '/builds/slave/test', 18:50:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:50:47 INFO - 'RUST_BACKTRACE': 'full', 18:50:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:50:47 INFO - 'SHELL': '/bin/bash', 18:50:47 INFO - 'SHLVL': '1', 18:50:47 INFO - 'TERM': 'linux', 18:50:47 INFO - 'TMOUT': '86400', 18:50:47 INFO - 'USER': 'cltbld', 18:50:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', 18:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:47 INFO - '_': '/tools/buildbot/bin/python'} 18:50:47 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/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 18:50:47 INFO - mozversion application_buildid: 20170915003610 18:50:47 INFO - mozversion application_changeset: e85c29016601de4367a96ff4bc37a440206f3304 18:50:47 INFO - mozversion application_display_name: Firefox 18:50:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:50:47 INFO - mozversion application_name: Firefox 18:50:47 INFO - mozversion application_remotingname: firefox 18:50:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:50:47 INFO - mozversion application_vendor: Mozilla 18:50:47 INFO - mozversion application_version: 57.0 18:50:47 INFO - mozversion platform_buildid: 20170915003610 18:50:47 INFO - mozversion platform_changeset: e85c29016601de4367a96ff4bc37a440206f3304 18:50:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:50:47 INFO - mozversion platform_version: 57.0 18:50:47 INFO - using testdate: 1505440247 18:50:47 INFO - actual date: 1505440247 18:50:47 INFO - starting webserver on 'localhost:55807' 18:50:47 INFO - SUITE-START | Running 2 tests 18:50:47 INFO - TEST-START | dromaeo_css 18:50:47 INFO - Initialising browser for dromaeo_css test... 18:50:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55807/getInfo.html -profile /tmp/tmp4ebZyt/profile 18:50:47 INFO - TEST-INFO | started process 29795 (/builds/slave/test/build/application/firefox/firefox http://localhost:55807/getInfo.html) 18:50:52 INFO - TEST-INFO | 29795: exit 0 18:50:52 INFO - Browser initialized. 18:50:52 INFO - Running cycle 1/1 for dromaeo_css test... 18:50:52 INFO - Using env: {'DISPLAY': ':0', 18:50:52 INFO - 'HOME': '/home/cltbld', 18:50:52 INFO - 'JSGC_DISABLE_POISONING': '1', 18:50:52 INFO - 'LANG': 'en_US.UTF-8', 18:50:52 INFO - 'LANGUAGE': 'en_US:en', 18:50:52 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:50:52 INFO - 'LOGNAME': 'cltbld', 18:50:52 INFO - 'MAIL': '/var/mail/cltbld', 18:50:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:50:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:50:52 INFO - 'MOZ_CRASHREPORTER': '1', 18:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:52 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:50:52 INFO - 'MOZ_NO_REMOTE': '1', 18:50:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:52 INFO - 'NO_EM_RESTART': '1', 18:50:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:52 INFO - 'PWD': '/builds/slave/test', 18:50:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:50:52 INFO - 'RUST_BACKTRACE': 'full', 18:50:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:50:52 INFO - 'SHELL': '/bin/bash', 18:50:52 INFO - 'SHLVL': '1', 18:50:52 INFO - 'TERM': 'linux', 18:50:52 INFO - 'TMOUT': '86400', 18:50:52 INFO - 'USER': 'cltbld', 18:50:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', 18:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:52 INFO - '_': '/tools/buildbot/bin/python'} 18:50:52 INFO - TEST-INFO | started process 29982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4ebZyt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:51:03 INFO - PID 29982 | RSS: Main: 162664448 18:51:03 INFO - PID 29982 | 18:54:00 INFO - PID 29982 | Cycle 1(1): loaded http://localhost:55807/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55807/tests/dromaeo/cssquery-ext.html) 18:54:01 INFO - PID 29982 | RSS: Main: 166236160 18:54:01 INFO - PID 29982 | 18:57:03 INFO - PID 29982 | Cycle 1(1): loaded http://localhost:55807/tests/dromaeo/cssquery-ext.html (next: http://localhost:55807/tests/dromaeo/cssquery-jquery.html) 18:57:04 INFO - PID 29982 | RSS: Main: 163418112 18:57:04 INFO - PID 29982 | 19:00:05 INFO - PID 29982 | Cycle 1(1): loaded http://localhost:55807/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55807/tests/dromaeo/cssquery-mootools.html) 19:00:06 INFO - PID 29982 | RSS: Main: 164737024 19:00:06 INFO - PID 29982 | 19:03:07 INFO - PID 29982 | Cycle 1(1): loaded http://localhost:55807/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55807/tests/dromaeo/cssquery-prototype.html) 19:03:08 INFO - PID 29982 | RSS: Main: 164347904 19:03:08 INFO - PID 29982 | 19:06:11 INFO - PID 29982 | Cycle 1(1): loaded http://localhost:55807/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55807/tests/dromaeo/cssquery-yui.html) 19:06:11 INFO - PID 29982 | RSS: Main: 165998592 19:06:11 INFO - PID 29982 | 19:09:13 INFO - PID 29982 | Cycle 1(1): loaded http://localhost:55807/tests/dromaeo/cssquery-yui.html (next: http://localhost:55807/tests/dromaeo/cssquery-dojo.html) 19:09:13 INFO - PID 29982 | RSS: Main: 169000960 19:09:13 INFO - PID 29982 | 19:09:13 INFO - PID 29982 | __start_tp_report 19:09:13 INFO - PID 29982 | _x_x_mozilla_page_load 19:09:13 INFO - PID 29982 | _x_x_mozilla_page_load_details 19:09:13 INFO - PID 29982 | |i|pagename|runs| 19:09:13 INFO - PID 29982 | |0;dojo.html;4048.736832105913;4057.7565346079236;4060.127072679373;4065.410515475255;4078.898027549311;6492.05865149553;6493.22081350238;6630.966845165767;6637.634930078843;6642.335766423361;6573.441257493118;6575;6581;6650.966745166267;6662;5913.615614985034;5933.291692692046;5945.583809133363;5947.286325640929;5982.282126144847;5849.678267695275;5891.293044834626;5936.347001829817;6063.090536419529;6068.150458935753;5962.672053037081;5991.1612374267415;6031.788887388921;6043.972524670795;6052.788152414644;6016.097585362187;6025.367336429656;6037.184980027684;6065.909011364833;6106.084087386883;5902.822915312548;5921.378255283176;5983.940160598382;6092.603980741282;6097.146399504073;6508.64202468864;6513.055606937015;6524.543281970264;6538.411542961157;6545;7114.110736157981;7118.822029449253;7215.747448839318;7228.349448549656;7239.276072392771;7072.752453664097;7168.46236532257;7185.820354491128;7238.927610723878;7255.782326530212;6520.8043758686845;6601.438877695402;6601.7359305627715;6603.273639899608;6621.271660117383;7267;7271.527350722186;7278.745243916437;7288.453365997571;7382.409407247407;7028.4025857801635;7034.085568876116;7058.11773528309;7104.6447677615915;7106.395956343768;7177.784666460015;7183.640817959081;7223.927760722326;7264.418846492268;7288.052553168054;6956.130483689539;7090.290970902868;7106.680199391039;7107.289271072955;7211.3870321023305;7067.328603782736;7143.392811610967;7162.856742865218;7164.641767911584;7168.92831071693;5217.713025783542;5272.314599102092;5282.577393808486;5283.894322113536;5290.444503327172;4730.053989202173;4753.049390121921;4759.50025247351;4771.5228477152;4808.014357056795;6712.39588437043;6728.293529179464;6772.458203343721;6775.796726098225;6778.627175505395;7090.326418990187;7131.215566287704;7135;7215.170255420694;7224;6589.472842172615;6636.170478690164;6713.765018224339;6715.46276297895;6766.15423072116;5892.646441213541;5943.167956486095;5952.136940143741;5957.255343082114;5966.0454327307425;7424;7449.962750186214;7485.438592105614;7534.284242996907;7540.472166948371;7132.251113632994;7142.464315176278;7155.227327016474;7224.74713385029;7239.4932354734665;7292.34368906801;7371.041764570571;7402.259774022555;7424.406047516294;7540.095188577406;7109.360157585842;7133.251008644018;7144.392726618088;7149.14210294768;7151.7854464366155;7007.7196912122945;7122.465815063787;7154.35610795031;7218.963905180441;7222.89165662526;6832;6871.347222013901;6876.381125698711;6903.309669033258;6960.825979350557;6850.8287292816085;6852.383285504328;6867.862642747217;6868.244493105854;6883.827904302432;6679.899801503078;6724.394804467425;6742.9662851685425;6774.085498457645;6781.728730850711;6675.666216689049;6780.864382712417;6855.760048398282;6877.931220687729;6898.586084834726;6613.404793568602;6629.403353698191;6682.966585167043;6684.866302674017;6693.933060669526 19:09:13 INFO - PID 29982 | |1;ext.html;980.8675828763118;1001.3591301566998;1002.7292630989633;1007.2999265510473;1013.0426746724346;46720.76639616806;47794.522054779445;47832;48033;48058.51941480584;43537.78231108848;43820.12359752803;43914.12171756571;44117.7794111029;44129.33805992913;7496.775096747093;7717.344025757818;7717.382609391263;7722.884156737653;7723.884141737878;7762.534247945113;7857.607119643995;7858.29275365217;7864.724734634289;7878.6454609542425;8270.297024752903;8565.443246188977;8570.142985701443;8571.100034496381;8584.356173286997;8380;8439.535825529623;8485.66057357705;8517.190866867637;8525.360597955178;8318.792030199233;8375;8414.158584141598;8422.620982055761;8437.873431898526;43497;43508.56491435108;43533.34699979503;43658;43774.12451750979;3814.9618503814886;3820.1213720844084;3857.7106716996336;3860.2279544091293;3865.43951127085;36017.27965440703;36069.27861442757;36074.09814754652;36097;36162;5548.77804887804;5614.382417934024;5623.297087864017;5627.212190293362;5647.830565083054;243895;244730;245594.99999999822;246106;247701;50248.74875625598;51099.74450127726;56289;56906.14640780391;57772.42227577754;60490.39509604935;60536.697316514015;60651;60760;60833.695831520556;18791.81208187928;18816.62366752657;18839.246430142914;18863.245470181315;19001.714974275397;15572.84427155714;15574.454894078654;15579.922100389425;15637.139957302457;15740.97683650559;15911.204439777965;15959.601009974844;16019.359225630844;16029.43896963624;16054.75917861233;6097.69511524422;6104.847378815476;6155.72299246535;6167.766446710676;6305.873882522324;1099.9395033273088;1100.7358234023936;1103.4041617526445;1117.1509652663872;1122.0686829931137;26391.340216494358;26429.867850660623;26446.44624628811;26758.732412676014;26831.195064148105;1202.9578964736193;1209.2744353388073;1212.484694005062;1219.859716132656;1229.94465249064;13858.584242472742;14063.43746250159;14184.432622695183;14232;14387.424503019762;298326;299002;300148;301581;301658;61477.84827531015;61747.382526174166;62172.37827621666;62227;62564;1550.6743583847292;1555.3389809331215;1584.3979287870536;1587.0239802521596;1599.1045014791755;26190.86904565541;26227.606585900845;26304.73695263023;26573.202803915912;26581.867090665197;43917.560824391345;43936.12127757491;44004.33993490164;44049.11901762011;44096;242697;243086;245090;245431;245456;38385;39137.80431097826;42250.36624450574;42402.78798605987;42421.15157696891;54165.45834541762;55373.72313138408;55437;55539;55574;39343.2131357377;39858.800705996284;39899.800500997306;40219.79890100648;40658.79670601746;39565.40651890166;39695.2060958785;39998.80000599979;40368.3944740835;40641;45446;46133.07733845237;46457.53542464532;46477;46806.297905530766;38044.23911521809;38057;38433;38447.80776096102;38863.61136388713;24456.633150503112;24811;24861.502769944862;25033.249002529952;25045.24864254075 19:09:13 INFO - PID 29982 | |2;jquery.html;604.8597351131506;610.6977046362051;621.5214285000549;629.7890206780731;650.096366051189;24971.375715607097;25670.74329256709;25807.483850323006;25826.48347033063;25912.83392247349;27003.324916877038;27832.3041923952;27849.16452506428;27879.442411151766;27879.721202787965;6667.73329066838;6744.089547911043;6772.255051944282;6792.898106528406;6800.6939687714175;6649.900251496208;6878.690458929335;6944.097267355262;6950.582965022089;6959;6827.522073454836;6836.658167091626;6851.554648947827;6853;6890;6830.863382732342;6849.075374824385;6891.414229790449;6896.793096207097;6924.272951340087;6470.514711396617;6481.870362592722;6483.578567393104;6505.21937367519;6505.609663420162;29701.851490742625;32575.51136732951;33122.3375532488;33154.668453315644;33224.335513289596;2346.002948746776;2375.3349062262423;2382.404398900275;2388.450656349032;2398.0887262840183;21600.027998740094;21828.89085554578;22109.11563537473;22170.334889953327;22174.667379989314;2634.1570697376847;2656.8538730369823;2699.676038875328;2702.4054707964415;2714.6199532065525;144267.27866360705;151977.24011379984;167500;174377.99999999872;174595;16838.663226735396;16877;17252.482425527254;17439.56401089983;17544.736828947574;27224.183274501796;27255;27394.726052739617;27401.177964661092;27465.45069098607;11517.539298428137;11541.76916461666;11651.242669226473;11676.649700508999;11898.940505297418;10640.201984851012;10687.732806679895;10800.729981750519;10823.188260880466;10838.566457341618;9973.30186886911;10317.896821031694;10323.741906452398;10362.585496580203;10494.108000820015;2933;3013.819170849712;3074.9231269218003;3097.90706278812;3187.5378070179695;1068.1935138970027;1073.6510634043811;1095.0965453500894;1106.1372129738816;1110.7889500994786;22227.885038173874;22315.21896733639;22441.775582244296;22455.55088898213;22554.097836086374;1158.9916772407892;1164.5400066973498;1166.0147175636573;1169.187414746743;1177.1230433327225;12186.390680465942;12345.38273086342;12521.186122901981;12521.686957825945;12599.118061735773;616725;623932;646258;650467;659406;128819;129672;131497;132505.33747331394;133932.33033834767;1169.6841852699724;1222.6698791326291;1264.1593340428697;1265.0322503284995;1296.0150285782872;22961.88519057461;23609.40976475602;23694.88152559226;23705.170319038752;23708.170214042424;63580.36419635744;63649.6817515928;64605;65256.34743652503;67095.98068087046;81552.18447815684;81598;81885.19142258863;82310;82645;16388;16504.917475412545;16520.66958660844;16645.50063498097;16655.3337866484;25659.23022309334;25757.484850302513;25946.481070378864;26061.609075863496;26112.73887261179;19077.427677169708;19171.424857254304;19377.128029238436;19387.51531211731;20669.17323307051;18173.727394088834;18491.167897444917;18600.627987440446;18693.345732899284;19139.04304784783;20145.899270503553;21606.459838504165;21637.783622163577;21688.45778855478;21791.12835486563;16491.34034638601;16516.587085322964;16556.089415082286;16570.337186512887;16579.751303730212;20260.696089558372;20835.270765523135;21023.57952840904;21035.789642103384;21261.7873821266 19:09:13 INFO - PID 29982 | |3;mootools.html;1464.5752731707803;1499.0630855715178;1507.5703424524013;1520.1942970225778;1527.25164669312;17139.143042847856;17676;17836.910815445906;17844.28622855086;17851;17376.218070186842;17490.650186996252;17597.91201043993;17604.911975440136;17605.383811566597;3016.2157838961807;3037.529182976642;3099.380123975203;3100.2869340051802;3102.5811515445353;2846.5160922643095;2864.914052578426;2878.884844606224;2888.090251570759;2893.6238289022504;2998.9100326990115;3020.6979302069835;3107.5338699195077;3109.0983614751694;3109.891153809617;3091.48990416581;3108.3938631966776;3124.7500199983947;3130.4834702274097;3132.4674805283043;3005.3238021445;3026.6821983691834;3030.8787648494035;3073.830939298338;3074.3390171113097;16848.157592120468;17337.826621733748;17379.826201738073;17380.739288910678;17383.391581294592;8905.332100092519;9180.357374983754;9185.770355741093;9191.310651701082;9226.953865230631;5863.208466856962;5902.144189092557;6240.594361366497;6281.968590157066;6290.433860952537;2088.9582208355746;2093.194120263694;2158.169104894627;2159.2550570053463;2176.1186719378675;31245.687543124506;31393.99999999977;31465.685343146506;31478.527822082688;31501.52747708786;7230.74692385764;7235.819104522324;7278.745243916544;7360.411167106618;7455.478116531791;19987.800121998593;20077.397678069683;20082.39752807418;20195.798042019687;20278.391648250577;8605.956970215235;8825.07336729647;8836.55817209137;8852.557372131496;8854.86717699235;7831.6475758591005;7935.246151615587;8038.517688938682;8143;8146.67413303473;5820.650760954356;5822.214001109881;5841.182234487175;5892.852678683067;5957.79147729836;1577.8737700983893;1589.4436947068434;1591.6896205240098;1595.9680806383808;1613.2337139858473;857.9871301930476;1012.1548506996741;1028.388109075114;1033.2870319479534;1044.3420644993757;9937.701868943943;10052.246081543914;10239.48802559869;10249.84625230622;10334.793304133875;1073.8711354637494;1085.685151306128;1088.7876864011441;1097.2812807611028;1118.8377685235757;5902.61632993854;6115.541334399938;6330.525210609223;6419.197600299963;6501.609903405811;25399;26211.475770484863;26607;26621.866890665424;26674.466510670067;25577.104801331865;25829.612555811676;26228.73771262301;26488.470230595667;26600.201993940213;12505.812412813815;12514.436850341757;12569.560065397483;12583;12588.937055314665;8387.287080598218;8706.782330441789;8713.607887645197;8715.477071375737;8753.606087726195;22142.446438839157;22160.667589986486;22289.331320060424;22597.2090976815;23214.651780222972;22776.544469110857;23060.540918862305;23393.883030584737;23415.297541073796;23757.881210593838;12300.507979680713;12327.69180770488;12351.444185011876;12414.503419863104;12469.251844889335;15538.300776465312;15748.055116693035;15850.920745396199;15851.841481585498;15858.444954426539;12679;12975.416106275428;13356;13356.599302020955;13584.524541640994;12289.07831912628;12667.93666031664;12896.806547901977;13125.60623181306;13315.733685326046;11721.765564688489;11766.58816941403;11889.870462306068;11941.820872686743;11970.042396608425;8801.29589632815;8895;8899.822003559762;8907.688230911886;8968.730938071869;8602.827943441222;8768.868466973128;8780.78048048804;8804.735857924017;8853.513056781681 19:09:13 INFO - PID 29982 | |4;prototype.html;541.8618252345651;587.142771553532;588.5732843688329;594.8721024979628;598.7964092208649;6424.132742079823;6453.128827608271;6465.450436712879;6479.967600161998;6518.934810651892;6305;6312.684365781715;6325.683715814214;6370.171877655898;6401.583897046688;5214.8174813881615;5237.659552129118;5301.443348448396;5327.946720532784;5341.572674186075;4916.901661966758;5138.9743051284695;5280.075986702331;5328.387235467932;5348.331458567679;5029.622778291625;5065.240213967916;5078.4413714491375;5083.593312535007;5088.440271570143;5107.38711354638;5125.461826508237;5142.717150556718;5144.279800827887;5156.561692256163;4627.329037289608;4636.582707556302;4657.906841863178;4659.534046595347;4683.391159149289;6238.754048542521;6277.748890044439;6326.304106548276;6363.649999250039;6402.391772781578;5990.580659353847;6021.337652858182;6052.546059045545;6087.908681369783;6088.543359248074;6714.026466162379;6790.219124800612;6805.087074931934;6846.965765171192;6851.417629501499;5183.688978661293;5197.7920883164625;5204.739763011834;5214.113600687892;5228.581713462914;6956.339147780953;6990.54561453509;7052.541584796972;7102.573845569283;7201.3158749918675;5350.170723537858;5358.758855851496;5367.007103685831;5369;5374.193870919394;5449.5640348772;5456.7544460499375;5459.2902922619805;5467.316585426822;5475.534579560782;6062.757489700451;6075.635461872302;6076.787312444043;6076.908846367308;6083.209182806207;6854.2117656469145;6911.481638877104;6920.204176519765;6923.792286231421;6968.616726080114;1809.475252176854;1843.3271855772546;1855.2208072609537;1864.5804693943753;1865.3471285050396;1292.9030322725832;1307.6534718299658;1314.9868501314863;1328.754180476615;1331.108157534435;6399.680015999182;6420.678966051679;6476.5466417350335;6498.772542960974;6500.252470965899;6855.554388964801;6882.759103431456;6923.269182704324;6985.301469853076;6996.090508233897;6494.6103233806125;6525.184351956005;6565.343465653396;6597.439217666552;6605.70274337656;3627.4558816177782;3635.345637785224;3636.2182130841466;3651.9634803652157;3678.098865777848;7150.463715221379;7173.282671732785;7225.132984041844;7250.891236631454;7293.8905916411295;6992.161545109789;7029.680205532162;7123.394511466583;7157.498975071695;7204.53170543913;7123.394511466479;7159.248278930741;7179.497435179592;7243.420526357879;7303.575802718419;6864.725410983705;6920.5847649141215;7018;7026.1217347831525;7072.222055573986;6819.965900170468;6849.253440372872;6958.652067396712;6963.651817409008;6978.511504194657;6976.720931162697;7260.165081015751;7268.236835132235;7284.817879553054;7314.780556583311;5206.583473322049;5285.894282114413;5291.1798671206025;5292.285541452009;5296.841979046584;6519.478441724746;6668.866622667422;6793.112927006102;6968.303169682991;7015.333543313377;6501.44737697301;6706;6707.731690732316;6721.563098398588;6733.966330168514;6613.395699343965;6624.8012559623285;6707.496937729592;6716.395524402632;6716.899246511404;6555.3772391622715;6601.933980660132;6710.16122984627;6724.4620430364475;6747.392734653905;6708.42978346846;6802.965985170043;6835.829104272433;6839.726410943506;6857.794266172023;6541.280459149394;6544.705488252945;6635.966820165868;6670.366315200048;6695.933040669531 19:09:13 INFO - PID 29982 | |5;yui.html;1004.2518323848734;1020.8621836052133;1033.782905589826;1049.4752623688155;1052.94208818515;20375.796242037573;20736.066876990535;21196;21601.45996350088;21610.243641472513;20002;20036;20246.493837654067;20314;20325.49186270344;1092.6558134187726;1095.1020163465962;1097.8133717268045;1098.6594155811683;1100.6422912553412;1076.43487169236;1077.181342179941;1081.967540973772;1083.8699356077282;1086.739182596179;1099.5107177306102;1143.794117058929;1145.9484323205477;1146.1232157399595;1147.0536807134106;1121.125522092769;1122.5846436818347;1139.2139423797553;1139.3221033485063;1142.9257098288626;834.8163404051099;842.204117109332;842.7766641839918;845.8392905347964;848.4781859156636;21058.05238764244;21728.239511617176;21811.781882181134;21935.890320548453;22236.6664500031;24022.639660405108;24070.277891663278;24327;24715;24721.629175562382;16519.33922643093;16830.831691683048;16913.57716057096;16964.491065268063;16997.150142492825;3678.760880542783;3783.3000894834545;3800.1639639279315;3802.372608519591;3803.9619603803885;131799;152124;168948;171078;178695;19127.33054343091;19317;19515;19588.90205548963;19643.60712785736;35812;35901.46147807785;36078.819605902325;36197.638023619955;36204.45693314602;10582.841257381146;10676.252662313564;10687.946560267148;10716.035556799925;10730.087942524817;5178.508041736029;5214.191800270964;5227.45111763267;5269.868253293622;5284.947150528523;6456.483481321483;6506.544541882117;6512.120863683437;6579.769708060195;6580.045893345438;1305.145129939891;1339.2901762066122;1346.5690978886857;1349.2174538767492;1372.3618517389461;716.77421612192;742.5284944060453;747.4058123791599;766.3907193780957;772.6291380137566;13782.448702051806;13828.585142445541;13942.302884855717;14176.362063707158;14228.430862765374;777.5995362388261;781.413939545341;783.3537331701369;788.8461749958703;795.745361484331;6785.898211526831;6816.352446517573;6824.863502730017;6849.109615750021;6877.415419689382;151935;153219.23390382977;156727;158548;163780;132500;134572;136615.31692341474;138592;142830;120198;121360.3931980352;121825.56348872973;122583;126872.36563817122;12613.432395542039;13040.673983150496;13045.543405980745;13078.149920255153;13201.135688873097;58906.41093589181;59464.70267648634;59956.70021649864;60184.09723854233;61197.694011531436;73950.26049739434;73963.63018184874;74220.62889685734;74754;75583.24416755982;15667.608309792346;15844.970076944961;16059.19704014818;16075.35698572044;16109.113998730183;20294.188232471126;20449.59100818005;20464;20494.692579611616;21172.153113875273;18696;19065.618687626447;19087.33194338247;19114.522136946132;19370.70943935814;18616.720749188502;18770.249190032246;18944.336948206746;19040.809591903904;19046.904765476083;18989.52526186801;19088.522786930436;19317.4204773857;19452.708209377153;19479.026048697793;12390.81413778776;12720.74558508843;12956.935215323863;13045.412956416794;13177.736445271232;13612.319384030561;13792;13939.581812545639;13974.860251397762;14162.150270983773 19:09:13 INFO - PID 29982 | __end_tp_report 19:09:13 INFO - PID 29982 | __start_cc_report 19:09:13 INFO - PID 29982 | _x_x_mozilla_cycle_collect,336 19:09:13 INFO - PID 29982 | __end_cc_report 19:09:13 INFO - PID 29982 | __startTimestamp1505441353614__endTimestamp 19:09:13 INFO - PID 29982 | 19:09:13 INFO - PID 29982 | ------- Summary: start ------- 19:09:13 INFO - PID 29982 | Number of tests: 6 19:09:13 INFO - PID 29982 | 19:09:13 INFO - PID 29982 | [#0] dojo.html Cycles:165 Average:6588.88 Median:6774.09 stddev:764.71 (11.3%) stddev-sans-first:740.64 19:09:13 INFO - PID 29982 | Values: 4048.7 4057.8 4060.1 4065.4 4078.9 6492.1 6493.2 6631.0 6637.6 6642.3 6573.4 6575.0 6581.0 6651.0 6662.0 5913.6 5933.3 5945.6 5947.3 5982.3 5849.7 5891.3 5936.3 6063.1 6068.2 5962.7 5991.2 6031.8 6044.0 6052.8 6016.1 6025.4 6037.2 6065.9 6106.1 5902.8 5921.4 5983.9 6092.6 6097.1 6508.6 6513.1 6524.5 6538.4 6545.0 7114.1 7118.8 7215.7 7228.3 7239.3 7072.8 7168.5 7185.8 7238.9 7255.8 6520.8 6601.4 6601.7 6603.3 6621.3 7267.0 7271.5 7278.7 7288.5 7382.4 7028.4 7034.1 7058.1 7104.6 7106.4 7177.8 7183.6 7223.9 7264.4 7288.1 6956.1 7090.3 7106.7 7107.3 7211.4 7067.3 7143.4 7162.9 7164.6 7168.9 5217.7 5272.3 5282.6 5283.9 5290.4 4730.1 4753.0 4759.5 4771.5 4808.0 6712.4 6728.3 6772.5 6775.8 6778.6 7090.3 7131.2 7135.0 7215.2 7224.0 6589.5 6636.2 6713.8 6715.5 6766.2 5892.6 5943.2 5952.1 5957.3 5966.0 7424.0 7450.0 7485.4 7534.3 7540.5 7132.3 7142.5 7155.2 7224.7 7239.5 7292.3 7371.0 7402.3 7424.4 7540.1 7109.4 7133.3 7144.4 7149.1 7151.8 7007.7 7122.5 7154.4 7219.0 7222.9 6832.0 6871.3 6876.4 6903.3 6960.8 6850.8 6852.4 6867.9 6868.2 6883.8 6679.9 6724.4 6743.0 6774.1 6781.7 6675.7 6780.9 6855.8 6877.9 6898.6 6613.4 6629.4 6683.0 6684.9 6693.9 19:09:13 INFO - PID 29982 | 19:09:13 INFO - PID 29982 | [#1] ext.html Cycles:180 Average:45754.90 Median:39949.30 stddev:68837.73 (172.3%) stddev-sans-first:68948.74 19:09:13 INFO - PID 29982 | Values: 980.9 1001.4 1002.7 1007.3 1013.0 46720.8 47794.5 47832.0 48033.0 48058.5 43537.8 43820.1 43914.1 44117.8 44129.3 7496.8 7717.3 7717.4 7722.9 7723.9 7762.5 7857.6 7858.3 7864.7 7878.6 8270.3 8565.4 8570.1 8571.1 8584.4 8380.0 8439.5 8485.7 8517.2 8525.4 8318.8 8375.0 8414.2 8422.6 8437.9 43497.0 43508.6 43533.3 43658.0 43774.1 3815.0 3820.1 3857.7 3860.2 3865.4 36017.3 36069.3 36074.1 36097.0 36162.0 5548.8 5614.4 5623.3 5627.2 5647.8 243895.0 244730.0 245595.0 246106.0 247701.0 50248.7 51099.7 56289.0 56906.1 57772.4 60490.4 60536.7 60651.0 60760.0 60833.7 18791.8 18816.6 18839.2 18863.2 19001.7 15572.8 15574.5 15579.9 15637.1 15741.0 15911.2 15959.6 16019.4 16029.4 16054.8 6097.7 6104.8 6155.7 6167.8 6305.9 1099.9 1100.7 1103.4 1117.2 1122.1 26391.3 26429.9 26446.4 26758.7 26831.2 1203.0 1209.3 1212.5 1219.9 1229.9 13858.6 14063.4 14184.4 14232.0 14387.4 298326.0 299002.0 300148.0 301581.0 301658.0 61477.8 61747.4 62172.4 62227.0 62564.0 1550.7 1555.3 1584.4 1587.0 1599.1 26190.9 26227.6 26304.7 26573.2 26581.9 43917.6 43936.1 44004.3 44049.1 44096.0 242697.0 243086.0 245090.0 245431.0 245456.0 38385.0 39137.8 42250.4 42402.8 42421.2 54165.5 55373.7 55437.0 55539.0 55574.0 39343.2 39858.8 39899.8 40219.8 40658.8 39565.4 39695.2 39998.8 40368.4 40641.0 45446.0 46133.1 46457.5 46477.0 46806.3 38044.2 38057.0 38433.0 38447.8 38863.6 24456.6 24811.0 24861.5 25033.2 25045.2 19:09:13 INFO - PID 29982 | 19:09:13 INFO - PID 29982 | [#2] jquery.html Cycles:180 Average:41911.19 Median:12977.71 stddev:106913.47 (823.8%) stddev-sans-first:107168.41 19:09:13 INFO - PID 29982 | Values: 604.9 610.7 621.5 629.8 650.1 24971.4 25670.7 25807.5 25826.5 25912.8 27003.3 27832.3 27849.2 27879.4 27879.7 6667.7 6744.1 6772.3 6792.9 6800.7 6649.9 6878.7 6944.1 6950.6 6959.0 6827.5 6836.7 6851.6 6853.0 6890.0 6830.9 6849.1 6891.4 6896.8 6924.3 6470.5 6481.9 6483.6 6505.2 6505.6 29701.9 32575.5 33122.3 33154.7 33224.3 2346.0 2375.3 2382.4 2388.5 2398.1 21600.0 21828.9 22109.1 22170.3 22174.7 2634.2 2656.9 2699.7 2702.4 2714.6 144267.3 151977.2 167500.0 174378.0 174595.0 16838.7 16877.0 17252.5 17439.6 17544.7 27224.2 27255.0 27394.7 27401.2 27465.5 11517.5 11541.8 11651.2 11676.6 11898.9 10640.2 10687.7 10800.7 10823.2 10838.6 9973.3 10317.9 10323.7 10362.6 10494.1 2933.0 3013.8 3074.9 3097.9 3187.5 1068.2 1073.7 1095.1 1106.1 1110.8 22227.9 22315.2 22441.8 22455.6 22554.1 1159.0 1164.5 1166.0 1169.2 1177.1 12186.4 12345.4 12521.2 12521.7 12599.1 616725.0 623932.0 646258.0 650467.0 659406.0 128819.0 129672.0 131497.0 132505.3 133932.3 1169.7 1222.7 1264.2 1265.0 1296.0 22961.9 23609.4 23694.9 23705.2 23708.2 63580.4 63649.7 64605.0 65256.3 67096.0 81552.2 81598.0 81885.2 82310.0 82645.0 16388.0 16504.9 16520.7 16645.5 16655.3 25659.2 25757.5 25946.5 26061.6 26112.7 19077.4 19171.4 19377.1 19387.5 20669.2 18173.7 18491.2 18600.6 18693.3 19139.0 20145.9 21606.5 21637.8 21688.5 21791.1 16491.3 16516.6 16556.1 16570.3 16579.8 20260.7 20835.3 21023.6 21035.8 21261.8 19:09:13 INFO - PID 29982 | 19:09:13 INFO - PID 29982 | [#3] mootools.html Cycles:180 Average:10869.27 Median:26020.54 stddev:8017.66 (30.8%) stddev-sans-first:8009.02 19:09:13 INFO - PID 29982 | Values: 1464.6 1499.1 1507.6 1520.2 1527.3 17139.1 17676.0 17836.9 17844.3 17851.0 17376.2 17490.7 17597.9 17604.9 17605.4 3016.2 3037.5 3099.4 3100.3 3102.6 2846.5 2864.9 2878.9 2888.1 2893.6 2998.9 3020.7 3107.5 3109.1 3109.9 3091.5 3108.4 3124.8 3130.5 3132.5 3005.3 3026.7 3030.9 3073.8 3074.3 16848.2 17337.8 17379.8 17380.7 17383.4 8905.3 9180.4 9185.8 9191.3 9227.0 5863.2 5902.1 6240.6 6282.0 6290.4 2089.0 2093.2 2158.2 2159.3 2176.1 31245.7 31394.0 31465.7 31478.5 31501.5 7230.7 7235.8 7278.7 7360.4 7455.5 19987.8 20077.4 20082.4 20195.8 20278.4 8606.0 8825.1 8836.6 8852.6 8854.9 7831.6 7935.2 8038.5 8143.0 8146.7 5820.7 5822.2 5841.2 5892.9 5957.8 1577.9 1589.4 1591.7 1596.0 1613.2 858.0 1012.2 1028.4 1033.3 1044.3 9937.7 10052.2 10239.5 10249.8 10334.8 1073.9 1085.7 1088.8 1097.3 1118.8 5902.6 6115.5 6330.5 6419.2 6501.6 25399.0 26211.5 26607.0 26621.9 26674.5 25577.1 25829.6 26228.7 26488.5 26600.2 12505.8 12514.4 12569.6 12583.0 12588.9 8387.3 8706.8 8713.6 8715.5 8753.6 22142.4 22160.7 22289.3 22597.2 23214.7 22776.5 23060.5 23393.9 23415.3 23757.9 12300.5 12327.7 12351.4 12414.5 12469.3 15538.3 15748.1 15850.9 15851.8 15858.4 12679.0 12975.4 13356.0 13356.6 13584.5 12289.1 12667.9 12896.8 13125.6 13315.7 11721.8 11766.6 11889.9 11941.8 11970.0 8801.3 8895.0 8899.8 8907.7 8968.7 8602.8 8768.9 8780.8 8804.7 8853.5 19:09:13 INFO - PID 29982 | 19:09:13 INFO - PID 29982 | [#4] prototype.html Cycles:180 Average:5802.65 Median:6478.26 stddev:1621.73 (25.0%) stddev-sans-first:1577.47 19:09:13 INFO - PID 29982 | Values: 541.9 587.1 588.6 594.9 598.8 6424.1 6453.1 6465.5 6480.0 6518.9 6305.0 6312.7 6325.7 6370.2 6401.6 5214.8 5237.7 5301.4 5327.9 5341.6 4916.9 5139.0 5280.1 5328.4 5348.3 5029.6 5065.2 5078.4 5083.6 5088.4 5107.4 5125.5 5142.7 5144.3 5156.6 4627.3 4636.6 4657.9 4659.5 4683.4 6238.8 6277.7 6326.3 6363.6 6402.4 5990.6 6021.3 6052.5 6087.9 6088.5 6714.0 6790.2 6805.1 6847.0 6851.4 5183.7 5197.8 5204.7 5214.1 5228.6 6956.3 6990.5 7052.5 7102.6 7201.3 5350.2 5358.8 5367.0 5369.0 5374.2 5449.6 5456.8 5459.3 5467.3 5475.5 6062.8 6075.6 6076.8 6076.9 6083.2 6854.2 6911.5 6920.2 6923.8 6968.6 1809.5 1843.3 1855.2 1864.6 1865.3 1292.9 1307.7 1315.0 1328.8 1331.1 6399.7 6420.7 6476.5 6498.8 6500.3 6855.6 6882.8 6923.3 6985.3 6996.1 6494.6 6525.2 6565.3 6597.4 6605.7 3627.5 3635.3 3636.2 3652.0 3678.1 7150.5 7173.3 7225.1 7250.9 7293.9 6992.2 7029.7 7123.4 7157.5 7204.5 7123.4 7159.2 7179.5 7243.4 7303.6 6864.7 6920.6 7018.0 7026.1 7072.2 6820.0 6849.3 6958.7 6963.7 6978.5 6976.7 7260.2 7268.2 7284.8 7314.8 5206.6 5285.9 5291.2 5292.3 5296.8 6519.5 6668.9 6793.1 6968.3 7015.3 6501.4 6706.0 6707.7 6721.6 6734.0 6613.4 6624.8 6707.5 6716.4 6716.9 6555.4 6601.9 6710.2 6724.5 6747.4 6708.4 6803.0 6835.8 6839.7 6857.8 6541.3 6544.7 6636.0 6670.4 6695.9 19:09:13 INFO - PID 29982 | 19:09:13 INFO - PID 29982 | [#5] yui.html Cycles:180 Average:29468.40 Median:19043.86 stddev:43899.82 (230.5%) stddev-sans-first:43970.95 19:09:13 INFO - PID 29982 | Values: 1004.3 1020.9 1033.8 1049.5 1052.9 20375.8 20736.1 21196.0 21601.5 21610.2 20002.0 20036.0 20246.5 20314.0 20325.5 1092.7 1095.1 1097.8 1098.7 1100.6 1076.4 1077.2 1082.0 1083.9 1086.7 1099.5 1143.8 1145.9 1146.1 1147.1 1121.1 1122.6 1139.2 1139.3 1142.9 834.8 842.2 842.8 845.8 848.5 21058.1 21728.2 21811.8 21935.9 22236.7 24022.6 24070.3 24327.0 24715.0 24721.6 16519.3 16830.8 16913.6 16964.5 16997.2 3678.8 3783.3 3800.2 3802.4 3804.0 131799.0 152124.0 168948.0 171078.0 178695.0 19127.3 19317.0 19515.0 19588.9 19643.6 35812.0 35901.5 36078.8 36197.6 36204.5 10582.8 10676.3 10687.9 10716.0 10730.1 5178.5 5214.2 5227.5 5269.9 5284.9 6456.5 6506.5 6512.1 6579.8 6580.0 1305.1 1339.3 1346.6 1349.2 1372.4 716.8 742.5 747.4 766.4 772.6 13782.4 13828.6 13942.3 14176.4 14228.4 777.6 781.4 783.4 788.8 795.7 6785.9 6816.4 6824.9 6849.1 6877.4 151935.0 153219.2 156727.0 158548.0 163780.0 132500.0 134572.0 136615.3 138592.0 142830.0 120198.0 121360.4 121825.6 122583.0 126872.4 12613.4 13040.7 13045.5 13078.1 13201.1 58906.4 59464.7 59956.7 60184.1 61197.7 73950.3 73963.6 74220.6 74754.0 75583.2 15667.6 15845.0 16059.2 16075.4 16109.1 20294.2 20449.6 20464.0 20494.7 21172.2 18696.0 19065.6 19087.3 19114.5 19370.7 18616.7 18770.2 18944.3 19040.8 19046.9 18989.5 19088.5 19317.4 19452.7 19479.0 12390.8 12720.7 12956.9 13045.4 13177.7 13612.3 13792.0 13939.6 13974.9 14162.2 19:09:13 INFO - PID 29982 | -------- Summary: end -------- 19:09:13 INFO - PID 29982 | 19:09:14 INFO - TEST-INFO | 29982: exit 0 19:09:14 INFO - TEST-OK | dromaeo_css | took 1106904ms 19:09:14 INFO - TEST-START | kraken 19:09:14 INFO - Initialising browser for kraken test... 19:09:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55807/getInfo.html -profile /tmp/tmpgnYQnp/profile 19:09:14 INFO - TEST-INFO | started process 30347 (/builds/slave/test/build/application/firefox/firefox http://localhost:55807/getInfo.html) 19:09:18 INFO - TEST-INFO | 30347: exit 0 19:09:18 INFO - Browser initialized. 19:09:18 INFO - Running cycle 1/1 for kraken test... 19:09:18 INFO - Using env: {'DISPLAY': ':0', 19:09:18 INFO - 'HOME': '/home/cltbld', 19:09:18 INFO - 'JSGC_DISABLE_POISONING': '1', 19:09:18 INFO - 'LANG': 'en_US.UTF-8', 19:09:18 INFO - 'LANGUAGE': 'en_US:en', 19:09:18 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 19:09:18 INFO - 'LOGNAME': 'cltbld', 19:09:18 INFO - 'MAIL': '/var/mail/cltbld', 19:09:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:09:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:09:18 INFO - 'MOZ_CRASHREPORTER': '1', 19:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:18 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 19:09:18 INFO - 'MOZ_NO_REMOTE': '1', 19:09:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:18 INFO - 'NO_EM_RESTART': '1', 19:09:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:18 INFO - 'PWD': '/builds/slave/test', 19:09:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:09:18 INFO - 'RUST_BACKTRACE': 'full', 19:09:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:09:18 INFO - 'SHELL': '/bin/bash', 19:09:18 INFO - 'SHLVL': '1', 19:09:18 INFO - 'TERM': 'linux', 19:09:18 INFO - 'TMOUT': '86400', 19:09:18 INFO - 'USER': 'cltbld', 19:09:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056', 19:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:18 INFO - '_': '/tools/buildbot/bin/python'} 19:09:18 INFO - TEST-INFO | started process 30535 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgnYQnp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:30 INFO - PID 30535 | RSS: Main: 162476032 19:09:30 INFO - PID 30535 | 19:09:32 INFO - PID 30535 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55807/tests/kraken/driver.html?testName=audio-beat-detection) 19:09:33 INFO - PID 30535 | RSS: Main: 167518208 19:09:33 INFO - PID 30535 | 19:09:35 INFO - PID 30535 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55807/tests/kraken/driver.html?testName=audio-dft) 19:09:36 INFO - PID 30535 | RSS: Main: 168460288 19:09:36 INFO - PID 30535 | 19:09:39 INFO - PID 30535 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55807/tests/kraken/driver.html?testName=audio-fft) 19:09:40 INFO - PID 30535 | RSS: Main: 169811968 19:09:40 INFO - PID 30535 | 19:09:42 INFO - PID 30535 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55807/tests/kraken/driver.html?testName=audio-oscillator) 19:09:42 INFO - PID 30535 | RSS: Main: 169603072 19:09:42 INFO - PID 30535 | 19:09:44 INFO - PID 30535 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55807/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:09:45 INFO - PID 30535 | RSS: Main: 169517056 19:09:45 INFO - PID 30535 | 19:09:48 INFO - PID 30535 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55807/tests/kraken/driver.html?testName=imaging-darkroom) 19:09:49 INFO - PID 30535 | RSS: Main: 169496576 19:09:49 INFO - PID 30535 | 19:09:52 INFO - PID 30535 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55807/tests/kraken/driver.html?testName=imaging-desaturate) 19:09:53 INFO - PID 30535 | RSS: Main: 170409984 19:09:53 INFO - PID 30535 | 19:09:56 INFO - PID 30535 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55807/tests/kraken/driver.html?testName=json-parse-financial) 19:09:56 INFO - PID 30535 | RSS: Main: 171966464 19:09:56 INFO - PID 30535 | 19:09:58 INFO - PID 30535 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55807/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:09:58 INFO - PID 30535 | RSS: Main: 171474944 19:09:58 INFO - PID 30535 | 19:10:00 INFO - PID 30535 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55807/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:10:00 INFO - PID 30535 | RSS: Main: 171667456 19:10:00 INFO - PID 30535 | 19:10:02 INFO - PID 30535 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55807/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:10:03 INFO - PID 30535 | RSS: Main: 168656896 19:10:03 INFO - PID 30535 | 19:10:05 INFO - PID 30535 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:10:06 INFO - PID 30535 | RSS: Main: 168914944 19:10:06 INFO - PID 30535 | 19:10:09 INFO - PID 30535 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:10:09 INFO - PID 30535 | RSS: Main: 169103360 19:10:09 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55807/tests/kraken/driver.html?testName=ai-astar) 19:10:11 INFO - PID 30535 | RSS: Main: 171393024 19:10:11 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | __start_tp_report 19:10:11 INFO - PID 30535 | _x_x_mozilla_page_load 19:10:11 INFO - PID 30535 | _x_x_mozilla_page_load_details 19:10:11 INFO - PID 30535 | |i|pagename|runs| 19:10:11 INFO - PID 30535 | |0;ai-astar;105;105;108;108;106;106;106;105;106;105 19:10:11 INFO - PID 30535 | |1;audio-beat-detection;114;115;110;111;113;114;111;110;110;141 19:10:11 INFO - PID 30535 | |2;audio-dft;162;161;163;163;164;162;163;162;165;161 19:10:11 INFO - PID 30535 | |3;audio-fft;73;73;72;73;72;72;72;72;73;73 19:10:11 INFO - PID 30535 | |4;audio-oscillator;78;77;78;80;82;77;77;77;78;81 19:10:11 INFO - PID 30535 | |5;imaging-gaussian-blur;110;113;114;115;111;113;118;116;113;113 19:10:11 INFO - PID 30535 | |6;imaging-darkroom;148;148;148;149;148;149;149;149;149;149 19:10:11 INFO - PID 30535 | |7;imaging-desaturate;98;95;94;93;94;93;94;94;94;94 19:10:11 INFO - PID 30535 | |8;json-parse-financial;45;44;41;42;42;43;44;45;44;43 19:10:11 INFO - PID 30535 | |9;json-stringify-tinderbox;37;37;37;37;37;37;37;37;37;37 19:10:11 INFO - PID 30535 | |10;stanford-crypto-aes;77;71;73;75;70;73;72;73;77;73 19:10:11 INFO - PID 30535 | |11;stanford-crypto-ccm;112;105;109;106;103;102;104;106;103;103 19:10:11 INFO - PID 30535 | |12;stanford-crypto-pbkdf2;154;154;150;158;150;153;158;149;154;162 19:10:11 INFO - PID 30535 | |13;stanford-crypto-sha256-iterative;57;57;58;59;59;63;58;57;60;56 19:10:11 INFO - PID 30535 | __end_tp_report 19:10:11 INFO - PID 30535 | __start_cc_report 19:10:11 INFO - PID 30535 | _x_x_mozilla_cycle_collect,866 19:10:11 INFO - PID 30535 | __end_cc_report 19:10:11 INFO - PID 30535 | __startTimestamp1505441411839__endTimestamp 19:10:11 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | ------- Summary: start ------- 19:10:11 INFO - PID 30535 | Number of tests: 14 19:10:11 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | [#0] ai-astar Cycles:10 Average:106.00 Median:106.00 stddev:1.15 (1.1%) stddev-sans-first:1.17 19:10:11 INFO - PID 30535 | Values: 105.0 105.0 108.0 108.0 106.0 106.0 106.0 105.0 106.0 105.0 19:10:11 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | [#1] audio-beat-detection Cycles:10 Average:114.90 Median:113.50 stddev:9.36 (8.2%) stddev-sans-first:9.92 19:10:11 INFO - PID 30535 | Values: 114.0 115.0 110.0 111.0 113.0 114.0 111.0 110.0 110.0 141.0 19:10:11 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 19:10:11 INFO - PID 30535 | Values: 162.0 161.0 163.0 163.0 164.0 162.0 163.0 162.0 165.0 161.0 19:10:11 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | [#3] audio-fft Cycles:10 Average:72.50 Median:73.00 stddev:0.53 (0.7%) stddev-sans-first:0.53 19:10:11 INFO - PID 30535 | Values: 73.0 73.0 72.0 73.0 72.0 72.0 72.0 72.0 73.0 73.0 19:10:11 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | [#4] audio-oscillator Cycles:10 Average:78.50 Median:78.00 stddev:1.84 (2.4%) stddev-sans-first:1.94 19:10:11 INFO - PID 30535 | Values: 78.0 77.0 78.0 80.0 82.0 77.0 77.0 77.0 78.0 81.0 19:10:11 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:113.50 stddev:2.32 (2.0%) stddev-sans-first:2.06 19:10:11 INFO - PID 30535 | Values: 110.0 113.0 114.0 115.0 111.0 113.0 118.0 116.0 113.0 113.0 19:10:11 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.52 (0.3%) stddev-sans-first:0.50 19:10:11 INFO - PID 30535 | Values: 148.0 148.0 148.0 149.0 148.0 149.0 149.0 149.0 149.0 149.0 19:10:11 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:1.42 (1.5%) stddev-sans-first:0.60 19:10:11 INFO - PID 30535 | Values: 98.0 95.0 94.0 93.0 94.0 93.0 94.0 94.0 94.0 94.0 19:10:11 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | [#8] json-parse-financial Cycles:10 Average:43.30 Median:44.00 stddev:1.34 (3.0%) stddev-sans-first:1.27 19:10:11 INFO - PID 30535 | Values: 45.0 44.0 41.0 42.0 42.0 43.0 44.0 45.0 44.0 43.0 19:10:11 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | [#9] json-stringify-tinderbox Cycles:10 Average:37.00 Median:37.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 19:10:11 INFO - PID 30535 | Values: 37.0 37.0 37.0 37.0 37.0 37.0 37.0 37.0 37.0 37.0 19:10:11 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | [#10] stanford-crypto-aes Cycles:10 Average:73.40 Median:73.00 stddev:2.32 (3.2%) stddev-sans-first:2.06 19:10:11 INFO - PID 30535 | Values: 77.0 71.0 73.0 75.0 70.0 73.0 72.0 73.0 77.0 73.0 19:10:11 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | [#11] stanford-crypto-ccm Cycles:10 Average:105.30 Median:105.50 stddev:3.13 (3.0%) stddev-sans-first:2.19 19:10:11 INFO - PID 30535 | Values: 112.0 105.0 109.0 106.0 103.0 102.0 104.0 106.0 103.0 103.0 19:10:11 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.20 Median:154.00 stddev:4.13 (2.7%) stddev-sans-first:4.38 19:10:11 INFO - PID 30535 | Values: 154.0 154.0 150.0 158.0 150.0 153.0 158.0 149.0 154.0 162.0 19:10:11 INFO - PID 30535 | 19:10:11 INFO - PID 30535 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.40 Median:58.50 stddev:2.01 (3.4%) stddev-sans-first:2.07 19:10:11 INFO - PID 30535 | Values: 57.0 57.0 58.0 59.0 59.0 63.0 58.0 57.0 60.0 56.0 19:10:11 INFO - PID 30535 | -------- Summary: end -------- 19:10:11 INFO - PID 30535 | 19:10:12 INFO - PID 30535 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:10:12 INFO - TEST-INFO | 30535: exit 0 19:10:12 INFO - TEST-OK | kraken | took 58232ms 19:10:12 INFO - SUITE-END | took 1165s 19:10:12 INFO - Completed test suite (00:19:25) 19:10:12 INFO - javascript benchmark 19:10:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9498.748823789072, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4048.736832105913, 4057.7565346079236, 4060.127072679373, 4065.410515475255, 4078.898027549311, 6492.05865149553, 6493.22081350238, 6630.966845165767, 6637.634930078843, 6642.335766423361, 6573.441257493118, 6575.0, 6581.0, 6650.966745166267, 6662.0, 5913.615614985034, 5933.291692692046, 5945.583809133363, 5947.286325640929, 5982.282126144847, 5849.678267695275, 5891.293044834626, 5936.347001829817, 6063.090536419529, 6068.150458935753, 5962.672053037081, 5991.1612374267415, 6031.788887388921, 6043.972524670795, 6052.788152414644, 6016.097585362187, 6025.367336429656, 6037.184980027684, 6065.909011364833, 6106.084087386883, 5902.822915312548, 5921.378255283176, 5983.940160598382, 6092.603980741282, 6097.146399504073, 6508.64202468864, 6513.055606937015, 6524.543281970264, 6538.411542961157, 6545.0, 7114.110736157981, 7118.822029449253, 7215.747448839318, 7228.349448549656, 7239.276072392771, 7072.752453664097, 7168.46236532257, 7185.820354491128, 7238.927610723878, 7255.782326530212, 6520.8043758686845, 6601.438877695402, 6601.7359305627715, 6603.273639899608, 6621.271660117383, 7267.0, 7271.527350722186, 7278.745243916437, 7288.453365997571, 7382.409407247407, 7028.4025857801635, 7034.085568876116, 7058.11773528309, 7104.6447677615915, 7106.395956343768, 7177.784666460015, 7183.640817959081, 7223.927760722326, 7264.418846492268, 7288.052553168054, 6956.130483689539, 7090.290970902868, 7106.680199391039, 7107.289271072955, 7211.3870321023305, 7067.328603782736, 7143.392811610967, 7162.856742865218, 7164.641767911584, 7168.92831071693, 5217.713025783542, 5272.314599102092, 5282.577393808486, 5283.894322113536, 5290.444503327172, 4730.053989202173, 4753.049390121921, 4759.50025247351, 4771.5228477152, 4808.014357056795, 6712.39588437043, 6728.293529179464, 6772.458203343721, 6775.796726098225, 6778.627175505395, 7090.326418990187, 7131.215566287704, 7135.0, 7215.170255420694, 7224.0, 6589.472842172615, 6636.170478690164, 6713.765018224339, 6715.46276297895, 6766.15423072116, 5892.646441213541, 5943.167956486095, 5952.136940143741, 5957.255343082114, 5966.0454327307425, 7424.0, 7449.962750186214, 7485.438592105614, 7534.284242996907, 7540.472166948371, 7132.251113632994, 7142.464315176278, 7155.227327016474, 7224.74713385029, 7239.4932354734665, 7292.34368906801, 7371.041764570571, 7402.259774022555, 7424.406047516294, 7540.095188577406, 7109.360157585842, 7133.251008644018, 7144.392726618088, 7149.14210294768, 7151.7854464366155, 7007.7196912122945, 7122.465815063787, 7154.35610795031, 7218.963905180441, 7222.89165662526, 6832.0, 6871.347222013901, 6876.381125698711, 6903.309669033258, 6960.825979350557, 6850.8287292816085, 6852.383285504328, 6867.862642747217, 6868.244493105854, 6883.827904302432, 6679.899801503078, 6724.394804467425, 6742.9662851685425, 6774.085498457645, 6781.728730850711, 6675.666216689049, 6780.864382712417, 6855.760048398282, 6877.931220687729, 6898.586084834726, 6613.404793568602, 6629.403353698191, 6682.966585167043, 6684.866302674017, 6693.933060669526], "value": 6537.849871193166, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [980.8675828763118, 1001.3591301566998, 1002.7292630989633, 1007.2999265510473, 1013.0426746724346, 46720.76639616806, 47794.522054779445, 47832.0, 48033.0, 48058.51941480584, 43537.78231108848, 43820.12359752803, 43914.12171756571, 44117.7794111029, 44129.33805992913, 7496.775096747093, 7717.344025757818, 7717.382609391263, 7722.884156737653, 7723.884141737878, 7762.534247945113, 7857.607119643995, 7858.29275365217, 7864.724734634289, 7878.6454609542425, 8270.297024752903, 8565.443246188977, 8570.142985701443, 8571.100034496381, 8584.356173286997, 8380.0, 8439.535825529623, 8485.66057357705, 8517.190866867637, 8525.360597955178, 8318.792030199233, 8375.0, 8414.158584141598, 8422.620982055761, 8437.873431898526, 43497.0, 43508.56491435108, 43533.34699979503, 43658.0, 43774.12451750979, 3814.9618503814886, 3820.1213720844084, 3857.7106716996336, 3860.2279544091293, 3865.43951127085, 36017.27965440703, 36069.27861442757, 36074.09814754652, 36097.0, 36162.0, 5548.77804887804, 5614.382417934024, 5623.297087864017, 5627.212190293362, 5647.830565083054, 243895.0, 244730.0, 245594.99999999822, 246106.0, 247701.0, 50248.74875625598, 51099.74450127726, 56289.0, 56906.14640780391, 57772.42227577754, 60490.39509604935, 60536.697316514015, 60651.0, 60760.0, 60833.695831520556, 18791.81208187928, 18816.62366752657, 18839.246430142914, 18863.245470181315, 19001.714974275397, 15572.84427155714, 15574.454894078654, 15579.922100389425, 15637.139957302457, 15740.97683650559, 15911.204439777965, 15959.601009974844, 16019.359225630844, 16029.43896963624, 16054.75917861233, 6097.69511524422, 6104.847378815476, 6155.72299246535, 6167.766446710676, 6305.873882522324, 1099.9395033273088, 1100.7358234023936, 1103.4041617526445, 1117.1509652663872, 1122.0686829931137, 26391.340216494358, 26429.867850660623, 26446.44624628811, 26758.732412676014, 26831.195064148105, 1202.9578964736193, 1209.2744353388073, 1212.484694005062, 1219.859716132656, 1229.94465249064, 13858.584242472742, 14063.43746250159, 14184.432622695183, 14232.0, 14387.424503019762, 298326.0, 299002.0, 300148.0, 301581.0, 301658.0, 61477.84827531015, 61747.382526174166, 62172.37827621666, 62227.0, 62564.0, 1550.6743583847292, 1555.3389809331215, 1584.3979287870536, 1587.0239802521596, 1599.1045014791755, 26190.86904565541, 26227.606585900845, 26304.73695263023, 26573.202803915912, 26581.867090665197, 43917.560824391345, 43936.12127757491, 44004.33993490164, 44049.11901762011, 44096.0, 242697.0, 243086.0, 245090.0, 245431.0, 245456.0, 38385.0, 39137.80431097826, 42250.36624450574, 42402.78798605987, 42421.15157696891, 54165.45834541762, 55373.72313138408, 55437.0, 55539.0, 55574.0, 39343.2131357377, 39858.800705996284, 39899.800500997306, 40219.79890100648, 40658.79670601746, 39565.40651890166, 39695.2060958785, 39998.80000599979, 40368.3944740835, 40641.0, 45446.0, 46133.07733845237, 46457.53542464532, 46477.0, 46806.297905530766, 38044.23911521809, 38057.0, 38433.0, 38447.80776096102, 38863.61136388713, 24456.633150503112, 24811.0, 24861.502769944862, 25033.249002529952, 25045.24864254075], "value": 19717.937069957952, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.8597351131506, 610.6977046362051, 621.5214285000549, 629.7890206780731, 650.096366051189, 24971.375715607097, 25670.74329256709, 25807.483850323006, 25826.48347033063, 25912.83392247349, 27003.324916877038, 27832.3041923952, 27849.16452506428, 27879.442411151766, 27879.721202787965, 6667.73329066838, 6744.089547911043, 6772.255051944282, 6792.898106528406, 6800.6939687714175, 6649.900251496208, 6878.690458929335, 6944.097267355262, 6950.582965022089, 6959.0, 6827.522073454836, 6836.658167091626, 6851.554648947827, 6853.0, 6890.0, 6830.863382732342, 6849.075374824385, 6891.414229790449, 6896.793096207097, 6924.272951340087, 6470.514711396617, 6481.870362592722, 6483.578567393104, 6505.21937367519, 6505.609663420162, 29701.851490742625, 32575.51136732951, 33122.3375532488, 33154.668453315644, 33224.335513289596, 2346.002948746776, 2375.3349062262423, 2382.404398900275, 2388.450656349032, 2398.0887262840183, 21600.027998740094, 21828.89085554578, 22109.11563537473, 22170.334889953327, 22174.667379989314, 2634.1570697376847, 2656.8538730369823, 2699.676038875328, 2702.4054707964415, 2714.6199532065525, 144267.27866360705, 151977.24011379984, 167500.0, 174377.99999999872, 174595.0, 16838.663226735396, 16877.0, 17252.482425527254, 17439.56401089983, 17544.736828947574, 27224.183274501796, 27255.0, 27394.726052739617, 27401.177964661092, 27465.45069098607, 11517.539298428137, 11541.76916461666, 11651.242669226473, 11676.649700508999, 11898.940505297418, 10640.201984851012, 10687.732806679895, 10800.729981750519, 10823.188260880466, 10838.566457341618, 9973.30186886911, 10317.896821031694, 10323.741906452398, 10362.585496580203, 10494.108000820015, 2933.0, 3013.819170849712, 3074.9231269218003, 3097.90706278812, 3187.5378070179695, 1068.1935138970027, 1073.6510634043811, 1095.0965453500894, 1106.1372129738816, 1110.7889500994786, 22227.885038173874, 22315.21896733639, 22441.775582244296, 22455.55088898213, 22554.097836086374, 1158.9916772407892, 1164.5400066973498, 1166.0147175636573, 1169.187414746743, 1177.1230433327225, 12186.390680465942, 12345.38273086342, 12521.186122901981, 12521.686957825945, 12599.118061735773, 616725.0, 623932.0, 646258.0, 650467.0, 659406.0, 128819.0, 129672.0, 131497.0, 132505.33747331394, 133932.33033834767, 1169.6841852699724, 1222.6698791326291, 1264.1593340428697, 1265.0322503284995, 1296.0150285782872, 22961.88519057461, 23609.40976475602, 23694.88152559226, 23705.170319038752, 23708.170214042424, 63580.36419635744, 63649.6817515928, 64605.0, 65256.34743652503, 67095.98068087046, 81552.18447815684, 81598.0, 81885.19142258863, 82310.0, 82645.0, 16388.0, 16504.917475412545, 16520.66958660844, 16645.50063498097, 16655.3337866484, 25659.23022309334, 25757.484850302513, 25946.481070378864, 26061.609075863496, 26112.73887261179, 19077.427677169708, 19171.424857254304, 19377.128029238436, 19387.51531211731, 20669.17323307051, 18173.727394088834, 18491.167897444917, 18600.627987440446, 18693.345732899284, 19139.04304784783, 20145.899270503553, 21606.459838504165, 21637.783622163577, 21688.45778855478, 21791.12835486563, 16491.34034638601, 16516.587085322964, 16556.089415082286, 16570.337186512887, 16579.751303730212, 20260.696089558372, 20835.270765523135, 21023.57952840904, 21035.789642103384, 21261.7873821266], "value": 13475.670377076185, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.5752731707803, 1499.0630855715178, 1507.5703424524013, 1520.1942970225778, 1527.25164669312, 17139.143042847856, 17676.0, 17836.910815445906, 17844.28622855086, 17851.0, 17376.218070186842, 17490.650186996252, 17597.91201043993, 17604.911975440136, 17605.383811566597, 3016.2157838961807, 3037.529182976642, 3099.380123975203, 3100.2869340051802, 3102.5811515445353, 2846.5160922643095, 2864.914052578426, 2878.884844606224, 2888.090251570759, 2893.6238289022504, 2998.9100326990115, 3020.6979302069835, 3107.5338699195077, 3109.0983614751694, 3109.891153809617, 3091.48990416581, 3108.3938631966776, 3124.7500199983947, 3130.4834702274097, 3132.4674805283043, 3005.3238021445, 3026.6821983691834, 3030.8787648494035, 3073.830939298338, 3074.3390171113097, 16848.157592120468, 17337.826621733748, 17379.826201738073, 17380.739288910678, 17383.391581294592, 8905.332100092519, 9180.357374983754, 9185.770355741093, 9191.310651701082, 9226.953865230631, 5863.208466856962, 5902.144189092557, 6240.594361366497, 6281.968590157066, 6290.433860952537, 2088.9582208355746, 2093.194120263694, 2158.169104894627, 2159.2550570053463, 2176.1186719378675, 31245.687543124506, 31393.99999999977, 31465.685343146506, 31478.527822082688, 31501.52747708786, 7230.74692385764, 7235.819104522324, 7278.745243916544, 7360.411167106618, 7455.478116531791, 19987.800121998593, 20077.397678069683, 20082.39752807418, 20195.798042019687, 20278.391648250577, 8605.956970215235, 8825.07336729647, 8836.55817209137, 8852.557372131496, 8854.86717699235, 7831.6475758591005, 7935.246151615587, 8038.517688938682, 8143.0, 8146.67413303473, 5820.650760954356, 5822.214001109881, 5841.182234487175, 5892.852678683067, 5957.79147729836, 1577.8737700983893, 1589.4436947068434, 1591.6896205240098, 1595.9680806383808, 1613.2337139858473, 857.9871301930476, 1012.1548506996741, 1028.388109075114, 1033.2870319479534, 1044.3420644993757, 9937.701868943943, 10052.246081543914, 10239.48802559869, 10249.84625230622, 10334.793304133875, 1073.8711354637494, 1085.685151306128, 1088.7876864011441, 1097.2812807611028, 1118.8377685235757, 5902.61632993854, 6115.541334399938, 6330.525210609223, 6419.197600299963, 6501.609903405811, 25399.0, 26211.475770484863, 26607.0, 26621.866890665424, 26674.466510670067, 25577.104801331865, 25829.612555811676, 26228.73771262301, 26488.470230595667, 26600.201993940213, 12505.812412813815, 12514.436850341757, 12569.560065397483, 12583.0, 12588.937055314665, 8387.287080598218, 8706.782330441789, 8713.607887645197, 8715.477071375737, 8753.606087726195, 22142.446438839157, 22160.667589986486, 22289.331320060424, 22597.2090976815, 23214.651780222972, 22776.544469110857, 23060.540918862305, 23393.883030584737, 23415.297541073796, 23757.881210593838, 12300.507979680713, 12327.69180770488, 12351.444185011876, 12414.503419863104, 12469.251844889335, 15538.300776465312, 15748.055116693035, 15850.920745396199, 15851.841481585498, 15858.444954426539, 12679.0, 12975.416106275428, 13356.0, 13356.599302020955, 13584.524541640994, 12289.07831912628, 12667.93666031664, 12896.806547901977, 13125.60623181306, 13315.733685326046, 11721.765564688489, 11766.58816941403, 11889.870462306068, 11941.820872686743, 11970.042396608425, 8801.29589632815, 8895.0, 8899.822003559762, 8907.688230911886, 8968.730938071869, 8602.827943441222, 8768.868466973128, 8780.78048048804, 8804.735857924017, 8853.513056781681], "value": 7641.690945214723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.8618252345651, 587.142771553532, 588.5732843688329, 594.8721024979628, 598.7964092208649, 6424.132742079823, 6453.128827608271, 6465.450436712879, 6479.967600161998, 6518.934810651892, 6305.0, 6312.684365781715, 6325.683715814214, 6370.171877655898, 6401.583897046688, 5214.8174813881615, 5237.659552129118, 5301.443348448396, 5327.946720532784, 5341.572674186075, 4916.901661966758, 5138.9743051284695, 5280.075986702331, 5328.387235467932, 5348.331458567679, 5029.622778291625, 5065.240213967916, 5078.4413714491375, 5083.593312535007, 5088.440271570143, 5107.38711354638, 5125.461826508237, 5142.717150556718, 5144.279800827887, 5156.561692256163, 4627.329037289608, 4636.582707556302, 4657.906841863178, 4659.534046595347, 4683.391159149289, 6238.754048542521, 6277.748890044439, 6326.304106548276, 6363.649999250039, 6402.391772781578, 5990.580659353847, 6021.337652858182, 6052.546059045545, 6087.908681369783, 6088.543359248074, 6714.026466162379, 6790.219124800612, 6805.087074931934, 6846.965765171192, 6851.417629501499, 5183.688978661293, 5197.7920883164625, 5204.739763011834, 5214.113600687892, 5228.581713462914, 6956.339147780953, 6990.54561453509, 7052.541584796972, 7102.573845569283, 7201.3158749918675, 5350.170723537858, 5358.758855851496, 5367.007103685831, 5369.0, 5374.193870919394, 5449.5640348772, 5456.7544460499375, 5459.2902922619805, 5467.316585426822, 5475.534579560782, 6062.757489700451, 6075.635461872302, 6076.787312444043, 6076.908846367308, 6083.209182806207, 6854.2117656469145, 6911.481638877104, 6920.204176519765, 6923.792286231421, 6968.616726080114, 1809.475252176854, 1843.3271855772546, 1855.2208072609537, 1864.5804693943753, 1865.3471285050396, 1292.9030322725832, 1307.6534718299658, 1314.9868501314863, 1328.754180476615, 1331.108157534435, 6399.680015999182, 6420.678966051679, 6476.5466417350335, 6498.772542960974, 6500.252470965899, 6855.554388964801, 6882.759103431456, 6923.269182704324, 6985.301469853076, 6996.090508233897, 6494.6103233806125, 6525.184351956005, 6565.343465653396, 6597.439217666552, 6605.70274337656, 3627.4558816177782, 3635.345637785224, 3636.2182130841466, 3651.9634803652157, 3678.098865777848, 7150.463715221379, 7173.282671732785, 7225.132984041844, 7250.891236631454, 7293.8905916411295, 6992.161545109789, 7029.680205532162, 7123.394511466583, 7157.498975071695, 7204.53170543913, 7123.394511466479, 7159.248278930741, 7179.497435179592, 7243.420526357879, 7303.575802718419, 6864.725410983705, 6920.5847649141215, 7018.0, 7026.1217347831525, 7072.222055573986, 6819.965900170468, 6849.253440372872, 6958.652067396712, 6963.651817409008, 6978.511504194657, 6976.720931162697, 7260.165081015751, 7268.236835132235, 7284.817879553054, 7314.780556583311, 5206.583473322049, 5285.894282114413, 5291.1798671206025, 5292.285541452009, 5296.841979046584, 6519.478441724746, 6668.866622667422, 6793.112927006102, 6968.303169682991, 7015.333543313377, 6501.44737697301, 6706.0, 6707.731690732316, 6721.563098398588, 6733.966330168514, 6613.395699343965, 6624.8012559623285, 6707.496937729592, 6716.395524402632, 6716.899246511404, 6555.3772391622715, 6601.933980660132, 6710.16122984627, 6724.4620430364475, 6747.392734653905, 6708.42978346846, 6802.965985170043, 6835.829104272433, 6839.726410943506, 6857.794266172023, 6541.280459149394, 6544.705488252945, 6635.966820165868, 6670.366315200048, 6695.933040669531], "value": 5335.14905013057, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1004.2518323848734, 1020.8621836052133, 1033.782905589826, 1049.4752623688155, 1052.94208818515, 20375.796242037573, 20736.066876990535, 21196.0, 21601.45996350088, 21610.243641472513, 20002.0, 20036.0, 20246.493837654067, 20314.0, 20325.49186270344, 1092.6558134187726, 1095.1020163465962, 1097.8133717268045, 1098.6594155811683, 1100.6422912553412, 1076.43487169236, 1077.181342179941, 1081.967540973772, 1083.8699356077282, 1086.739182596179, 1099.5107177306102, 1143.794117058929, 1145.9484323205477, 1146.1232157399595, 1147.0536807134106, 1121.125522092769, 1122.5846436818347, 1139.2139423797553, 1139.3221033485063, 1142.9257098288626, 834.8163404051099, 842.204117109332, 842.7766641839918, 845.8392905347964, 848.4781859156636, 21058.05238764244, 21728.239511617176, 21811.781882181134, 21935.890320548453, 22236.6664500031, 24022.639660405108, 24070.277891663278, 24327.0, 24715.0, 24721.629175562382, 16519.33922643093, 16830.831691683048, 16913.57716057096, 16964.491065268063, 16997.150142492825, 3678.760880542783, 3783.3000894834545, 3800.1639639279315, 3802.372608519591, 3803.9619603803885, 131799.0, 152124.0, 168948.0, 171078.0, 178695.0, 19127.33054343091, 19317.0, 19515.0, 19588.90205548963, 19643.60712785736, 35812.0, 35901.46147807785, 36078.819605902325, 36197.638023619955, 36204.45693314602, 10582.841257381146, 10676.252662313564, 10687.946560267148, 10716.035556799925, 10730.087942524817, 5178.508041736029, 5214.191800270964, 5227.45111763267, 5269.868253293622, 5284.947150528523, 6456.483481321483, 6506.544541882117, 6512.120863683437, 6579.769708060195, 6580.045893345438, 1305.145129939891, 1339.2901762066122, 1346.5690978886857, 1349.2174538767492, 1372.3618517389461, 716.77421612192, 742.5284944060453, 747.4058123791599, 766.3907193780957, 772.6291380137566, 13782.448702051806, 13828.585142445541, 13942.302884855717, 14176.362063707158, 14228.430862765374, 777.5995362388261, 781.413939545341, 783.3537331701369, 788.8461749958703, 795.745361484331, 6785.898211526831, 6816.352446517573, 6824.863502730017, 6849.109615750021, 6877.415419689382, 151935.0, 153219.23390382977, 156727.0, 158548.0, 163780.0, 132500.0, 134572.0, 136615.31692341474, 138592.0, 142830.0, 120198.0, 121360.3931980352, 121825.56348872973, 122583.0, 126872.36563817122, 12613.432395542039, 13040.673983150496, 13045.543405980745, 13078.149920255153, 13201.135688873097, 58906.41093589181, 59464.70267648634, 59956.70021649864, 60184.09723854233, 61197.694011531436, 73950.26049739434, 73963.63018184874, 74220.62889685734, 74754.0, 75583.24416755982, 15667.608309792346, 15844.970076944961, 16059.19704014818, 16075.35698572044, 16109.113998730183, 20294.188232471126, 20449.59100818005, 20464.0, 20494.692579611616, 21172.153113875273, 18696.0, 19065.618687626447, 19087.33194338247, 19114.522136946132, 19370.70943935814, 18616.720749188502, 18770.249190032246, 18944.336948206746, 19040.809591903904, 19046.904765476083, 18989.52526186801, 19088.522786930436, 19317.4204773857, 19452.708209377153, 19479.026048697793, 12390.81413778776, 12720.74558508843, 12956.935215323863, 13045.412956416794, 13177.736445271232, 13612.319384030561, 13792.0, 13939.581812545639, 13974.860251397762, 14162.150270983773], "value": 10370.247826377641, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1362.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 108.0, 108.0, 106.0, 106.0, 106.0, 105.0, 106.0, 105.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 110.0, 111.0, 113.0, 114.0, 111.0, 110.0, 110.0, 141.0], "value": 114.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 163.0, 164.0, 162.0, 163.0, 162.0, 165.0, 161.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 73.0, 72.0, 72.0, 72.0, 72.0, 73.0, 73.0], "value": 72.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 78.0, 80.0, 82.0, 77.0, 77.0, 77.0, 78.0, 81.0], "value": 78.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 114.0, 115.0, 111.0, 113.0, 118.0, 116.0, 113.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 148.0, 149.0, 149.0, 149.0, 149.0, 149.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 44.0, 41.0, 42.0, 42.0, 43.0, 44.0, 45.0, 44.0, 43.0], "value": 43.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0], "value": 37.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 71.0, 73.0, 75.0, 70.0, 73.0, 72.0, 73.0, 77.0, 73.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 109.0, 106.0, 103.0, 102.0, 104.0, 106.0, 103.0, 103.0], "value": 105.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 150.0, 158.0, 150.0, 153.0, 158.0, 149.0, 154.0, 162.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 59.0, 59.0, 63.0, 58.0, 57.0, 60.0, 56.0], "value": 58.4, "unit": "score"}]}]} 19:10:12 INFO - Return code: 0 19:10:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:10:12 INFO - # TBPL SUCCESS # 19:10:12 INFO - Running post-action listener: _package_coverage_data 19:10:12 INFO - Running post-action listener: _resource_record_post_action 19:10:12 INFO - [mozharness: 2017-09-15 02:10:12.624633Z] Finished run-tests step (success) 19:10:12 INFO - Running post-run listener: _resource_record_post_run 19:10:12 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290017280; Read time: 8; Write time: 182724 19:10:12 INFO - TinderboxPrint: CPU usage
13.0% 19:10:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:10:12 INFO - TinderboxPrint: I/O write bytes / time
290,017,280 / 182,724 19:10:12 INFO - TinderboxPrint: CPU idle
8,181.7 (86.9%) 19:10:12 INFO - TinderboxPrint: CPU user
1,180.1 (12.5%) 19:10:12 INFO - TinderboxPrint: Swap in / out
0 / 0 19:10:12 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 6352896; Read time: 0; Write time: 472 19:10:12 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:10:12 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 4096; Write bytes: 271163392; Read time: 8; Write time: 181020 19:10:13 INFO - Running post-run listener: _upload_blobber_files 19:10:13 INFO - Blob upload gear active. 19:10:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:10:13 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 19:10:13 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'] 19:10:13 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 19:10:13 INFO - (blobuploader) - INFO - Open directory for files ... 19:10:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:10:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:10:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:14 INFO - (blobuploader) - INFO - Done attempting. 19:10:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:10:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:10:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:15 INFO - (blobuploader) - INFO - Done attempting. 19:10:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:10:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:10:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:16 INFO - (blobuploader) - INFO - Done attempting. 19:10:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:10:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:10:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:24 INFO - (blobuploader) - INFO - Done attempting. 19:10:24 INFO - (blobuploader) - INFO - Iteration through files over. 19:10:24 INFO - Return code: 0 19:10:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:10:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:10:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/29c7aa7ef7d1d83707da518f7d17de27e1cd072d630dbb3f8de9ce8a88bc48983cacb6287a6e8994d405ad10b5c37a47fd25596cac332b7998dfe9d3fe63ed1c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/62fffb82a6f2f1a30c41725c64cb19746351e4e6e710e4e9605028bebf86e04852b3a5e89b07c555c7cca1f40cef92db7bfc55d70da17091fc1d177a9dba1795", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5c2498571bcc2b70bcf184ac11e1c7fb3354f817bad8f860f398ed3f4b19538f2bc0f7788ee535d6e122de80a0695da7e45c51dbf81926cb0c2ca215ab7a8e34", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/079d382dc10e2fb2830161c09c4e44f3e3a0c8d030be33cb0b719c255ab7900a713ed7dd04624c42b557a7aa842685f7476ef827c6fa03e3c85e81ed118d33db"} 19:10:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:10:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:10:24 INFO - Contents: 19:10:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/29c7aa7ef7d1d83707da518f7d17de27e1cd072d630dbb3f8de9ce8a88bc48983cacb6287a6e8994d405ad10b5c37a47fd25596cac332b7998dfe9d3fe63ed1c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/62fffb82a6f2f1a30c41725c64cb19746351e4e6e710e4e9605028bebf86e04852b3a5e89b07c555c7cca1f40cef92db7bfc55d70da17091fc1d177a9dba1795", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5c2498571bcc2b70bcf184ac11e1c7fb3354f817bad8f860f398ed3f4b19538f2bc0f7788ee535d6e122de80a0695da7e45c51dbf81926cb0c2ca215ab7a8e34", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/079d382dc10e2fb2830161c09c4e44f3e3a0c8d030be33cb0b719c255ab7900a713ed7dd04624c42b557a7aa842685f7476ef827c6fa03e3c85e81ed118d33db"} 19:10:24 INFO - Running post-run listener: copy_logs_to_upload_dir 19:10:24 INFO - Copying logs to upload dir... 19:10:24 INFO - mkdir: /builds/slave/test/build/upload/logs 19:10:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1312.674704 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2017-09-14 19:10:24.419445) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 19:10:24.423118) ========= 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=0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056 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/29c7aa7ef7d1d83707da518f7d17de27e1cd072d630dbb3f8de9ce8a88bc48983cacb6287a6e8994d405ad10b5c37a47fd25596cac332b7998dfe9d3fe63ed1c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/62fffb82a6f2f1a30c41725c64cb19746351e4e6e710e4e9605028bebf86e04852b3a5e89b07c555c7cca1f40cef92db7bfc55d70da17091fc1d177a9dba1795", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5c2498571bcc2b70bcf184ac11e1c7fb3354f817bad8f860f398ed3f4b19538f2bc0f7788ee535d6e122de80a0695da7e45c51dbf81926cb0c2ca215ab7a8e34", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/079d382dc10e2fb2830161c09c4e44f3e3a0c8d030be33cb0b719c255ab7900a713ed7dd04624c42b557a7aa842685f7476ef827c6fa03e3c85e81ed118d33db"} build_url:https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/JqZSVEnuQWW_NWeaC3HcgA/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/29c7aa7ef7d1d83707da518f7d17de27e1cd072d630dbb3f8de9ce8a88bc48983cacb6287a6e8994d405ad10b5c37a47fd25596cac332b7998dfe9d3fe63ed1c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/62fffb82a6f2f1a30c41725c64cb19746351e4e6e710e4e9605028bebf86e04852b3a5e89b07c555c7cca1f40cef92db7bfc55d70da17091fc1d177a9dba1795", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5c2498571bcc2b70bcf184ac11e1c7fb3354f817bad8f860f398ed3f4b19538f2bc0f7788ee535d6e122de80a0695da7e45c51dbf81926cb0c2ca215ab7a8e34", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/079d382dc10e2fb2830161c09c4e44f3e3a0c8d030be33cb0b719c255ab7900a713ed7dd04624c42b557a7aa842685f7476ef827c6fa03e3c85e81ed118d33db"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 19:10:24.451868) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 19:10:24.452218) ========= 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=0333a256a5e4f052382dd180000001b1-1505430979.772340-1127399056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 19:10:24.534719) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 19:10:24.535031) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 19:10:24.535351) ========= ========= Total master_lag: 0.20 =========