builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1504431863.38 results: success (0) revision: 37824bf5c5b08afa7e689fceb935b8f457ebd9eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:23.379656) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:23.380151) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:23.380426) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:23.449952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:23.450432) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-03 02:44:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.9M=0s 2017-09-03 02:44:23 (36.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106636 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:23.573626) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:23.573980) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014527 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:23.624150) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:23.624525) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37824bf5c5b08afa7e689fceb935b8f457ebd9eb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 37824bf5c5b08afa7e689fceb935b8f457ebd9eb --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=e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-03 02:44:23,663 truncating revision to first 12 chars 2017-09-03 02:44:23,664 Setting DEBUG logging. 2017-09-03 02:44:23,664 attempt 1/10 2017-09-03 02:44:23,664 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37824bf5c5b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-03 02:44:23,970 unpacking tar archive at: mozilla-central-37824bf5c5b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657506 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:24.299294) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:24.299643) ========= script_repo_revision: 37824bf5c5b08afa7e689fceb935b8f457ebd9eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:24.300037) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:24.300317) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:24.315989) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-09-03 02:44:24.316422) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:44:24 INFO - MultiFileLogger online at 20170903 02:44:24 in /builds/slave/test 02:44:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:44:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:44:24 INFO - {'append_to_log': False, 02:44:24 INFO - 'base_work_dir': '/builds/slave/test', 02:44:24 INFO - 'blob_upload_branch': 'Firefox', 02:44:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:44:24 INFO - 'branch': 'Firefox', 02:44:24 INFO - 'buildbot_json_path': 'buildprops.json', 02:44:24 INFO - 'code_coverage': False, 02:44:24 INFO - 'config_files': ('talos/linux_config.py',), 02:44:24 INFO - 'default_actions': ('clobber', 02:44:24 INFO - 'read-buildbot-config', 02:44:24 INFO - 'download-and-extract', 02:44:24 INFO - 'populate-webroot', 02:44:24 INFO - 'create-virtualenv', 02:44:24 INFO - 'install', 02:44:24 INFO - 'setup-mitmproxy', 02:44:24 INFO - 'run-tests'), 02:44:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:44:24 INFO - 'disable_ccov_upload': False, 02:44:24 INFO - 'disable_stylo': False, 02:44:24 INFO - 'download_minidump_stackwalk': True, 02:44:24 INFO - 'download_symbols': 'ondemand', 02:44:24 INFO - 'enable_stylo': False, 02:44:24 INFO - 'enable_webrender': False, 02:44:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:44:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:44:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:44:24 INFO - 'gecko_profile': False, 02:44:24 INFO - 'gecko_profile_interval': 0, 02:44:24 INFO - 'installer_path': 'installer.exe', 02:44:24 INFO - 'log_level': 'info', 02:44:24 INFO - 'log_name': 'talos', 02:44:24 INFO - 'log_to_console': True, 02:44:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:44:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:44:24 INFO - 'opt_config_files': (), 02:44:24 INFO - 'pip_index': False, 02:44:24 INFO - 'suite': 'dromaeojs-e10s', 02:44:24 INFO - 'system_bits': '32', 02:44:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:44:24 INFO - 'title': 'talos-linux64-ix-067', 02:44:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:44:24 INFO - 'use_talos_json': True, 02:44:24 INFO - 'verify': 'False', 02:44:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:44:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:44:24 INFO - 'work_dir': 'build'} 02:44:24 INFO - [mozharness: 2017-09-03 09:44:24.497344Z] Running clobber step. 02:44:24 INFO - Running pre-action listener: _resource_record_pre_action 02:44:24 INFO - Running main action method: clobber 02:44:24 INFO - rmtree: /builds/slave/test/build 02:44:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:44:25 INFO - Running post-action listener: _resource_record_post_action 02:44:25 INFO - [mozharness: 2017-09-03 09:44:25.508658Z] Finished clobber step (success) 02:44:25 INFO - [mozharness: 2017-09-03 09:44:25.508765Z] Running read-buildbot-config step. 02:44:25 INFO - Running pre-action listener: _resource_record_pre_action 02:44:25 INFO - Running main action method: read_buildbot_config 02:44:25 INFO - Using buildbot properties: 02:44:25 INFO - { 02:44:25 INFO - "project": "", 02:44:25 INFO - "product": "firefox", 02:44:25 INFO - "who": "archaeopteryx@coole-files.de", 02:44:25 INFO - "installer_path": "public/build/target.tar.bz2", 02:44:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 02:44:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:44:25 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 02:44:25 INFO - "stage_platform": "linux64-qr", 02:44:25 INFO - "basedir": "/builds/slave/test", 02:44:25 INFO - "buildnumber": 28, 02:44:25 INFO - "platform": "ubuntu64_hw_qr", 02:44:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:44:25 INFO - "slavebuilddir": "test", 02:44:25 INFO - "taskId": "eYEbhj9YT-m7VbMPSy8_Lg", 02:44:25 INFO - "branch": "mozilla-central", 02:44:25 INFO - "script_repo_revision": "production", 02:44:25 INFO - "revision": "37824bf5c5b08afa7e689fceb935b8f457ebd9eb", 02:44:25 INFO - "slavename": "talos-linux64-ix-067", 02:44:25 INFO - "repo_path": "mozilla-central" 02:44:25 INFO - } 02:44:25 INFO - Finding installer, test and symbols from parent task. 02:44:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eYEbhj9YT-m7VbMPSy8_Lg'}, attempt #1 02:44:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eYEbhj9YT-m7VbMPSy8_Lg'}, attempt #1 02:44:26 INFO - Task dependencies: K9R3fxHzShCqGda311qAQg 02:44:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg'}, attempt #1 02:44:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 02:44:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.test_packages.json 02:44:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.crashreporter-symbols.zip 02:44:26 INFO - Running post-action listener: _resource_record_post_action 02:44:26 INFO - [mozharness: 2017-09-03 09:44:26.910858Z] Finished read-buildbot-config step (success) 02:44:26 INFO - [mozharness: 2017-09-03 09:44:26.911076Z] Running download-and-extract step. 02:44:26 INFO - Running pre-action listener: _resource_record_pre_action 02:44:26 INFO - Running main action method: download_and_extract 02:44:26 INFO - mkdir: /builds/slave/test/build/tests 02:44: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')]} 02:44:26 INFO - trying https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.test_packages.json 02:44:26 INFO - Downloading https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:44:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:44:27 INFO - Downloaded 989 bytes. 02:44:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:44:27 INFO - Using the following test package requirements: 02:44:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:44:27 INFO - u'common': [u'target.common.tests.zip'], 02:44:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:44:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:44:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:44:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:44:27 INFO - u'mozbase': [u'target.common.tests.zip'], 02:44:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:44:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:44:27 INFO - u'web-platform': [u'target.common.tests.zip', 02:44:27 INFO - u'target.web-platform.tests.tar.gz'], 02:44:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:44:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:44:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip 02:44:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:44:27 INFO - Fetch https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip into memory 02:44:29 INFO - Content-Length response header: 55022284 02:44:29 INFO - Bytes received: 55022284 02:44:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:44:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip 02:44:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:44:40 INFO - Fetch https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip into memory 02:44:41 INFO - Content-Length response header: 55022284 02:44:41 INFO - Bytes received: 55022284 02:44:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.talos.tests.zip 02:44:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:44:53 INFO - Fetch https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.talos.tests.zip into memory 02:44:55 INFO - Content-Length response header: 14496650 02:44:55 INFO - Bytes received: 14496650 02:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:55 INFO - trying https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 02:44:55 INFO - Downloading https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:44:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:44:57 INFO - Downloaded 62653558 bytes. 02:44:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 02:44:57 INFO - mkdir: /builds/slave/test/properties 02:44:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:44:57 INFO - Writing to file /builds/slave/test/properties/build_url 02:44:57 INFO - Contents: 02:44:57 INFO - build_url:https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 02:44:57 INFO - Running post-action listener: _resource_record_post_action 02:44:57 INFO - Running post-action listener: find_tests_for_verification 02:44:57 INFO - Running post-action listener: set_extra_try_arguments 02:44:57 INFO - [mozharness: 2017-09-03 09:44:57.501509Z] Finished download-and-extract step (success) 02:44:57 INFO - [mozharness: 2017-09-03 09:44:57.501685Z] Running populate-webroot step. 02:44:57 INFO - Running pre-action listener: _resource_record_pre_action 02:44:57 INFO - Running main action method: populate_webroot 02:44:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:44:57 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:44:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:44:57 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:44:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:57 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'tests': ['damp', 'tps']}, 02:44:57 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['damp', 'tps']}, 02:44:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:44:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:44:57 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:44:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:44:57 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:44:57 INFO - 'other-e10s': {'tests': ['a11yr', 02:44:57 INFO - 'ts_paint', 02:44:57 INFO - 'tpaint', 02:44:57 INFO - 'sessionrestore', 02:44:57 INFO - 'sessionrestore_many_windows', 02:44:57 INFO - 'sessionrestore_no_auto_restore', 02:44:57 INFO - 'tabpaint']}, 02:44:57 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['a11yr', 02:44:57 INFO - 'ts_paint', 02:44:57 INFO - 'tpaint', 02:44:57 INFO - 'sessionrestore', 02:44:57 INFO - 'sessionrestore_many_windows', 02:44:57 INFO - 'sessionrestore_no_auto_restore', 02:44:57 INFO - 'tabpaint']}, 02:44:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:44:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:44:57 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['bloom_basic_singleton']}, 02:44:57 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['bloom_basic']}, 02:44:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:44:57 INFO - 'tsvgr_opacity', 02:44:57 INFO - 'tart', 02:44:57 INFO - 'tscrollx', 02:44:57 INFO - 'tsvg_static']}, 02:44:57 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['tsvgx', 02:44:57 INFO - 'tsvgr_opacity', 02:44:57 INFO - 'tart', 02:44:57 INFO - 'tscrollx', 02:44:57 INFO - 'tsvg_static']}, 02:44:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:44:57 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['tp5o']}, 02:44:57 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:44:57 INFO - 'talos_options': ['--mitmproxy', 02:44:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:44:57 INFO - '--firstNonBlankPaint'], 02:44:57 INFO - 'tests': ['tp6_google', 02:44:57 INFO - 'tp6_youtube', 02:44:57 INFO - 'tp6_amazon', 02:44:57 INFO - 'tp6_facebook']}, 02:44:57 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:44:57 INFO - 'talos_options': ['--enable-stylo', 02:44:57 INFO - '--mitmproxy', 02:44:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:44:57 INFO - '--firstNonBlankPaint'], 02:44:57 INFO - 'tests': ['tp6_google', 02:44:57 INFO - 'tp6_youtube', 02:44:57 INFO - 'tp6_amazon', 02:44:57 INFO - 'tp6_facebook']}, 02:44:57 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:44:57 INFO - 'talos_options': ['--enable-stylo', 02:44:57 INFO - '--stylo-threads=1', 02:44:57 INFO - '--mitmproxy', 02:44:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:44:57 INFO - '--firstNonBlankPaint'], 02:44:57 INFO - 'tests': ['tp6_google', 02:44:57 INFO - 'tp6_youtube', 02:44:57 INFO - 'tp6_amazon', 02:44:57 INFO - 'tp6_facebook']}, 02:44:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'talos_options': ['--xperf_path', 02:44:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:57 INFO - 'tests': ['tp5n']}, 02:44:57 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'talos_options': ['--enable-stylo', 02:44:57 INFO - '--xperf_path', 02:44:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:57 INFO - 'tests': ['tp5n']}}} 02:44:57 INFO - Running post-action listener: _resource_record_post_action 02:44:57 INFO - [mozharness: 2017-09-03 09:44:57.523515Z] Finished populate-webroot step (success) 02:44:57 INFO - [mozharness: 2017-09-03 09:44:57.523604Z] Running create-virtualenv step. 02:44:57 INFO - Running pre-action listener: _resource_record_pre_action 02:44:57 INFO - Running main action method: create_virtualenv 02:44:57 INFO - Creating virtualenv /builds/slave/test/build/venv 02:44:57 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:44:57 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:44:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:44:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:44:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:44:58 INFO - Installing distribute.............................................................................................................................................................................................done. 02:44:58 INFO - Installing pip...............done. 02:44:58 INFO - Return code: 0 02:44:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:44:58 INFO - Reading from file tmpfile_stdout 02:44:58 INFO - Output received: 02:44:58 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:44:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2090>, '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 0x29d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ccf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', '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 02:44:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:44:58 INFO - Using env: {'DISPLAY': ':0', 02:44:58 INFO - 'HOME': '/home/cltbld', 02:44:58 INFO - 'LANG': 'en_US.UTF-8', 02:44:58 INFO - 'LANGUAGE': 'en_US:en', 02:44:58 INFO - 'LOGNAME': 'cltbld', 02:44:58 INFO - 'MAIL': '/var/mail/cltbld', 02:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:58 INFO - 'MOZ_NO_REMOTE': '1', 02:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:58 INFO - 'NO_EM_RESTART': '1', 02:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:58 INFO - 'PWD': '/builds/slave/test', 02:44:58 INFO - 'SHELL': '/bin/bash', 02:44:58 INFO - 'SHLVL': '1', 02:44:58 INFO - 'TERM': 'linux', 02:44:58 INFO - 'TMOUT': '86400', 02:44:58 INFO - 'USER': 'cltbld', 02:44:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', 02:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:58 INFO - '_': '/tools/buildbot/bin/python'} 02:44:59 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:44:59 INFO - Downloading/unpacking pip>=1.5 02:44:59 INFO - Running setup.py egg_info for package pip 02:44:59 INFO - warning: no files found matching 'pip/cacert.pem' 02:44:59 INFO - warning: no files found matching '*.html' under directory 'docs' 02:44:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:44:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:44:59 INFO - Installing collected packages: pip 02:44:59 INFO - Found existing installation: pip 1.1 02:44:59 INFO - Uninstalling pip: 02:44:59 INFO - Successfully uninstalled pip 02:44:59 INFO - Running setup.py install for pip 02:44:59 INFO - warning: no files found matching 'pip/cacert.pem' 02:44:59 INFO - warning: no files found matching '*.html' under directory 'docs' 02:44:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:44:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:44:59 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Successfully installed pip 02:44:59 INFO - Cleaning up... 02:44:59 INFO - Return code: 0 02:44:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:44:59 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')]} 02:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:59 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')]} 02:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:59 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 0x26621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2090>, '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 0x29d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ccf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', '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 02:44:59 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 02:44:59 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 02:44:59 INFO - Using env: {'DISPLAY': ':0', 02:44:59 INFO - 'HOME': '/home/cltbld', 02:44:59 INFO - 'LANG': 'en_US.UTF-8', 02:44:59 INFO - 'LANGUAGE': 'en_US:en', 02:44:59 INFO - 'LOGNAME': 'cltbld', 02:44:59 INFO - 'MAIL': '/var/mail/cltbld', 02:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:59 INFO - 'MOZ_NO_REMOTE': '1', 02:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:59 INFO - 'NO_EM_RESTART': '1', 02:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:59 INFO - 'PWD': '/builds/slave/test', 02:44:59 INFO - 'SHELL': '/bin/bash', 02:44:59 INFO - 'SHLVL': '1', 02:44:59 INFO - 'TERM': 'linux', 02:44:59 INFO - 'TMOUT': '86400', 02:44:59 INFO - 'USER': 'cltbld', 02:44:59 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', 02:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:59 INFO - '_': '/tools/buildbot/bin/python'} 02:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:59 INFO - Downloading/unpacking psutil>=3.1.1 02:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:45:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:01 INFO - Installing collected packages: psutil 02:45:01 INFO - Running setup.py install for psutil 02:45:01 INFO - building 'psutil._psutil_linux' extension 02:45:01 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 02:45:01 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 02:45:01 INFO - building 'psutil._psutil_posix' extension 02:45:01 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 02:45:01 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 02:45:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:01 INFO - Successfully installed psutil 02:45:01 INFO - Cleaning up... 02:45:01 INFO - Return code: 0 02:45:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:01 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 0x26621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2090>, '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 0x29d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ccf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', '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 02:45:01 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 02:45:01 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 02:45:01 INFO - Using env: {'DISPLAY': ':0', 02:45:01 INFO - 'HOME': '/home/cltbld', 02:45:01 INFO - 'LANG': 'en_US.UTF-8', 02:45:01 INFO - 'LANGUAGE': 'en_US:en', 02:45:01 INFO - 'LOGNAME': 'cltbld', 02:45:01 INFO - 'MAIL': '/var/mail/cltbld', 02:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:01 INFO - 'MOZ_NO_REMOTE': '1', 02:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:01 INFO - 'NO_EM_RESTART': '1', 02:45:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:01 INFO - 'PWD': '/builds/slave/test', 02:45:01 INFO - 'SHELL': '/bin/bash', 02:45:01 INFO - 'SHLVL': '1', 02:45:01 INFO - 'TERM': 'linux', 02:45:01 INFO - 'TMOUT': '86400', 02:45:01 INFO - 'USER': 'cltbld', 02:45:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', 02:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:01 INFO - '_': '/tools/buildbot/bin/python'} 02:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:45:01 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 02:45:01 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 02:45:01 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 02:45:01 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 02:45:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:45:03 INFO - Installing collected packages: mozsystemmonitor 02:45:03 INFO - Running setup.py install for mozsystemmonitor 02:45:03 INFO - Successfully installed mozsystemmonitor 02:45:03 INFO - Cleaning up... 02:45:03 INFO - Return code: 0 02:45:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:03 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 0x26621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2090>, '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 0x29d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ccf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', '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 02:45:03 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 02:45:03 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 02:45:03 INFO - Using env: {'DISPLAY': ':0', 02:45:03 INFO - 'HOME': '/home/cltbld', 02:45:03 INFO - 'LANG': 'en_US.UTF-8', 02:45:03 INFO - 'LANGUAGE': 'en_US:en', 02:45:03 INFO - 'LOGNAME': 'cltbld', 02:45:03 INFO - 'MAIL': '/var/mail/cltbld', 02:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:03 INFO - 'MOZ_NO_REMOTE': '1', 02:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:03 INFO - 'NO_EM_RESTART': '1', 02:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:03 INFO - 'PWD': '/builds/slave/test', 02:45:03 INFO - 'SHELL': '/bin/bash', 02:45:03 INFO - 'SHLVL': '1', 02:45:03 INFO - 'TERM': 'linux', 02:45:03 INFO - 'TMOUT': '86400', 02:45:03 INFO - 'USER': 'cltbld', 02:45:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', 02:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:03 INFO - '_': '/tools/buildbot/bin/python'} 02:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:03 INFO - Downloading/unpacking jsonschema==2.5.1 02:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:45:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:04 INFO - Downloading functools32-3.2.3-2.tar.gz 02:45:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:45:04 INFO - warning: no files found matching '*.txt' 02:45:04 INFO - no previously-included directories found matching 'build' 02:45:04 INFO - no previously-included directories found matching 'dist' 02:45:04 INFO - no previously-included directories found matching '.git*' 02:45:04 INFO - Installing collected packages: jsonschema, functools32 02:45:04 INFO - Running setup.py install for functools32 02:45:04 INFO - warning: no files found matching '*.txt' 02:45:04 INFO - no previously-included directories found matching 'build' 02:45:04 INFO - no previously-included directories found matching 'dist' 02:45:04 INFO - no previously-included directories found matching '.git*' 02:45:04 INFO - Successfully installed jsonschema functools32 02:45:04 INFO - Cleaning up... 02:45:04 INFO - Return code: 0 02:45:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:04 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 0x26621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2090>, '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 0x29d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ccf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', '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 02:45:04 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 02:45:04 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 02:45:04 INFO - Using env: {'DISPLAY': ':0', 02:45:04 INFO - 'HOME': '/home/cltbld', 02:45:04 INFO - 'LANG': 'en_US.UTF-8', 02:45:04 INFO - 'LANGUAGE': 'en_US:en', 02:45:04 INFO - 'LOGNAME': 'cltbld', 02:45:04 INFO - 'MAIL': '/var/mail/cltbld', 02:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:04 INFO - 'MOZ_NO_REMOTE': '1', 02:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:04 INFO - 'NO_EM_RESTART': '1', 02:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:04 INFO - 'PWD': '/builds/slave/test', 02:45:04 INFO - 'SHELL': '/bin/bash', 02:45:04 INFO - 'SHLVL': '1', 02:45:04 INFO - 'TERM': 'linux', 02:45:04 INFO - 'TMOUT': '86400', 02:45:04 INFO - 'USER': 'cltbld', 02:45:04 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', 02:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:04 INFO - '_': '/tools/buildbot/bin/python'} 02:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:45:05 INFO - Cleaning up... 02:45:05 INFO - Return code: 0 02:45:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:45:05 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')]} 02:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:05 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')]} 02:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:05 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 0x26621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2090>, '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 0x29d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ccf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', '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 02:45:05 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 02:45:05 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 02:45:05 INFO - Using env: {'DISPLAY': ':0', 02:45:05 INFO - 'HOME': '/home/cltbld', 02:45:05 INFO - 'LANG': 'en_US.UTF-8', 02:45:05 INFO - 'LANGUAGE': 'en_US:en', 02:45:05 INFO - 'LOGNAME': 'cltbld', 02:45:05 INFO - 'MAIL': '/var/mail/cltbld', 02:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:05 INFO - 'MOZ_NO_REMOTE': '1', 02:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:05 INFO - 'NO_EM_RESTART': '1', 02:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:05 INFO - 'PWD': '/builds/slave/test', 02:45:05 INFO - 'SHELL': '/bin/bash', 02:45:05 INFO - 'SHLVL': '1', 02:45:05 INFO - 'TERM': 'linux', 02:45:05 INFO - 'TMOUT': '86400', 02:45:05 INFO - 'USER': 'cltbld', 02:45:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', 02:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:05 INFO - '_': '/tools/buildbot/bin/python'} 02:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:05 INFO - Downloading/unpacking blobuploader==1.2.4 02:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:06 INFO - Downloading blobuploader-1.2.4.tar.gz 02:45:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:45:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:45:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:06 INFO - Downloading docopt-0.6.1.tar.gz 02:45:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:45:06 INFO - Installing collected packages: blobuploader, requests, docopt 02:45:06 INFO - Running setup.py install for blobuploader 02:45:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:45:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:45:07 INFO - Running setup.py install for requests 02:45:07 INFO - Running setup.py install for docopt 02:45:07 INFO - Successfully installed blobuploader requests docopt 02:45:07 INFO - Cleaning up... 02:45:07 INFO - Return code: 0 02:45:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:07 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 0x26621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2090>, '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 0x29d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ccf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', '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 02:45:07 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 02:45:07 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 02:45:07 INFO - Using env: {'DISPLAY': ':0', 02:45:07 INFO - 'HOME': '/home/cltbld', 02:45:07 INFO - 'LANG': 'en_US.UTF-8', 02:45:07 INFO - 'LANGUAGE': 'en_US:en', 02:45:07 INFO - 'LOGNAME': 'cltbld', 02:45:07 INFO - 'MAIL': '/var/mail/cltbld', 02:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:07 INFO - 'MOZ_NO_REMOTE': '1', 02:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:07 INFO - 'NO_EM_RESTART': '1', 02:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:07 INFO - 'PWD': '/builds/slave/test', 02:45:07 INFO - 'SHELL': '/bin/bash', 02:45:07 INFO - 'SHLVL': '1', 02:45:07 INFO - 'TERM': 'linux', 02:45:07 INFO - 'TMOUT': '86400', 02:45:07 INFO - 'USER': 'cltbld', 02:45:07 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', 02:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:07 INFO - '_': '/tools/buildbot/bin/python'} 02:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:45:07 INFO - Running setup.py (path:/tmp/pip-m_ppXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:45:07 INFO - Running setup.py (path:/tmp/pip-Bw53R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:45:07 INFO - Running setup.py (path:/tmp/pip-_YRth6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:45:07 INFO - Running setup.py (path:/tmp/pip-jSSi0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:45:08 INFO - Running setup.py (path:/tmp/pip-u8gRQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:45:08 INFO - Running setup.py (path:/tmp/pip-sbcT5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:45:08 INFO - Running setup.py (path:/tmp/pip-W3Rycr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:45:08 INFO - Running setup.py (path:/tmp/pip-YKqS5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:45:08 INFO - Running setup.py (path:/tmp/pip-6ZYn6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:45:08 INFO - Running setup.py (path:/tmp/pip-tOvuB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:45:08 INFO - Running setup.py (path:/tmp/pip-006qoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:45:08 INFO - Running setup.py (path:/tmp/pip-9AkSp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:45:08 INFO - Running setup.py (path:/tmp/pip-UHj5MR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:45:08 INFO - Running setup.py (path:/tmp/pip-e5Busm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:08 INFO - Running setup.py (path:/tmp/pip-kTXgUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:45:08 INFO - Running setup.py (path:/tmp/pip-CVl0t0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:45:08 INFO - Running setup.py (path:/tmp/pip-MDLq5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:45:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:45:08 INFO - Running setup.py install for manifestparser 02:45:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Running setup.py install for mozcrash 02:45:09 INFO - Running setup.py install for mozdebug 02:45:09 INFO - Running setup.py install for mozdevice 02:45:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Running setup.py install for mozfile 02:45:09 INFO - Running setup.py install for mozhttpd 02:45:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Running setup.py install for mozinfo 02:45:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Running setup.py install for mozInstall 02:45:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Running setup.py install for mozleak 02:45:09 INFO - Running setup.py install for mozlog 02:45:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Running setup.py install for moznetwork 02:45:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:45:10 INFO - Running setup.py install for mozprocess 02:45:10 INFO - Running setup.py install for mozprofile 02:45:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:45:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:45:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:45:10 INFO - Running setup.py install for mozrunner 02:45:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:45:10 INFO - Running setup.py install for mozscreenshot 02:45:10 INFO - Running setup.py install for moztest 02:45:10 INFO - Running setup.py install for mozversion 02:45:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:45:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:45:10 INFO - Cleaning up... 02:45:10 INFO - Return code: 0 02:45:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:10 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 0x26621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2090>, '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 0x29d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ccf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', '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 02:45:10 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 02:45:10 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 02:45:10 INFO - Using env: {'DISPLAY': ':0', 02:45:10 INFO - 'HOME': '/home/cltbld', 02:45:10 INFO - 'LANG': 'en_US.UTF-8', 02:45:10 INFO - 'LANGUAGE': 'en_US:en', 02:45:10 INFO - 'LOGNAME': 'cltbld', 02:45:10 INFO - 'MAIL': '/var/mail/cltbld', 02:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:10 INFO - 'MOZ_NO_REMOTE': '1', 02:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:10 INFO - 'NO_EM_RESTART': '1', 02:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:10 INFO - 'PWD': '/builds/slave/test', 02:45:10 INFO - 'SHELL': '/bin/bash', 02:45:10 INFO - 'SHLVL': '1', 02:45:10 INFO - 'TERM': 'linux', 02:45:10 INFO - 'TMOUT': '86400', 02:45:10 INFO - 'USER': 'cltbld', 02:45:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', 02:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:10 INFO - '_': '/tools/buildbot/bin/python'} 02:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:45:10 INFO - Running setup.py (path:/tmp/pip-UDEDjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:45:11 INFO - Running setup.py (path:/tmp/pip-Js7ukw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:45:11 INFO - Running setup.py (path:/tmp/pip-bjD38X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:45:11 INFO - Running setup.py (path:/tmp/pip-nUx1H6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:45:11 INFO - Running setup.py (path:/tmp/pip-AG6_f9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:45:11 INFO - Running setup.py (path:/tmp/pip-0p3wLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:45:11 INFO - Running setup.py (path:/tmp/pip-Net98V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:45:11 INFO - Running setup.py (path:/tmp/pip-qF2EC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:45:11 INFO - Running setup.py (path:/tmp/pip-3Hl8g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:45:11 INFO - Running setup.py (path:/tmp/pip-yRPRUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:45:11 INFO - Running setup.py (path:/tmp/pip-D9tHjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:45:11 INFO - Running setup.py (path:/tmp/pip-OrvqOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:45:11 INFO - Running setup.py (path:/tmp/pip-35MCH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:45:11 INFO - Running setup.py (path:/tmp/pip-d8Z9cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:11 INFO - Running setup.py (path:/tmp/pip-fpEpUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:12 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)) 02:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:45:12 INFO - Running setup.py (path:/tmp/pip-FlPvk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:45:12 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)) 02:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:45:12 INFO - Running setup.py (path:/tmp/pip-lktEf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:45:12 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)) 02:45:12 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)) 02:45:12 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)) 02:45:12 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)) 02:45:12 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)) 02:45:12 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)) 02:45:12 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)) 02:45:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:45:12 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 02:45:12 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 02:45:12 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 02:45:12 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 02:45:13 INFO - Downloading blessings-1.6.tar.gz 02:45:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:45:13 INFO - Installing collected packages: blessings 02:45:13 INFO - Running setup.py install for blessings 02:45:13 INFO - Successfully installed blessings 02:45:13 INFO - Cleaning up... 02:45:13 INFO - Return code: 0 02:45:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:45:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:45:13 INFO - Reading from file tmpfile_stdout 02:45:13 INFO - Current package versions: 02:45:13 INFO - argparse == 1.2.1 02:45:13 INFO - blessings == 1.6 02:45:13 INFO - blobuploader == 1.2.4 02:45:13 INFO - docopt == 0.6.1 02:45:13 INFO - functools32 == 3.2.3-2 02:45:13 INFO - jsonschema == 2.5.1 02:45:13 INFO - manifestparser == 1.1 02:45:13 INFO - mozInstall == 1.13 02:45:13 INFO - mozcrash == 1.0 02:45:13 INFO - mozdebug == 0.1 02:45:13 INFO - mozdevice == 0.51 02:45:13 INFO - mozfile == 1.2 02:45:13 INFO - mozhttpd == 0.7 02:45:13 INFO - mozinfo == 0.10 02:45:13 INFO - mozleak == 0.1 02:45:13 INFO - mozlog == 3.5 02:45:13 INFO - moznetwork == 0.27 02:45:13 INFO - mozprocess == 0.25 02:45:13 INFO - mozprofile == 0.28 02:45:13 INFO - mozrunner == 6.13 02:45:13 INFO - mozscreenshot == 0.1 02:45:13 INFO - mozsystemmonitor == 0.3 02:45:13 INFO - moztest == 0.8 02:45:13 INFO - mozversion == 1.4 02:45:13 INFO - psutil == 3.1.1 02:45:13 INFO - requests == 1.2.3 02:45:13 INFO - wsgiref == 0.1.2 02:45:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:13 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')]} 02:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:13 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')]} 02:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:13 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 0x26621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2090>, '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 0x29d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ccf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', '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 02:45:13 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 02:45:13 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 02:45:13 INFO - Using env: {'DISPLAY': ':0', 02:45:13 INFO - 'HOME': '/home/cltbld', 02:45:13 INFO - 'LANG': 'en_US.UTF-8', 02:45:13 INFO - 'LANGUAGE': 'en_US:en', 02:45:13 INFO - 'LOGNAME': 'cltbld', 02:45:13 INFO - 'MAIL': '/var/mail/cltbld', 02:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:13 INFO - 'MOZ_NO_REMOTE': '1', 02:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:13 INFO - 'NO_EM_RESTART': '1', 02:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:13 INFO - 'PWD': '/builds/slave/test', 02:45:13 INFO - 'SHELL': '/bin/bash', 02:45:13 INFO - 'SHLVL': '1', 02:45:13 INFO - 'TERM': 'linux', 02:45:13 INFO - 'TMOUT': '86400', 02:45:13 INFO - 'USER': 'cltbld', 02:45:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', 02:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:13 INFO - '_': '/tools/buildbot/bin/python'} 02:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:13 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)) 02:45:13 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)) 02:45:13 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)) 02:45:13 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)) 02:45:13 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)) 02:45:13 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)) 02:45:13 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)) 02:45:13 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)) 02:45:13 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)) 02:45:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:45:13 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 02:45:13 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 02:45:13 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 02:45:13 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 02:45:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:45:15 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)) 02:45:15 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)) 02:45:15 INFO - Installing collected packages: simplejson 02:45:15 INFO - Running setup.py install for simplejson 02:45:15 INFO - building 'simplejson._speedups' extension 02:45:15 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 02:45:16 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 02:45:16 INFO - Successfully installed simplejson 02:45:16 INFO - Cleaning up... 02:45:16 INFO - Return code: 0 02:45:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:45:16 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')]} 02:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:16 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')]} 02:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:16 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 0x26621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2090>, '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 0x29d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ccf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', '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 02:45:16 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 02:45:16 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 02:45:16 INFO - Using env: {'DISPLAY': ':0', 02:45:16 INFO - 'HOME': '/home/cltbld', 02:45:16 INFO - 'LANG': 'en_US.UTF-8', 02:45:16 INFO - 'LANGUAGE': 'en_US:en', 02:45:16 INFO - 'LOGNAME': 'cltbld', 02:45:16 INFO - 'MAIL': '/var/mail/cltbld', 02:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:16 INFO - 'MOZ_NO_REMOTE': '1', 02:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:16 INFO - 'NO_EM_RESTART': '1', 02:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:16 INFO - 'PWD': '/builds/slave/test', 02:45:16 INFO - 'SHELL': '/bin/bash', 02:45:16 INFO - 'SHLVL': '1', 02:45:16 INFO - 'TERM': 'linux', 02:45:16 INFO - 'TMOUT': '86400', 02:45:16 INFO - 'USER': 'cltbld', 02:45:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', 02:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:16 INFO - '_': '/tools/buildbot/bin/python'} 02:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:45:16 INFO - Cleaning up... 02:45:16 INFO - Return code: 0 02:45:16 INFO - Running post-action listener: _resource_record_post_action 02:45:16 INFO - Running post-action listener: _start_resource_monitoring 02:45:16 INFO - Starting resource monitoring. 02:45:16 INFO - [mozharness: 2017-09-03 09:45:16.407957Z] Finished create-virtualenv step (success) 02:45:16 INFO - [mozharness: 2017-09-03 09:45:16.408427Z] Running install step. 02:45:16 INFO - Running pre-action listener: _resource_record_pre_action 02:45:16 INFO - Running main action method: install 02:45:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:45:16 INFO - Reading from file tmpfile_stdout 02:45:16 INFO - Detecting whether we're running mozinstall >=1.0... 02:45:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:45:16 INFO - Reading from file tmpfile_stdout 02:45:16 INFO - Output received: 02:45:16 INFO - Usage: mozinstall [options] installer 02:45:16 INFO - Options: 02:45:16 INFO - -h, --help show this help message and exit 02:45:16 INFO - -d DEST, --destination=DEST 02:45:16 INFO - Directory to install application into. [default: 02:45:16 INFO - "/builds/slave/test"] 02:45:16 INFO - --app=APP Application being installed. [default: firefox] 02:45:16 INFO - mkdir: /builds/slave/test/build/application 02:45:16 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'] 02:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:45:33 INFO - Reading from file tmpfile_stdout 02:45:33 INFO - Output received: 02:45:33 INFO - /builds/slave/test/build/application/firefox/firefox 02:45:33 INFO - Running post-action listener: _resource_record_post_action 02:45:33 INFO - [mozharness: 2017-09-03 09:45:33.262797Z] Finished install step (success) 02:45:33 INFO - [mozharness: 2017-09-03 09:45:33.263140Z] Running setup-mitmproxy step. 02:45:33 INFO - Running pre-action listener: _resource_record_pre_action 02:45:33 INFO - Running main action method: setup_mitmproxy 02:45:33 INFO - Skipping: mitmproxy is not required 02:45:33 INFO - Running post-action listener: _resource_record_post_action 02:45:33 INFO - [mozharness: 2017-09-03 09:45:33.264875Z] Finished setup-mitmproxy step (success) 02:45:33 INFO - [mozharness: 2017-09-03 09:45:33.265191Z] Running run-tests step. 02:45:33 INFO - Running pre-action listener: _resource_record_pre_action 02:45:33 INFO - Running pre-action listener: _set_gcov_prefix 02:45:33 INFO - Running main action method: run_tests 02:45:33 WARNING - Try message not found. 02:45:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:45:33 INFO - Python 2.7.3 02:45:33 INFO - Return code: 0 02:45:33 INFO - grabbing minidump binary from tooltool 02:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:33 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 0x29d2090>, '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 0x29d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ccf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:45:33 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 02:45:33 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 02:45:33 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 02:45:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:45:33 INFO - Return code: 0 02:45:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:45:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:45:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:45:33 INFO - ENV: RUST_BACKTRACE is now full 02:45:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:45:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:45:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 02:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 02:45:33 INFO - Using env: {'DISPLAY': ':0', 02:45:33 INFO - 'HOME': '/home/cltbld', 02:45:33 INFO - 'LANG': 'en_US.UTF-8', 02:45:33 INFO - 'LANGUAGE': 'en_US:en', 02:45:33 INFO - 'LOGNAME': 'cltbld', 02:45:33 INFO - 'MAIL': '/var/mail/cltbld', 02:45:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:45:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:45:33 INFO - 'MOZ_ACCELERATED': '1', 02:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:33 INFO - 'MOZ_NO_REMOTE': '1', 02:45:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:45:33 INFO - 'MOZ_WEBRENDER': '1', 02:45:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:33 INFO - 'NO_EM_RESTART': '1', 02:45:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:33 INFO - 'PWD': '/builds/slave/test', 02:45:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:45:33 INFO - 'RUST_BACKTRACE': 'full', 02:45:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:45:33 INFO - 'SHELL': '/bin/bash', 02:45:33 INFO - 'SHLVL': '1', 02:45:33 INFO - 'TERM': 'linux', 02:45:33 INFO - 'TMOUT': '86400', 02:45:33 INFO - 'USER': 'cltbld', 02:45:33 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', 02:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:33 INFO - '_': '/tools/buildbot/bin/python'} 02:45:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 02:45:33 INFO - mozversion application_buildid: 20170903085438 02:45:33 INFO - mozversion application_changeset: 37824bf5c5b08afa7e689fceb935b8f457ebd9eb 02:45:33 INFO - mozversion application_display_name: Nightly 02:45:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:45:33 INFO - mozversion application_name: Firefox 02:45:33 INFO - mozversion application_remotingname: firefox 02:45:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:45:33 INFO - mozversion application_vendor: Mozilla 02:45:33 INFO - mozversion application_version: 57.0a1 02:45:33 INFO - mozversion platform_buildid: 20170903085438 02:45:33 INFO - mozversion platform_changeset: 37824bf5c5b08afa7e689fceb935b8f457ebd9eb 02:45:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:45:33 INFO - mozversion platform_version: 57.0a1 02:45:33 INFO - using testdate: 1504431933 02:45:33 INFO - actual date: 1504431933 02:45:33 INFO - starting webserver on 'localhost:36777' 02:45:33 INFO - SUITE-START | Running 2 tests 02:45:33 INFO - TEST-START | dromaeo_css 02:45:33 INFO - Initialising browser for dromaeo_css test... 02:45:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36777/getInfo.html -profile /tmp/tmpqQRvAz/profile 02:45:33 INFO - TEST-INFO | started process 7833 (/builds/slave/test/build/application/firefox/firefox http://localhost:36777/getInfo.html) 02:45:39 INFO - TEST-INFO | 7833: exit 0 02:45:39 INFO - Browser initialized. 02:45:39 INFO - Running cycle 1/1 for dromaeo_css test... 02:45:39 INFO - Using env: {'DISPLAY': ':0', 02:45:39 INFO - 'HOME': '/home/cltbld', 02:45:39 INFO - 'JSGC_DISABLE_POISONING': '1', 02:45:39 INFO - 'LANG': 'en_US.UTF-8', 02:45:39 INFO - 'LANGUAGE': 'en_US:en', 02:45:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:45:39 INFO - 'LOGNAME': 'cltbld', 02:45:39 INFO - 'MAIL': '/var/mail/cltbld', 02:45:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:45:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:45:39 INFO - 'MOZ_ACCELERATED': '1', 02:45:39 INFO - 'MOZ_CRASHREPORTER': '1', 02:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:45:39 INFO - 'MOZ_NO_REMOTE': '1', 02:45:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:45:39 INFO - 'MOZ_WEBRENDER': '1', 02:45:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:39 INFO - 'NO_EM_RESTART': '1', 02:45:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:39 INFO - 'PWD': '/builds/slave/test', 02:45:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:45:39 INFO - 'RUST_BACKTRACE': 'full', 02:45:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:45:39 INFO - 'SHELL': '/bin/bash', 02:45:39 INFO - 'SHLVL': '1', 02:45:39 INFO - 'TERM': 'linux', 02:45:39 INFO - 'TMOUT': '86400', 02:45:39 INFO - 'USER': 'cltbld', 02:45:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', 02:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:39 INFO - '_': '/tools/buildbot/bin/python'} 02:45:39 INFO - TEST-INFO | started process 8024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqQRvAz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:40 INFO - PID 8024 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:45:40 INFO - PID 8024 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:45:40 INFO - PID 8024 | 02:45:40 INFO - PID 8024 | (/builds/slave/test/build/application/firefox/firefox:8087): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:45:40 INFO - PID 8024 | 02:45:51 INFO - PID 8024 | RSS: Main: 210259968 02:45:51 INFO - PID 8024 | 02:45:54 INFO - PID 8024 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:48:49 INFO - PID 8024 | Cycle 1(1): loaded http://localhost:36777/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36777/tests/dromaeo/cssquery-ext.html) 02:48:51 INFO - PID 8024 | RSS: Main: 219234304 02:48:51 INFO - PID 8024 | 02:51:53 INFO - PID 8024 | Cycle 1(1): loaded http://localhost:36777/tests/dromaeo/cssquery-ext.html (next: http://localhost:36777/tests/dromaeo/cssquery-jquery.html) 02:51:54 INFO - PID 8024 | RSS: Main: 218984448 02:51:54 INFO - PID 8024 | 02:54:56 INFO - PID 8024 | Cycle 1(1): loaded http://localhost:36777/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36777/tests/dromaeo/cssquery-mootools.html) 02:54:57 INFO - PID 8024 | RSS: Main: 220037120 02:54:57 INFO - PID 8024 | 02:57:59 INFO - PID 8024 | Cycle 1(1): loaded http://localhost:36777/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36777/tests/dromaeo/cssquery-prototype.html) 02:57:59 INFO - PID 8024 | RSS: Main: 217251840 02:57:59 INFO - PID 8024 | 03:01:03 INFO - PID 8024 | Cycle 1(1): loaded http://localhost:36777/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36777/tests/dromaeo/cssquery-yui.html) 03:01:04 INFO - PID 8024 | RSS: Main: 218304512 03:01:04 INFO - PID 8024 | 03:04:06 INFO - PID 8024 | Cycle 1(1): loaded http://localhost:36777/tests/dromaeo/cssquery-yui.html (next: http://localhost:36777/tests/dromaeo/cssquery-dojo.html) 03:04:06 INFO - PID 8024 | RSS: Main: 220876800 03:04:06 INFO - PID 8024 | 03:04:06 INFO - PID 8024 | __start_tp_report 03:04:06 INFO - PID 8024 | _x_x_mozilla_page_load 03:04:06 INFO - PID 8024 | _x_x_mozilla_page_load_details 03:04:06 INFO - PID 8024 | |i|pagename|runs| 03:04:06 INFO - PID 8024 | |0;dojo.html;3325.883594074208;3340.7661463697536;3364.8485818138183;3368.2758206985495;3368.4105281575726;6258.749650014005;6259.186305780254;6396.648184349859;6419.133416988711;6424.132742079818;6405.039244113385;6430.196225471816;6444.323346048668;6446.258680251773;6474.74101035958;5874.295084589845;5913.704314784265;5930.911036334458;5945.613535120204;5972.104184372335;5933.525317974573;5934.64392136471;5953.285605727318;5958.612690175147;5960.493358064569;5929.495992840613;5954.612950158247;5962.403759624024;5990.281166260055;5991.281046274453;5804.100364443476;5974.731137098797;5980.97009514954;5981.401859814006;5987.700614969234;5916;5946.167536544887;5948.851278718067;5962.3739507351975;5964.493018093467;6483;6507.154069970921;6507.544471886969;6537.215534135887;6669.23303820062;6859.07402500661;6866;6872;6977.232504424509;7008.824779380505;6716.697748601325;6857.417119544794;6858.177018757731;6868.553544019623;7020.543664661832;6426.614403135827;6449;6462.935370646281;6477.060826180177;6490.772822951174;7007.404370628554;7163.42692584592;7193.820154496179;7214.92785072153;7226;6811.080504131978;6834.965825170842;6878.759243426456;6912.688928998207;6932.584044957218;6719.260881303053;6802.319768023158;6843.692033858489;6925.861482770417;6944.479164062715;6446.709898054599;6755.49333799967;6818.318168183241;6876.931230687729;6970.825729356705;6896.379325860697;6919.619420931897;6945.548539344926;7005.754798582026;7010.614416207056;5353.437889021675;5446.482584154499;5448.291722076105;5479.397266300703;5520.447955204448;4744.217204161344;4773.809047638056;4794.017226468565;4797.928031079537;4870.342503761947;6008.459238668541;6050.6672133032225;6105.603135796159;6117.051856962178;6140.140380346755;6918.100646915868;6932.861342773217;6934.583924964418;6944.340287672663;7029.753958611424;5902.085176797603;5967;5979.701014949323;6027.156198132265;6102.206713127353;5990.520758339322;6009.849753756103;6013.00785370409;6016.398360163948;6047.7278522466595;6556;6565.934340656628;6662.034005069335;6683.097781799492;6849.2465828758795;6726.8654626908165;6735.360140786617;6767.526273160832;6772.153480814898;6777.45780337562;6505.186851643544;6577.177852768404;6583.275839657538;6591.835204119743;6620.8344791380605;6675.265720770614;6676.632785196861;6687.264400915993;6687.899681504879;6694.196696396463;6850.45196384298;6862.553933994474;6962;6993.580385176906;7062.117235345582;6684.4318232950745;6722.798316050526;6820.4202642773935;6824.385805277549;6834.897476537756;6482.935170648422;6652.966735166293;6706.731730730716;6720.294369091371;6812.318768123148;6551.836204094745;6576.046473261446;6584.76953306632;6600.141981542369;6604.240512341143;6606.8017959461295;6643.734250629921;6704.430123439367;6722.563033402813;6774.119364482585;6493.935060649522;6496.935030649822;6598.274189839018;6600.372964568358;6674.065630811593 03:04:06 INFO - PID 8024 | |1;ext.html;797.1789057271011;825.1253671108625;1028.382970217869;1095.6986828622128;1238.9132760706755;38316.80841595795;39357.60642393575;39792.403113953274;39874.2025159497;40013;36195.819020904855;36537.63462365376;36736.63263367365;36761.816190919075;36962;7631.2368763123795;7828.530288182699;7838.216178382173;7848.13670496245;7888.842223155533;7650.234976502333;7796.259355361231;7804.60976951153;7816.374690024784;7816.687332506693;7751.069871615414;7760.06879174497;7796.376289896823;7800.570968596753;7854.764357069297;7788.571628560427;7804.804879877992;7815.960920195391;7823.765287041398;7857.1357150713375;7732.226777322279;7782.571958542278;7788.221177882223;7788.571628560427;7793.649285782153;36898.8155059223;37117.257654846755;37199.81400092982;37395.62604373949;37426.8128659355;3513.9824300878586;3533.169705119295;3545.06055895188;3545.574531056264;3568.2506673598577;31483.685163148304;31527;31537;31586.36827263465;31646.841765791025;4994.101061808873;5162.22566615007;5182.559482443997;5226.189940559181;5249.86875328116;181525.0923745386;181533;181777;182475;185969;42395.7880210597;48685.513144868804;49027.50972490301;49228.50771492311;49295.02819887236;50573.24140137901;51372.22941655878;51437.7428112857;51500.742496287276;51617.225741613904;15959.36162553508;16076.115813630362;16088;16091;16101.11443870575;13121.475140994444;13268.867311326763;13277.867221327857;13291.534796282083;13300.201987880759;13750.312484375741;13863.653408664864;13910.374033168531;14075.71848563023;14090.577282681536;5603.3836278009385;5626.943730562642;5651.237082993744;5723.084306511021;5730.799422020209;985.280745056113;995.2833959549258;997.436448406648;1001.2140469731225;1015.3856916565519;22657.206997754998;22818;22892.313230603108;22925.88537057304;23035.769642303698;1098.4727330881221;1104.4974536585835;1110.5668789172069;1125.2573301620891;1128.5260190719753;11924.224925379822;12207.45066471993;12255.203411778206;12342.382880856101;12361.93819030899;228315;228562;228753;229722;229903;51341.486585134415;51601.741991289804;51672.22491662628;51706.48293517017;51837.48162518402;1425.736238795826;1453.3895763779237;1456.3082535795413;1463.3561233057421;1473.1823837769925;22489.43776405603;22810.65784013208;22846.31461056171;22891.716629142997;22945.426364340357;36684.81657591802;36845.63154368422;37074.258514829016;37117.25765484729;37132;192710;194353;194472;194607;194712;29649.110526684235;29771.70228297776;31254.21864453407;33996.49005264972;34160.65839341674;41803.79098104611;41859.372109417774;42301.57698422977;42944.35583466313;43312.350314744675;30694.84652576723;30780.53829192609;31301.373972520876;31317.53023704601;31637.683623163473;30907.690923090482;31242.281674507212;31338.21654458657;31347.84326078355;31422.52866206963;34796.82601586976;37436.812815935744;37839.24321513609;37953.2409351817;38220.80889595534;32635.020949371556;32970.835145824116;33048.834755826065;33577.49633755447;34159.4876076864;24814.627780582945;24843.130490432748;25127.49745005053;25340.493190135727;25777.097801576856 03:04:06 INFO - PID 8024 | |2;jquery.html;567.9261695979523;572.2503520388289;573.260493962788;579.4697851465909;587.4712758517334;22259.777402225973;22950;22971.310860674184;23030.88484557579;23067.42331441715;23962.28113156608;26046;26085.608715869228;26210;26242.47515049698;6598.142241508609;6765.12053433053;6765.32346765322;6782.389584937355;6789.490788190881;6039.305479869805;6544.411003009728;6553.410193082622;6573.342665733412;6592.6703664816805;6599.67001649918;6620.966895165518;6624.867502649944;6638.203415590136;6642.667866606675;6614.636195009272;6616.338366163345;6625.304343043959;6635.402813746762;6639.103720997676;6110.144579758838;6161.568690191689;6171.475424588915;6183.81448556544;6191.25704915413;27798.444031119467;28945.42109157805;29047;29391.706082939112;29608.703912961024;2070.171931227521;2096.6540520814046;2097.465146387661;2098.181709133439;2104.400245929918;19367.418977430698;20050.298239561693;20058.699119513218;20095.89952050245;20121.195152193894;2433.0875921529428;2458.791002764767;2484.6645702830247;2518.244526642;2525.5580273452074;133793;135435.32282338524;135973;136891;136943;13722.794158087636;14601.269936503133;14602.882582025546;14667.853321466862;14897.467430536835;22877.428064298194;23093.422664433187;23148.726820024724;23149;23257.18599848997;9868.309218354647;9924.652637157666;10073.992600739868;10205.591776328863;10223;9355.345125841262;9437.103475169848;9516.809663806824;9562.665306714232;9597.280203984728;7623.8069062016775;8879.733607991771;8970.641174352953;9166.908330916605;9288.210502107262;2556.7443255674284;2563.782078523309;2631.8420894746378;2662.9600555991674;2710.671770832278;929.6142101028133;935.9812803744023;945.7541039329824;966.6230170233614;984.1142971325864;19183.32858349951;19416.8058319415;19562;19641.705374419395;20012.59974800525;1033.4987531047436;1038.402918321968;1042.8227201375785;1050.4800123938699;1054.146141625286;10672.30630009047;10868.456577171268;10936.507857146447;10948.890511094947;10979.83530247047;474626;483123;484314;501213;501310;121488;123300;124293.37853310676;124343;125722;1132.4620805117504;1165.7785020846013;1189.6133756529164;1193.4689063366893;1195.0797885628017;16804.915975420045;16818.747718784474;17059.402920897708;17667.293308267526;17673.911630441766;53977;54655.72672136614;55839;56368.718156408955;56461.435385645615;76646.23353766391;77450.6127469359;77487;77572;79176;13848.238346891017;14105.929470352583;14126.78809817874;14363.856361436252;14398.352074156479;21762.238321658668;21875.234366797085;21882.562348752617;22206.777932221117;22286;17690.91154544219;18057.729134062738;18132.546686332946;18192.99938503395;18297.634047319247;15738.291776870297;15830.129342886252;16146.515604531884;16363.2636531354;16383.918080409521;17948.37180698669;18795;18870.905645471685;18875.6224875499;18892.149853256913;14366.209858457885;14400.351984160528;14400.42398304056;14404.639884002983;14416.567502974927;17034.829651703323;17513.03678297706;17844.464666060037;17857.553561161076;17899 03:04:06 INFO - PID 8024 | |3;mootools.html;1323.1201251167975;1367.9822262163311;1370.212128026385;1384.335518950903;1385.0443194196005;14844.628884277885;15655.843441565596;15665.84334156658;15712.764308535381;15722.606934826606;14848;15908.204589770494;15925.840741592581;15952.282147303371;16011.199440028011;2645.5238057149754;2687.220705995259;2712.606672032564;2712.742289482496;2716.9184924452297;2620.397308619019;2713.782897368216;2760.4479104179145;2774.4867199568043;2776.0422654184376;2762.8066035377533;2801.9299517512122;2807.199948014816;2808.0593001344573;2810.297425643589;2521.8991240350365;2580.367809886571;2596.013514864349;2611.7257687942683;2617.018618018243;2656.627432307094;2681.182239416977;2682.9195124146113;2697.339151907795;2705.391286960438;14908.70182596342;15143.848561514464;15156.545303640909;15189.468368607157;15222.771658425132;7838.686452541891;8135.145809690016;8141.918580814176;8173.918260817375;8204.671813127468;5034.622403319729;5144;5174.404943431516;5326.573874090063;5340.198970154469;1965.626530959113;1979.8614097013215;1983.7123617075442;2023.6964455331818;2026.3110542415502;27061.323466913287;27432.451350972868;27446;27455.313617159532;27503.587446188325;7115.466340024519;7200.963995179991;7362.595057271901;7430.071241094864;7443.627818609048;17533.21100550478;17617.647647046986;17706.5573360667;17743.55641108957;17786.91106544459;7810.921890781019;7916.960415197887;7982.321502672222;7995.360371170409;8015.599220039091;7358.595277259802;7379.88930166048;7398.593077380796;7452.993845830852;7504.437167212372;4774.594159496412;5014.498550145029;5044.873878153002;5055.545000949932;5060.063888180698;1318.5978276625528;1357.8206977800685;1422.118286662276;1423.59427563144;1470.522080323899;863.4732812984074;876.145757886056;897.1253028297358;903.3902116071625;906.859436787299;8249.257566819015;8417.284530814826;8616.956915215384;8674.6530138795;8892;988.7972965542046;1001.7896241789306;1002.6691191906799;1013.5489707080426;1016.9389836609827;4771.308160316735;5049.091163590516;5131.7690703918415;5236.842894713165;5429.67421954684;20582.176712931614;21992.120315187534;22121.33635990923;22141.66787498189;22230.444238894157;21492.462688432603;21587.67618485724;22299.554008920055;22383.32850014502;22596.66105008426;11571.884281157081;11757.706057348463;11795.882041179479;11903.523859045714;11976.041916646822;8450.957745211235;8571.95714021426;8578.571071446528;8598.871016934876;8657.091005444337;18493.90753046226;18849.434516964513;19092.618147637248;19267.22931082741;19778.50553736168;19368.709469357687;19378.224871005;19398.321058762875;19479.61040779205;19601.509962251057;11094.334339939629;11110.388928608681;11181.832272516082;11200;11235.213535052795;13390.866091339352;13398.26309552945;13530.052896297164;13533.120347177795;13557.728845423233;10453.68638940833;10735.624253151102;10772.461376931278;10805.405702686428;11083.334999900031;10494.580216791242;10661.466926653482;10661.733456663645;10767;10918.454077296263;10221.9488902555;10320.948395257976;10342.37945723229;10348.482575871025;10456.268061235945;7004.229534751275;7070.7525236616475;7077.5399599025895;7158.749443769443;7204.53170543913;6866.931330686629;6951.965240173767;6956;6978.825529361807;7008.334208250412 03:04:06 INFO - PID 8024 | |4;prototype.html;502.44981744989224;509.3047989494339;530.1993989076498;534.684536123687;536.5653820405472;6458.354164583539;6459.545372758357;6495.480361571074;6544.051112588678;6554.6067235965875;6198.59709118907;6346.936530634693;6374.087773667904;6389.744410223586;6419.5506314558;5102.081625307444;5112.923306150411;5153.3558305211845;5214.634975551713;5221.921671174935;5091.134507133796;5112.335396398463;5120.92318615221;5127.717975511346;5168.8707782305555;4900.6920328778115;4994.525520075587;5018.222175562793;5083.18669012958;5121.743912804345;4939.827106051271;5067.797288108472;5122.8207012754565;5127.717975511346;5144.845654630349;4493.955060449386;4515.593596576324;4522.7286362818;4554.590086892195;4600.884977875547;6112.63324200545;6159.538034647419;6189.907151392733;6209.677822365058;6284.465820405271;5806.970965145189;5834.97082514589;5849.707514624251;5882.147088672119;5917.644941303535;6713.597184168965;6762.2469529411155;6769.661516924134;6787.524873258873;6816.7614133505085;4929.3345398371475;4960.296638332117;4961.181405068195;4963.255511673242;4968.577670897978;7003.439724822053;7069;7083.362497375261;7108.928910710878;7171.318724721144;5146.768395422215;5156.974215128976;5157.742112894415;5197.154105961637;5198.9740051299505;5194.8961020780125;5196.246544251138;5211.973940130275;5215.426303106655;5265.578753699695;5710.371859095496;5798;5807.651540907559;5836.153757705194;5841.853953651193;6685.164354455693;6767.154105736783;6779.15260592426;6797.898031529531;6816.147981502312;1679.6724638695582;1731.5065206416111;1759.4018033868547;1785.0628420079563;1790.7045337519423;1189.9107566932341;1228.9078319126102;1253.3419954523947;1253.9749205015848;1254.4668515880896;5868.501177399883;5925.318588362394;5949.196858424144;5949.434803693643;5961;6612.603243805387;6716.529842911047;6736.292689267654;6740.573393578308;6891.620960847202;5879.882402351929;5934.3383852521365;5977.402259773988;5988.461038506555;6064.787732429432;3641.7997010164167;3651.397519409321;3665.8533658653355;3705.7405981581032;3713.962860371416;6634.7393995140765;6726.159230096238;6749.966250168816;6797.932020679828;6806.659667016629;7107.253738357502;7156.24859389767;7164.101513099033;7181.210066892638;7208.711651533985;6593.505487088488;6614.768483103068;6620.139381880324;6662.467002639681;6715.966420167868;6717.865642687021;6746.898796517958;6825.69284382194;6883.242843287134;7019.894701579583;6811.8978215325815;6851.45188384938;6860.0791778302155;6863.794086177422;6895.5173137879865;6650.700718467584;6651.467882569286;6677.499187561049;6698.263191049078;6767.796966090828;5062.620303477328;5082.695038297714;5120.411152717336;5148;5161.174212126042;6865.485088618274;6904.723811047703;6967.467157225605;7032.5077244592385;7056.6471676417;6586.176727909012;6642.900356494753;6646.202455705346;6704.463642908653;6719.563228390139;6636.469082473487;6749.865002700017;6777.322267773183;6821.8635627286185;6841.692123854339;6342.431315317304;6541.934580654132;6662.137319159109;6744.62904540255;6798.830029249309;6294.685265736786;6727.562708423937;6740.39336459721;6763.5941843489545;6814.659267036727;6433.29233784274;6487.935120648733;6493.805185844432;6507.544471886922;6523.151990241238 03:04:06 INFO - PID 8024 | |5;yui.html;888.4802390601498;908.4821651658553;910.9362344635877;911.8313112074271;943.052232506331;18517;19630.803691963076;19676.90161549192;19722.802771972278;22610.434739131488;20974.89512552439;21412.14351425945;21541;21559.892200539016;21631.45921351963;980.6126580000913;988.990110098897;997.0378584665796;998.2363491928644;999.145730400508;984.4782265399314;994.2940512236285;998.1465846701075;998.4907697074508;1000.6447711062577;950.553239977213;981.7545613596601;1030.263361696387;1036.5076588620382;1043.8590790243295;1018.7453136715822;1027.6505987964129;1028.228828378716;1029.7322696098993;1029.860968769214;740.677805154754;742.9777106686809;745.7054463486946;746.3879618712658;749.2881762325812;19579.11893964775;19709.704354434696;19724.704129437927;19960.201591936304;20229.797702023086;19685.606287874307;20173.899130504255;20422.69365959512;20598.897005515028;20633.277835275843;17190.1404929753;17211.139443027798;17212.741808872877;17423.21595528204;17502.649947001115;3673.559172899269;3709;3712.6472985066375;3720.9441858372147;3730.4404339349044;127110;127838;132762.3361883194;133818;134915;15891.761623575656;16220;16310.184490775413;16397.67204655924;16866.831331686528;30037.549436758465;30698.386032279228;30716.232094197378;30746;31830.04509864708;7636.923630763621;7949.523028618301;8757.080506546848;9300.8604870927;9510.09654082861;4343.370211319341;4433.202023635712;4461.531539188403;4461.843835465743;4469.642428605704;5332.626716129834;5465.207544906046;5471.288732464834;5774.451427114417;5949.970250148722;1061.8991195836384;1073.7637719701654;1075.198976762317;1086.9347839129678;1089.096050278283;634.1470721879065;659.9538032337787;661.6823924516259;665.0788657709107;676.3202981004059;12046.939765301116;12251.32617706017;12929.676758080936;13325.200487970753;13710.108842925178;644.2108417188906;645.5448908519483;654.6432194453939;655.8458762190882;659.1694464974167;5648.096304591246;5679.176519404663;5730.7421166047625;5770.884582308414;5814.3313518945015;112110;112830.43584782188;115516;115872.42063789627;117481;100176.49911750395;102166;103711;104412;105075.4746226264;87131.56434217788;89502;89568.10431895728;90119;91674.54162729143;10545.789084218426;10569.312994655324;10585.665515362636;10608.787824243625;10888.18338624622;41495;41765.58234417617;43594.56405436032;43701.34447983346;43857.56142438662;53419.19871202013;53759.462405375445;54552.45447545474;54814.45185548093;54816.45183548273;14960;15394.538163855103;15523.922380388025;15544.145072021147;15791.763123553386;17502;17629.382971595933;17810.821891780917;17927.19327630286;17995.460136195936;19737.506562336057;19874;20198.39404817858;20326.390208293775;20758.688619670414;18913.810861891205;19256.518587034876;19680.803191967898;19851.205951761767;20251.18995240174;18483.90758046255;19557.31549395764;19749.60500790005;20286;20561.79438205599;13230.867691323348;13557.186568805902;13575.592732218049;13670;13909.513167039106;13733.45066197341;14030.719385612434;14088.859111408754;14156.787648185491;14196.43214271459 03:04:06 INFO - PID 8024 | __end_tp_report 03:04:06 INFO - PID 8024 | __start_cc_report 03:04:06 INFO - PID 8024 | _x_x_mozilla_cycle_collect,345 03:04:06 INFO - PID 8024 | __end_cc_report 03:04:06 INFO - PID 8024 | __startTimestamp1504433046583__endTimestamp 03:04:06 INFO - PID 8024 | 03:04:06 INFO - PID 8024 | ------- Summary: start ------- 03:04:06 INFO - PID 8024 | Number of tests: 6 03:04:06 INFO - PID 8024 | 03:04:06 INFO - PID 8024 | [#0] dojo.html Cycles:165 Average:6348.23 Median:6576.05 stddev:730.08 (11.1%) stddev-sans-first:692.75 03:04:06 INFO - PID 8024 | Values: 3325.9 3340.8 3364.8 3368.3 3368.4 6258.7 6259.2 6396.6 6419.1 6424.1 6405.0 6430.2 6444.3 6446.3 6474.7 5874.3 5913.7 5930.9 5945.6 5972.1 5933.5 5934.6 5953.3 5958.6 5960.5 5929.5 5954.6 5962.4 5990.3 5991.3 5804.1 5974.7 5981.0 5981.4 5987.7 5916.0 5946.2 5948.9 5962.4 5964.5 6483.0 6507.2 6507.5 6537.2 6669.2 6859.1 6866.0 6872.0 6977.2 7008.8 6716.7 6857.4 6858.2 6868.6 7020.5 6426.6 6449.0 6462.9 6477.1 6490.8 7007.4 7163.4 7193.8 7214.9 7226.0 6811.1 6835.0 6878.8 6912.7 6932.6 6719.3 6802.3 6843.7 6925.9 6944.5 6446.7 6755.5 6818.3 6876.9 6970.8 6896.4 6919.6 6945.5 7005.8 7010.6 5353.4 5446.5 5448.3 5479.4 5520.4 4744.2 4773.8 4794.0 4797.9 4870.3 6008.5 6050.7 6105.6 6117.1 6140.1 6918.1 6932.9 6934.6 6944.3 7029.8 5902.1 5967.0 5979.7 6027.2 6102.2 5990.5 6009.8 6013.0 6016.4 6047.7 6556.0 6565.9 6662.0 6683.1 6849.2 6726.9 6735.4 6767.5 6772.2 6777.5 6505.2 6577.2 6583.3 6591.8 6620.8 6675.3 6676.6 6687.3 6687.9 6694.2 6850.5 6862.6 6962.0 6993.6 7062.1 6684.4 6722.8 6820.4 6824.4 6834.9 6482.9 6653.0 6706.7 6720.3 6812.3 6551.8 6576.0 6584.8 6600.1 6604.2 6606.8 6643.7 6704.4 6722.6 6774.1 6493.9 6496.9 6598.3 6600.4 6674.1 03:04:06 INFO - PID 8024 | 03:04:06 INFO - PID 8024 | [#1] ext.html Cycles:180 Average:36937.17 Median:19155.40 stddev:52517.77 (274.2%) stddev-sans-first:52594.98 03:04:06 INFO - PID 8024 | Values: 797.2 825.1 1028.4 1095.7 1238.9 38316.8 39357.6 39792.4 39874.2 40013.0 36195.8 36537.6 36736.6 36761.8 36962.0 7631.2 7828.5 7838.2 7848.1 7888.8 7650.2 7796.3 7804.6 7816.4 7816.7 7751.1 7760.1 7796.4 7800.6 7854.8 7788.6 7804.8 7816.0 7823.8 7857.1 7732.2 7782.6 7788.2 7788.6 7793.6 36898.8 37117.3 37199.8 37395.6 37426.8 3514.0 3533.2 3545.1 3545.6 3568.3 31483.7 31527.0 31537.0 31586.4 31646.8 4994.1 5162.2 5182.6 5226.2 5249.9 181525.1 181533.0 181777.0 182475.0 185969.0 42395.8 48685.5 49027.5 49228.5 49295.0 50573.2 51372.2 51437.7 51500.7 51617.2 15959.4 16076.1 16088.0 16091.0 16101.1 13121.5 13268.9 13277.9 13291.5 13300.2 13750.3 13863.7 13910.4 14075.7 14090.6 5603.4 5626.9 5651.2 5723.1 5730.8 985.3 995.3 997.4 1001.2 1015.4 22657.2 22818.0 22892.3 22925.9 23035.8 1098.5 1104.5 1110.6 1125.3 1128.5 11924.2 12207.5 12255.2 12342.4 12361.9 228315.0 228562.0 228753.0 229722.0 229903.0 51341.5 51601.7 51672.2 51706.5 51837.5 1425.7 1453.4 1456.3 1463.4 1473.2 22489.4 22810.7 22846.3 22891.7 22945.4 36684.8 36845.6 37074.3 37117.3 37132.0 192710.0 194353.0 194472.0 194607.0 194712.0 29649.1 29771.7 31254.2 33996.5 34160.7 41803.8 41859.4 42301.6 42944.4 43312.4 30694.8 30780.5 31301.4 31317.5 31637.7 30907.7 31242.3 31338.2 31347.8 31422.5 34796.8 37436.8 37839.2 37953.2 38220.8 32635.0 32970.8 33048.8 33577.5 34159.5 24814.6 24843.1 25127.5 25340.5 25777.1 03:04:06 INFO - PID 8024 | 03:04:06 INFO - PID 8024 | [#2] jquery.html Cycles:180 Average:34926.17 Median:22960.66 stddev:82680.67 (360.1%) stddev-sans-first:82872.36 03:04:06 INFO - PID 8024 | Values: 567.9 572.3 573.3 579.5 587.5 22259.8 22950.0 22971.3 23030.9 23067.4 23962.3 26046.0 26085.6 26210.0 26242.5 6598.1 6765.1 6765.3 6782.4 6789.5 6039.3 6544.4 6553.4 6573.3 6592.7 6599.7 6621.0 6624.9 6638.2 6642.7 6614.6 6616.3 6625.3 6635.4 6639.1 6110.1 6161.6 6171.5 6183.8 6191.3 27798.4 28945.4 29047.0 29391.7 29608.7 2070.2 2096.7 2097.5 2098.2 2104.4 19367.4 20050.3 20058.7 20095.9 20121.2 2433.1 2458.8 2484.7 2518.2 2525.6 133793.0 135435.3 135973.0 136891.0 136943.0 13722.8 14601.3 14602.9 14667.9 14897.5 22877.4 23093.4 23148.7 23149.0 23257.2 9868.3 9924.7 10074.0 10205.6 10223.0 9355.3 9437.1 9516.8 9562.7 9597.3 7623.8 8879.7 8970.6 9166.9 9288.2 2556.7 2563.8 2631.8 2663.0 2710.7 929.6 936.0 945.8 966.6 984.1 19183.3 19416.8 19562.0 19641.7 20012.6 1033.5 1038.4 1042.8 1050.5 1054.1 10672.3 10868.5 10936.5 10948.9 10979.8 474626.0 483123.0 484314.0 501213.0 501310.0 121488.0 123300.0 124293.4 124343.0 125722.0 1132.5 1165.8 1189.6 1193.5 1195.1 16804.9 16818.7 17059.4 17667.3 17673.9 53977.0 54655.7 55839.0 56368.7 56461.4 76646.2 77450.6 77487.0 77572.0 79176.0 13848.2 14105.9 14126.8 14363.9 14398.4 21762.2 21875.2 21882.6 22206.8 22286.0 17690.9 18057.7 18132.5 18193.0 18297.6 15738.3 15830.1 16146.5 16363.3 16383.9 17948.4 18795.0 18870.9 18875.6 18892.1 14366.2 14400.4 14400.4 14404.6 14416.6 17034.8 17513.0 17844.5 17857.6 17899.0 03:04:06 INFO - PID 8024 | 03:04:06 INFO - PID 8024 | [#3] mootools.html Cycles:180 Average:9431.90 Median:2588.19 stddev:6838.11 (264.2%) stddev-sans-first:6830.15 03:04:06 INFO - PID 8024 | Values: 1323.1 1368.0 1370.2 1384.3 1385.0 14844.6 15655.8 15665.8 15712.8 15722.6 14848.0 15908.2 15925.8 15952.3 16011.2 2645.5 2687.2 2712.6 2712.7 2716.9 2620.4 2713.8 2760.4 2774.5 2776.0 2762.8 2801.9 2807.2 2808.1 2810.3 2521.9 2580.4 2596.0 2611.7 2617.0 2656.6 2681.2 2682.9 2697.3 2705.4 14908.7 15143.8 15156.5 15189.5 15222.8 7838.7 8135.1 8141.9 8173.9 8204.7 5034.6 5144.0 5174.4 5326.6 5340.2 1965.6 1979.9 1983.7 2023.7 2026.3 27061.3 27432.5 27446.0 27455.3 27503.6 7115.5 7201.0 7362.6 7430.1 7443.6 17533.2 17617.6 17706.6 17743.6 17786.9 7810.9 7917.0 7982.3 7995.4 8015.6 7358.6 7379.9 7398.6 7453.0 7504.4 4774.6 5014.5 5044.9 5055.5 5060.1 1318.6 1357.8 1422.1 1423.6 1470.5 863.5 876.1 897.1 903.4 906.9 8249.3 8417.3 8617.0 8674.7 8892.0 988.8 1001.8 1002.7 1013.5 1016.9 4771.3 5049.1 5131.8 5236.8 5429.7 20582.2 21992.1 22121.3 22141.7 22230.4 21492.5 21587.7 22299.6 22383.3 22596.7 11571.9 11757.7 11795.9 11903.5 11976.0 8451.0 8572.0 8578.6 8598.9 8657.1 18493.9 18849.4 19092.6 19267.2 19778.5 19368.7 19378.2 19398.3 19479.6 19601.5 11094.3 11110.4 11181.8 11200.0 11235.2 13390.9 13398.3 13530.1 13533.1 13557.7 10453.7 10735.6 10772.5 10805.4 11083.3 10494.6 10661.5 10661.7 10767.0 10918.5 10221.9 10320.9 10342.4 10348.5 10456.3 7004.2 7070.8 7077.5 7158.7 7204.5 6866.9 6952.0 6956.0 6978.8 7008.3 03:04:06 INFO - PID 8024 | 03:04:06 INFO - PID 8024 | [#4] prototype.html Cycles:180 Average:5656.42 Median:6289.58 stddev:1596.86 (25.4%) stddev-sans-first:1553.77 03:04:06 INFO - PID 8024 | Values: 502.4 509.3 530.2 534.7 536.6 6458.4 6459.5 6495.5 6544.1 6554.6 6198.6 6346.9 6374.1 6389.7 6419.6 5102.1 5112.9 5153.4 5214.6 5221.9 5091.1 5112.3 5120.9 5127.7 5168.9 4900.7 4994.5 5018.2 5083.2 5121.7 4939.8 5067.8 5122.8 5127.7 5144.8 4494.0 4515.6 4522.7 4554.6 4600.9 6112.6 6159.5 6189.9 6209.7 6284.5 5807.0 5835.0 5849.7 5882.1 5917.6 6713.6 6762.2 6769.7 6787.5 6816.8 4929.3 4960.3 4961.2 4963.3 4968.6 7003.4 7069.0 7083.4 7108.9 7171.3 5146.8 5157.0 5157.7 5197.2 5199.0 5194.9 5196.2 5212.0 5215.4 5265.6 5710.4 5798.0 5807.7 5836.2 5841.9 6685.2 6767.2 6779.2 6797.9 6816.1 1679.7 1731.5 1759.4 1785.1 1790.7 1189.9 1228.9 1253.3 1254.0 1254.5 5868.5 5925.3 5949.2 5949.4 5961.0 6612.6 6716.5 6736.3 6740.6 6891.6 5879.9 5934.3 5977.4 5988.5 6064.8 3641.8 3651.4 3665.9 3705.7 3714.0 6634.7 6726.2 6750.0 6797.9 6806.7 7107.3 7156.2 7164.1 7181.2 7208.7 6593.5 6614.8 6620.1 6662.5 6716.0 6717.9 6746.9 6825.7 6883.2 7019.9 6811.9 6851.5 6860.1 6863.8 6895.5 6650.7 6651.5 6677.5 6698.3 6767.8 5062.6 5082.7 5120.4 5148.0 5161.2 6865.5 6904.7 6967.5 7032.5 7056.6 6586.2 6642.9 6646.2 6704.5 6719.6 6636.5 6749.9 6777.3 6821.9 6841.7 6342.4 6541.9 6662.1 6744.6 6798.8 6294.7 6727.6 6740.4 6763.6 6814.7 6433.3 6487.9 6493.8 6507.5 6523.2 03:04:06 INFO - PID 8024 | 03:04:06 INFO - PID 8024 | [#5] yui.html Cycles:180 Average:23943.60 Median:20268.59 stddev:33003.02 (162.8%) stddev-sans-first:33050.20 03:04:06 INFO - PID 8024 | Values: 888.5 908.5 910.9 911.8 943.1 18517.0 19630.8 19676.9 19722.8 22610.4 20974.9 21412.1 21541.0 21559.9 21631.5 980.6 989.0 997.0 998.2 999.1 984.5 994.3 998.1 998.5 1000.6 950.6 981.8 1030.3 1036.5 1043.9 1018.7 1027.7 1028.2 1029.7 1029.9 740.7 743.0 745.7 746.4 749.3 19579.1 19709.7 19724.7 19960.2 20229.8 19685.6 20173.9 20422.7 20598.9 20633.3 17190.1 17211.1 17212.7 17423.2 17502.6 3673.6 3709.0 3712.6 3720.9 3730.4 127110.0 127838.0 132762.3 133818.0 134915.0 15891.8 16220.0 16310.2 16397.7 16866.8 30037.5 30698.4 30716.2 30746.0 31830.0 7636.9 7949.5 8757.1 9300.9 9510.1 4343.4 4433.2 4461.5 4461.8 4469.6 5332.6 5465.2 5471.3 5774.5 5950.0 1061.9 1073.8 1075.2 1086.9 1089.1 634.1 660.0 661.7 665.1 676.3 12046.9 12251.3 12929.7 13325.2 13710.1 644.2 645.5 654.6 655.8 659.2 5648.1 5679.2 5730.7 5770.9 5814.3 112110.0 112830.4 115516.0 115872.4 117481.0 100176.5 102166.0 103711.0 104412.0 105075.5 87131.6 89502.0 89568.1 90119.0 91674.5 10545.8 10569.3 10585.7 10608.8 10888.2 41495.0 41765.6 43594.6 43701.3 43857.6 53419.2 53759.5 54552.5 54814.5 54816.5 14960.0 15394.5 15523.9 15544.1 15791.8 17502.0 17629.4 17810.8 17927.2 17995.5 19737.5 19874.0 20198.4 20326.4 20758.7 18913.8 19256.5 19680.8 19851.2 20251.2 18483.9 19557.3 19749.6 20286.0 20561.8 13230.9 13557.2 13575.6 13670.0 13909.5 13733.5 14030.7 14088.9 14156.8 14196.4 03:04:06 INFO - PID 8024 | -------- Summary: end -------- 03:04:06 INFO - PID 8024 | 03:04:07 INFO - TEST-INFO | 8024: exit 0 03:04:07 INFO - TEST-OK | dromaeo_css | took 1113857ms 03:04:07 INFO - TEST-START | kraken 03:04:07 INFO - Initialising browser for kraken test... 03:04:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36777/getInfo.html -profile /tmp/tmpJ0KXkl/profile 03:04:07 INFO - TEST-INFO | started process 8413 (/builds/slave/test/build/application/firefox/firefox http://localhost:36777/getInfo.html) 03:04:12 INFO - TEST-INFO | 8413: exit 0 03:04:12 INFO - Browser initialized. 03:04:12 INFO - Running cycle 1/1 for kraken test... 03:04:12 INFO - Using env: {'DISPLAY': ':0', 03:04:12 INFO - 'HOME': '/home/cltbld', 03:04:12 INFO - 'JSGC_DISABLE_POISONING': '1', 03:04:12 INFO - 'LANG': 'en_US.UTF-8', 03:04:12 INFO - 'LANGUAGE': 'en_US:en', 03:04:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:04:12 INFO - 'LOGNAME': 'cltbld', 03:04:12 INFO - 'MAIL': '/var/mail/cltbld', 03:04:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:04:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:04:12 INFO - 'MOZ_ACCELERATED': '1', 03:04:12 INFO - 'MOZ_CRASHREPORTER': '1', 03:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:04:12 INFO - 'MOZ_NO_REMOTE': '1', 03:04:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:04:12 INFO - 'MOZ_WEBRENDER': '1', 03:04:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:12 INFO - 'NO_EM_RESTART': '1', 03:04:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:12 INFO - 'PWD': '/builds/slave/test', 03:04:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:04:12 INFO - 'RUST_BACKTRACE': 'full', 03:04:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:04:12 INFO - 'SHELL': '/bin/bash', 03:04:12 INFO - 'SHLVL': '1', 03:04:12 INFO - 'TERM': 'linux', 03:04:12 INFO - 'TMOUT': '86400', 03:04:12 INFO - 'USER': 'cltbld', 03:04:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217', 03:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:12 INFO - '_': '/tools/buildbot/bin/python'} 03:04:12 INFO - TEST-INFO | started process 8606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ0KXkl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:04:13 INFO - PID 8606 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:04:14 INFO - PID 8606 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:04:14 INFO - PID 8606 | 03:04:14 INFO - PID 8606 | (/builds/slave/test/build/application/firefox/firefox:8668): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:04:14 INFO - PID 8606 | 03:04:24 INFO - PID 8606 | RSS: Main: 209887232 03:04:24 INFO - PID 8606 | 03:04:27 INFO - PID 8606 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36777/tests/kraken/driver.html?testName=audio-beat-detection) 03:04:28 INFO - PID 8606 | RSS: Main: 215166976 03:04:28 INFO - PID 8606 | 03:04:30 INFO - PID 8606 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36777/tests/kraken/driver.html?testName=audio-dft) 03:04:31 INFO - PID 8606 | RSS: Main: 216997888 03:04:31 INFO - PID 8606 | 03:04:34 INFO - PID 8606 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36777/tests/kraken/driver.html?testName=audio-fft) 03:04:35 INFO - PID 8606 | RSS: Main: 210493440 03:04:35 INFO - PID 8606 | 03:04:37 INFO - PID 8606 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36777/tests/kraken/driver.html?testName=audio-oscillator) 03:04:38 INFO - PID 8606 | RSS: Main: 211345408 03:04:38 INFO - PID 8606 | 03:04:40 INFO - PID 8606 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36777/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:04:40 INFO - PID 8606 | RSS: Main: 211238912 03:04:40 INFO - PID 8606 | 03:04:44 INFO - PID 8606 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36777/tests/kraken/driver.html?testName=imaging-darkroom) 03:04:44 INFO - PID 8606 | RSS: Main: 213983232 03:04:44 INFO - PID 8606 | 03:04:48 INFO - PID 8606 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36777/tests/kraken/driver.html?testName=imaging-desaturate) 03:04:48 INFO - PID 8606 | RSS: Main: 213282816 03:04:48 INFO - PID 8606 | 03:04:51 INFO - PID 8606 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36777/tests/kraken/driver.html?testName=json-parse-financial) 03:04:52 INFO - PID 8606 | RSS: Main: 214851584 03:04:52 INFO - PID 8606 | 03:04:54 INFO - PID 8606 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36777/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:04:54 INFO - PID 8606 | RSS: Main: 213692416 03:04:54 INFO - PID 8606 | 03:04:56 INFO - PID 8606 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36777/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:04:57 INFO - PID 8606 | RSS: Main: 214183936 03:04:57 INFO - PID 8606 | 03:04:59 INFO - PID 8606 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36777/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:04:59 INFO - PID 8606 | RSS: Main: 210464768 03:04:59 INFO - PID 8606 | 03:05:02 INFO - PID 8606 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:05:03 INFO - PID 8606 | RSS: Main: 211918848 03:05:03 INFO - PID 8606 | 03:05:06 INFO - PID 8606 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:05:06 INFO - PID 8606 | RSS: Main: 211443712 03:05:06 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36777/tests/kraken/driver.html?testName=ai-astar) 03:05:08 INFO - PID 8606 | RSS: Main: 213676032 03:05:08 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | __start_tp_report 03:05:08 INFO - PID 8606 | _x_x_mozilla_page_load 03:05:08 INFO - PID 8606 | _x_x_mozilla_page_load_details 03:05:08 INFO - PID 8606 | |i|pagename|runs| 03:05:08 INFO - PID 8606 | |0;ai-astar;104;119;108;110;117;118;115;108;112;116 03:05:08 INFO - PID 8606 | |1;audio-beat-detection;151;116;144;167;118;156;149;124;170;118 03:05:08 INFO - PID 8606 | |2;audio-dft;169;163;164;165;166;172;167;161;163;165 03:05:08 INFO - PID 8606 | |3;audio-fft;76;76;77;172;76;86;85;92;104;74 03:05:08 INFO - PID 8606 | |4;audio-oscillator;82;82;124;82;81;89;131;82;80;144 03:05:08 INFO - PID 8606 | |5;imaging-gaussian-blur;124;120;114;114;123;114;124;117;114;123 03:05:08 INFO - PID 8606 | |6;imaging-darkroom;152;150;149;150;151;149;159;148;155;157 03:05:08 INFO - PID 8606 | |7;imaging-desaturate;96;99;94;101;95;104;94;95;101;95 03:05:08 INFO - PID 8606 | |8;json-parse-financial;53;53;52;55;53;53;54;52;52;53 03:05:08 INFO - PID 8606 | |9;json-stringify-tinderbox;42;42;39;38;49;48;39;44;39;46 03:05:08 INFO - PID 8606 | |10;stanford-crypto-aes;86;82;82;84;74;77;75;75;75;75 03:05:08 INFO - PID 8606 | |11;stanford-crypto-ccm;124;128;117;134;124;117;122;119;127;164 03:05:08 INFO - PID 8606 | |12;stanford-crypto-pbkdf2;178;171;172;174;169;175;169;179;167;166 03:05:08 INFO - PID 8606 | |13;stanford-crypto-sha256-iterative;72;63;66;65;65;63;64;66;70;65 03:05:08 INFO - PID 8606 | __end_tp_report 03:05:08 INFO - PID 8606 | __start_cc_report 03:05:08 INFO - PID 8606 | _x_x_mozilla_cycle_collect,950 03:05:08 INFO - PID 8606 | __end_cc_report 03:05:08 INFO - PID 8606 | __startTimestamp1504433108949__endTimestamp 03:05:08 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | ------- Summary: start ------- 03:05:08 INFO - PID 8606 | Number of tests: 14 03:05:08 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | [#0] ai-astar Cycles:10 Average:112.70 Median:115.50 stddev:5.06 (4.4%) stddev-sans-first:4.27 03:05:08 INFO - PID 8606 | Values: 104.0 119.0 108.0 110.0 117.0 118.0 115.0 108.0 112.0 116.0 03:05:08 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:150.00 stddev:20.78 (13.9%) stddev-sans-first:21.74 03:05:08 INFO - PID 8606 | Values: 151.0 116.0 144.0 167.0 118.0 156.0 149.0 124.0 170.0 118.0 03:05:08 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.50 stddev:3.21 (1.9%) stddev-sans-first:3.14 03:05:08 INFO - PID 8606 | Values: 169.0 163.0 164.0 165.0 166.0 172.0 167.0 161.0 163.0 165.0 03:05:08 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | [#3] audio-fft Cycles:10 Average:91.80 Median:76.50 stddev:29.71 (38.8%) stddev-sans-first:30.96 03:05:08 INFO - PID 8606 | Values: 76.0 76.0 77.0 172.0 76.0 86.0 85.0 92.0 104.0 74.0 03:05:08 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:82.00 stddev:24.94 (30.4%) stddev-sans-first:25.80 03:05:08 INFO - PID 8606 | Values: 82.0 82.0 124.0 82.0 81.0 89.0 131.0 82.0 80.0 144.0 03:05:08 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:121.50 stddev:4.55 (3.7%) stddev-sans-first:4.40 03:05:08 INFO - PID 8606 | Values: 124.0 120.0 114.0 114.0 123.0 114.0 124.0 117.0 114.0 123.0 03:05:08 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | [#6] imaging-darkroom Cycles:10 Average:152.00 Median:151.50 stddev:3.74 (2.5%) stddev-sans-first:3.97 03:05:08 INFO - PID 8606 | Values: 152.0 150.0 149.0 150.0 151.0 149.0 159.0 148.0 155.0 157.0 03:05:08 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | [#7] imaging-desaturate Cycles:10 Average:97.40 Median:95.00 stddev:3.57 (3.8%) stddev-sans-first:3.75 03:05:08 INFO - PID 8606 | Values: 96.0 99.0 94.0 101.0 95.0 104.0 94.0 95.0 101.0 95.0 03:05:08 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:0.94 (1.8%) stddev-sans-first:1.00 03:05:08 INFO - PID 8606 | Values: 53.0 53.0 52.0 55.0 53.0 53.0 54.0 52.0 52.0 53.0 03:05:08 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | [#9] json-stringify-tinderbox Cycles:10 Average:42.60 Median:43.00 stddev:4.01 (9.3%) stddev-sans-first:4.24 03:05:08 INFO - PID 8606 | Values: 42.0 42.0 39.0 38.0 49.0 48.0 39.0 44.0 39.0 46.0 03:05:08 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:79.50 stddev:4.50 (5.7%) stddev-sans-first:3.87 03:05:08 INFO - PID 8606 | Values: 86.0 82.0 82.0 84.0 74.0 77.0 75.0 75.0 75.0 75.0 03:05:08 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:125.50 stddev:13.83 (11.0%) stddev-sans-first:14.61 03:05:08 INFO - PID 8606 | Values: 124.0 128.0 117.0 134.0 124.0 117.0 122.0 119.0 127.0 164.0 03:05:08 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:173.00 stddev:4.45 (2.6%) stddev-sans-first:4.15 03:05:08 INFO - PID 8606 | Values: 178.0 171.0 172.0 174.0 169.0 175.0 169.0 179.0 167.0 166.0 03:05:08 INFO - PID 8606 | 03:05:08 INFO - PID 8606 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:65.50 stddev:2.92 (4.5%) stddev-sans-first:2.11 03:05:08 INFO - PID 8606 | Values: 72.0 63.0 66.0 65.0 65.0 63.0 64.0 66.0 70.0 65.0 03:05:08 INFO - PID 8606 | -------- Summary: end -------- 03:05:08 INFO - PID 8606 | 03:05:09 INFO - PID 8606 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:05:09 INFO - TEST-INFO | 8606: exit 0 03:05:09 INFO - TEST-OK | kraken | took 62329ms 03:05:09 INFO - SUITE-END | took 1176s 03:05:10 INFO - Completed test suite (00:19:36) 03:05:10 INFO - javascript benchmark 03:05:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8612.210994072035, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.883594074208, 3340.7661463697536, 3364.8485818138183, 3368.2758206985495, 3368.4105281575726, 6258.749650014005, 6259.186305780254, 6396.648184349859, 6419.133416988711, 6424.132742079818, 6405.039244113385, 6430.196225471816, 6444.323346048668, 6446.258680251773, 6474.74101035958, 5874.295084589845, 5913.704314784265, 5930.911036334458, 5945.613535120204, 5972.104184372335, 5933.525317974573, 5934.64392136471, 5953.285605727318, 5958.612690175147, 5960.493358064569, 5929.495992840613, 5954.612950158247, 5962.403759624024, 5990.281166260055, 5991.281046274453, 5804.100364443476, 5974.731137098797, 5980.97009514954, 5981.401859814006, 5987.700614969234, 5916.0, 5946.167536544887, 5948.851278718067, 5962.3739507351975, 5964.493018093467, 6483.0, 6507.154069970921, 6507.544471886969, 6537.215534135887, 6669.23303820062, 6859.07402500661, 6866.0, 6872.0, 6977.232504424509, 7008.824779380505, 6716.697748601325, 6857.417119544794, 6858.177018757731, 6868.553544019623, 7020.543664661832, 6426.614403135827, 6449.0, 6462.935370646281, 6477.060826180177, 6490.772822951174, 7007.404370628554, 7163.42692584592, 7193.820154496179, 7214.92785072153, 7226.0, 6811.080504131978, 6834.965825170842, 6878.759243426456, 6912.688928998207, 6932.584044957218, 6719.260881303053, 6802.319768023158, 6843.692033858489, 6925.861482770417, 6944.479164062715, 6446.709898054599, 6755.49333799967, 6818.318168183241, 6876.931230687729, 6970.825729356705, 6896.379325860697, 6919.619420931897, 6945.548539344926, 7005.754798582026, 7010.614416207056, 5353.437889021675, 5446.482584154499, 5448.291722076105, 5479.397266300703, 5520.447955204448, 4744.217204161344, 4773.809047638056, 4794.017226468565, 4797.928031079537, 4870.342503761947, 6008.459238668541, 6050.6672133032225, 6105.603135796159, 6117.051856962178, 6140.140380346755, 6918.100646915868, 6932.861342773217, 6934.583924964418, 6944.340287672663, 7029.753958611424, 5902.085176797603, 5967.0, 5979.701014949323, 6027.156198132265, 6102.206713127353, 5990.520758339322, 6009.849753756103, 6013.00785370409, 6016.398360163948, 6047.7278522466595, 6556.0, 6565.934340656628, 6662.034005069335, 6683.097781799492, 6849.2465828758795, 6726.8654626908165, 6735.360140786617, 6767.526273160832, 6772.153480814898, 6777.45780337562, 6505.186851643544, 6577.177852768404, 6583.275839657538, 6591.835204119743, 6620.8344791380605, 6675.265720770614, 6676.632785196861, 6687.264400915993, 6687.899681504879, 6694.196696396463, 6850.45196384298, 6862.553933994474, 6962.0, 6993.580385176906, 7062.117235345582, 6684.4318232950745, 6722.798316050526, 6820.4202642773935, 6824.385805277549, 6834.897476537756, 6482.935170648422, 6652.966735166293, 6706.731730730716, 6720.294369091371, 6812.318768123148, 6551.836204094745, 6576.046473261446, 6584.76953306632, 6600.141981542369, 6604.240512341143, 6606.8017959461295, 6643.734250629921, 6704.430123439367, 6722.563033402813, 6774.119364482585, 6493.935060649522, 6496.935030649822, 6598.274189839018, 6600.372964568358, 6674.065630811593], "value": 6295.499895262256, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.1789057271011, 825.1253671108625, 1028.382970217869, 1095.6986828622128, 1238.9132760706755, 38316.80841595795, 39357.60642393575, 39792.403113953274, 39874.2025159497, 40013.0, 36195.819020904855, 36537.63462365376, 36736.63263367365, 36761.816190919075, 36962.0, 7631.2368763123795, 7828.530288182699, 7838.216178382173, 7848.13670496245, 7888.842223155533, 7650.234976502333, 7796.259355361231, 7804.60976951153, 7816.374690024784, 7816.687332506693, 7751.069871615414, 7760.06879174497, 7796.376289896823, 7800.570968596753, 7854.764357069297, 7788.571628560427, 7804.804879877992, 7815.960920195391, 7823.765287041398, 7857.1357150713375, 7732.226777322279, 7782.571958542278, 7788.221177882223, 7788.571628560427, 7793.649285782153, 36898.8155059223, 37117.257654846755, 37199.81400092982, 37395.62604373949, 37426.8128659355, 3513.9824300878586, 3533.169705119295, 3545.06055895188, 3545.574531056264, 3568.2506673598577, 31483.685163148304, 31527.0, 31537.0, 31586.36827263465, 31646.841765791025, 4994.101061808873, 5162.22566615007, 5182.559482443997, 5226.189940559181, 5249.86875328116, 181525.0923745386, 181533.0, 181777.0, 182475.0, 185969.0, 42395.7880210597, 48685.513144868804, 49027.50972490301, 49228.50771492311, 49295.02819887236, 50573.24140137901, 51372.22941655878, 51437.7428112857, 51500.742496287276, 51617.225741613904, 15959.36162553508, 16076.115813630362, 16088.0, 16091.0, 16101.11443870575, 13121.475140994444, 13268.867311326763, 13277.867221327857, 13291.534796282083, 13300.201987880759, 13750.312484375741, 13863.653408664864, 13910.374033168531, 14075.71848563023, 14090.577282681536, 5603.3836278009385, 5626.943730562642, 5651.237082993744, 5723.084306511021, 5730.799422020209, 985.280745056113, 995.2833959549258, 997.436448406648, 1001.2140469731225, 1015.3856916565519, 22657.206997754998, 22818.0, 22892.313230603108, 22925.88537057304, 23035.769642303698, 1098.4727330881221, 1104.4974536585835, 1110.5668789172069, 1125.2573301620891, 1128.5260190719753, 11924.224925379822, 12207.45066471993, 12255.203411778206, 12342.382880856101, 12361.93819030899, 228315.0, 228562.0, 228753.0, 229722.0, 229903.0, 51341.486585134415, 51601.741991289804, 51672.22491662628, 51706.48293517017, 51837.48162518402, 1425.736238795826, 1453.3895763779237, 1456.3082535795413, 1463.3561233057421, 1473.1823837769925, 22489.43776405603, 22810.65784013208, 22846.31461056171, 22891.716629142997, 22945.426364340357, 36684.81657591802, 36845.63154368422, 37074.258514829016, 37117.25765484729, 37132.0, 192710.0, 194353.0, 194472.0, 194607.0, 194712.0, 29649.110526684235, 29771.70228297776, 31254.21864453407, 33996.49005264972, 34160.65839341674, 41803.79098104611, 41859.372109417774, 42301.57698422977, 42944.35583466313, 43312.350314744675, 30694.84652576723, 30780.53829192609, 31301.373972520876, 31317.53023704601, 31637.683623163473, 30907.690923090482, 31242.281674507212, 31338.21654458657, 31347.84326078355, 31422.52866206963, 34796.82601586976, 37436.812815935744, 37839.24321513609, 37953.2409351817, 38220.80889595534, 32635.020949371556, 32970.835145824116, 33048.834755826065, 33577.49633755447, 34159.4876076864, 24814.627780582945, 24843.130490432748, 25127.49745005053, 25340.493190135727, 25777.097801576856], "value": 17093.151922109675, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.9261695979523, 572.2503520388289, 573.260493962788, 579.4697851465909, 587.4712758517334, 22259.777402225973, 22950.0, 22971.310860674184, 23030.88484557579, 23067.42331441715, 23962.28113156608, 26046.0, 26085.608715869228, 26210.0, 26242.47515049698, 6598.142241508609, 6765.12053433053, 6765.32346765322, 6782.389584937355, 6789.490788190881, 6039.305479869805, 6544.411003009728, 6553.410193082622, 6573.342665733412, 6592.6703664816805, 6599.67001649918, 6620.966895165518, 6624.867502649944, 6638.203415590136, 6642.667866606675, 6614.636195009272, 6616.338366163345, 6625.304343043959, 6635.402813746762, 6639.103720997676, 6110.144579758838, 6161.568690191689, 6171.475424588915, 6183.81448556544, 6191.25704915413, 27798.444031119467, 28945.42109157805, 29047.0, 29391.706082939112, 29608.703912961024, 2070.171931227521, 2096.6540520814046, 2097.465146387661, 2098.181709133439, 2104.400245929918, 19367.418977430698, 20050.298239561693, 20058.699119513218, 20095.89952050245, 20121.195152193894, 2433.0875921529428, 2458.791002764767, 2484.6645702830247, 2518.244526642, 2525.5580273452074, 133793.0, 135435.32282338524, 135973.0, 136891.0, 136943.0, 13722.794158087636, 14601.269936503133, 14602.882582025546, 14667.853321466862, 14897.467430536835, 22877.428064298194, 23093.422664433187, 23148.726820024724, 23149.0, 23257.18599848997, 9868.309218354647, 9924.652637157666, 10073.992600739868, 10205.591776328863, 10223.0, 9355.345125841262, 9437.103475169848, 9516.809663806824, 9562.665306714232, 9597.280203984728, 7623.8069062016775, 8879.733607991771, 8970.641174352953, 9166.908330916605, 9288.210502107262, 2556.7443255674284, 2563.782078523309, 2631.8420894746378, 2662.9600555991674, 2710.671770832278, 929.6142101028133, 935.9812803744023, 945.7541039329824, 966.6230170233614, 984.1142971325864, 19183.32858349951, 19416.8058319415, 19562.0, 19641.705374419395, 20012.59974800525, 1033.4987531047436, 1038.402918321968, 1042.8227201375785, 1050.4800123938699, 1054.146141625286, 10672.30630009047, 10868.456577171268, 10936.507857146447, 10948.890511094947, 10979.83530247047, 474626.0, 483123.0, 484314.0, 501213.0, 501310.0, 121488.0, 123300.0, 124293.37853310676, 124343.0, 125722.0, 1132.4620805117504, 1165.7785020846013, 1189.6133756529164, 1193.4689063366893, 1195.0797885628017, 16804.915975420045, 16818.747718784474, 17059.402920897708, 17667.293308267526, 17673.911630441766, 53977.0, 54655.72672136614, 55839.0, 56368.718156408955, 56461.435385645615, 76646.23353766391, 77450.6127469359, 77487.0, 77572.0, 79176.0, 13848.238346891017, 14105.929470352583, 14126.78809817874, 14363.856361436252, 14398.352074156479, 21762.238321658668, 21875.234366797085, 21882.562348752617, 22206.777932221117, 22286.0, 17690.91154544219, 18057.729134062738, 18132.546686332946, 18192.99938503395, 18297.634047319247, 15738.291776870297, 15830.129342886252, 16146.515604531884, 16363.2636531354, 16383.918080409521, 17948.37180698669, 18795.0, 18870.905645471685, 18875.6224875499, 18892.149853256913, 14366.209858457885, 14400.351984160528, 14400.42398304056, 14404.639884002983, 14416.567502974927, 17034.829651703323, 17513.03678297706, 17844.464666060037, 17857.553561161076, 17899.0], "value": 11932.461509685014, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.1201251167975, 1367.9822262163311, 1370.212128026385, 1384.335518950903, 1385.0443194196005, 14844.628884277885, 15655.843441565596, 15665.84334156658, 15712.764308535381, 15722.606934826606, 14848.0, 15908.204589770494, 15925.840741592581, 15952.282147303371, 16011.199440028011, 2645.5238057149754, 2687.220705995259, 2712.606672032564, 2712.742289482496, 2716.9184924452297, 2620.397308619019, 2713.782897368216, 2760.4479104179145, 2774.4867199568043, 2776.0422654184376, 2762.8066035377533, 2801.9299517512122, 2807.199948014816, 2808.0593001344573, 2810.297425643589, 2521.8991240350365, 2580.367809886571, 2596.013514864349, 2611.7257687942683, 2617.018618018243, 2656.627432307094, 2681.182239416977, 2682.9195124146113, 2697.339151907795, 2705.391286960438, 14908.70182596342, 15143.848561514464, 15156.545303640909, 15189.468368607157, 15222.771658425132, 7838.686452541891, 8135.145809690016, 8141.918580814176, 8173.918260817375, 8204.671813127468, 5034.622403319729, 5144.0, 5174.404943431516, 5326.573874090063, 5340.198970154469, 1965.626530959113, 1979.8614097013215, 1983.7123617075442, 2023.6964455331818, 2026.3110542415502, 27061.323466913287, 27432.451350972868, 27446.0, 27455.313617159532, 27503.587446188325, 7115.466340024519, 7200.963995179991, 7362.595057271901, 7430.071241094864, 7443.627818609048, 17533.21100550478, 17617.647647046986, 17706.5573360667, 17743.55641108957, 17786.91106544459, 7810.921890781019, 7916.960415197887, 7982.321502672222, 7995.360371170409, 8015.599220039091, 7358.595277259802, 7379.88930166048, 7398.593077380796, 7452.993845830852, 7504.437167212372, 4774.594159496412, 5014.498550145029, 5044.873878153002, 5055.545000949932, 5060.063888180698, 1318.5978276625528, 1357.8206977800685, 1422.118286662276, 1423.59427563144, 1470.522080323899, 863.4732812984074, 876.145757886056, 897.1253028297358, 903.3902116071625, 906.859436787299, 8249.257566819015, 8417.284530814826, 8616.956915215384, 8674.6530138795, 8892.0, 988.7972965542046, 1001.7896241789306, 1002.6691191906799, 1013.5489707080426, 1016.9389836609827, 4771.308160316735, 5049.091163590516, 5131.7690703918415, 5236.842894713165, 5429.67421954684, 20582.176712931614, 21992.120315187534, 22121.33635990923, 22141.66787498189, 22230.444238894157, 21492.462688432603, 21587.67618485724, 22299.554008920055, 22383.32850014502, 22596.66105008426, 11571.884281157081, 11757.706057348463, 11795.882041179479, 11903.523859045714, 11976.041916646822, 8450.957745211235, 8571.95714021426, 8578.571071446528, 8598.871016934876, 8657.091005444337, 18493.90753046226, 18849.434516964513, 19092.618147637248, 19267.22931082741, 19778.50553736168, 19368.709469357687, 19378.224871005, 19398.321058762875, 19479.61040779205, 19601.509962251057, 11094.334339939629, 11110.388928608681, 11181.832272516082, 11200.0, 11235.213535052795, 13390.866091339352, 13398.26309552945, 13530.052896297164, 13533.120347177795, 13557.728845423233, 10453.68638940833, 10735.624253151102, 10772.461376931278, 10805.405702686428, 11083.334999900031, 10494.580216791242, 10661.466926653482, 10661.733456663645, 10767.0, 10918.454077296263, 10221.9488902555, 10320.948395257976, 10342.37945723229, 10348.482575871025, 10456.268061235945, 7004.229534751275, 7070.7525236616475, 7077.5399599025895, 7158.749443769443, 7204.53170543913, 6866.931330686629, 6951.965240173767, 6956.0, 6978.825529361807, 7008.334208250412], "value": 6702.7553497518575, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.44981744989224, 509.3047989494339, 530.1993989076498, 534.684536123687, 536.5653820405472, 6458.354164583539, 6459.545372758357, 6495.480361571074, 6544.051112588678, 6554.6067235965875, 6198.59709118907, 6346.936530634693, 6374.087773667904, 6389.744410223586, 6419.5506314558, 5102.081625307444, 5112.923306150411, 5153.3558305211845, 5214.634975551713, 5221.921671174935, 5091.134507133796, 5112.335396398463, 5120.92318615221, 5127.717975511346, 5168.8707782305555, 4900.6920328778115, 4994.525520075587, 5018.222175562793, 5083.18669012958, 5121.743912804345, 4939.827106051271, 5067.797288108472, 5122.8207012754565, 5127.717975511346, 5144.845654630349, 4493.955060449386, 4515.593596576324, 4522.7286362818, 4554.590086892195, 4600.884977875547, 6112.63324200545, 6159.538034647419, 6189.907151392733, 6209.677822365058, 6284.465820405271, 5806.970965145189, 5834.97082514589, 5849.707514624251, 5882.147088672119, 5917.644941303535, 6713.597184168965, 6762.2469529411155, 6769.661516924134, 6787.524873258873, 6816.7614133505085, 4929.3345398371475, 4960.296638332117, 4961.181405068195, 4963.255511673242, 4968.577670897978, 7003.439724822053, 7069.0, 7083.362497375261, 7108.928910710878, 7171.318724721144, 5146.768395422215, 5156.974215128976, 5157.742112894415, 5197.154105961637, 5198.9740051299505, 5194.8961020780125, 5196.246544251138, 5211.973940130275, 5215.426303106655, 5265.578753699695, 5710.371859095496, 5798.0, 5807.651540907559, 5836.153757705194, 5841.853953651193, 6685.164354455693, 6767.154105736783, 6779.15260592426, 6797.898031529531, 6816.147981502312, 1679.6724638695582, 1731.5065206416111, 1759.4018033868547, 1785.0628420079563, 1790.7045337519423, 1189.9107566932341, 1228.9078319126102, 1253.3419954523947, 1253.9749205015848, 1254.4668515880896, 5868.501177399883, 5925.318588362394, 5949.196858424144, 5949.434803693643, 5961.0, 6612.603243805387, 6716.529842911047, 6736.292689267654, 6740.573393578308, 6891.620960847202, 5879.882402351929, 5934.3383852521365, 5977.402259773988, 5988.461038506555, 6064.787732429432, 3641.7997010164167, 3651.397519409321, 3665.8533658653355, 3705.7405981581032, 3713.962860371416, 6634.7393995140765, 6726.159230096238, 6749.966250168816, 6797.932020679828, 6806.659667016629, 7107.253738357502, 7156.24859389767, 7164.101513099033, 7181.210066892638, 7208.711651533985, 6593.505487088488, 6614.768483103068, 6620.139381880324, 6662.467002639681, 6715.966420167868, 6717.865642687021, 6746.898796517958, 6825.69284382194, 6883.242843287134, 7019.894701579583, 6811.8978215325815, 6851.45188384938, 6860.0791778302155, 6863.794086177422, 6895.5173137879865, 6650.700718467584, 6651.467882569286, 6677.499187561049, 6698.263191049078, 6767.796966090828, 5062.620303477328, 5082.695038297714, 5120.411152717336, 5148.0, 5161.174212126042, 6865.485088618274, 6904.723811047703, 6967.467157225605, 7032.5077244592385, 7056.6471676417, 6586.176727909012, 6642.900356494753, 6646.202455705346, 6704.463642908653, 6719.563228390139, 6636.469082473487, 6749.865002700017, 6777.322267773183, 6821.8635627286185, 6841.692123854339, 6342.431315317304, 6541.934580654132, 6662.137319159109, 6744.62904540255, 6798.830029249309, 6294.685265736786, 6727.562708423937, 6740.39336459721, 6763.5941843489545, 6814.659267036727, 6433.29233784274, 6487.935120648733, 6493.805185844432, 6507.544471886922, 6523.151990241238], "value": 5182.84498840496, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.4802390601498, 908.4821651658553, 910.9362344635877, 911.8313112074271, 943.052232506331, 18517.0, 19630.803691963076, 19676.90161549192, 19722.802771972278, 22610.434739131488, 20974.89512552439, 21412.14351425945, 21541.0, 21559.892200539016, 21631.45921351963, 980.6126580000913, 988.990110098897, 997.0378584665796, 998.2363491928644, 999.145730400508, 984.4782265399314, 994.2940512236285, 998.1465846701075, 998.4907697074508, 1000.6447711062577, 950.553239977213, 981.7545613596601, 1030.263361696387, 1036.5076588620382, 1043.8590790243295, 1018.7453136715822, 1027.6505987964129, 1028.228828378716, 1029.7322696098993, 1029.860968769214, 740.677805154754, 742.9777106686809, 745.7054463486946, 746.3879618712658, 749.2881762325812, 19579.11893964775, 19709.704354434696, 19724.704129437927, 19960.201591936304, 20229.797702023086, 19685.606287874307, 20173.899130504255, 20422.69365959512, 20598.897005515028, 20633.277835275843, 17190.1404929753, 17211.139443027798, 17212.741808872877, 17423.21595528204, 17502.649947001115, 3673.559172899269, 3709.0, 3712.6472985066375, 3720.9441858372147, 3730.4404339349044, 127110.0, 127838.0, 132762.3361883194, 133818.0, 134915.0, 15891.761623575656, 16220.0, 16310.184490775413, 16397.67204655924, 16866.831331686528, 30037.549436758465, 30698.386032279228, 30716.232094197378, 30746.0, 31830.04509864708, 7636.923630763621, 7949.523028618301, 8757.080506546848, 9300.8604870927, 9510.09654082861, 4343.370211319341, 4433.202023635712, 4461.531539188403, 4461.843835465743, 4469.642428605704, 5332.626716129834, 5465.207544906046, 5471.288732464834, 5774.451427114417, 5949.970250148722, 1061.8991195836384, 1073.7637719701654, 1075.198976762317, 1086.9347839129678, 1089.096050278283, 634.1470721879065, 659.9538032337787, 661.6823924516259, 665.0788657709107, 676.3202981004059, 12046.939765301116, 12251.32617706017, 12929.676758080936, 13325.200487970753, 13710.108842925178, 644.2108417188906, 645.5448908519483, 654.6432194453939, 655.8458762190882, 659.1694464974167, 5648.096304591246, 5679.176519404663, 5730.7421166047625, 5770.884582308414, 5814.3313518945015, 112110.0, 112830.43584782188, 115516.0, 115872.42063789627, 117481.0, 100176.49911750395, 102166.0, 103711.0, 104412.0, 105075.4746226264, 87131.56434217788, 89502.0, 89568.10431895728, 90119.0, 91674.54162729143, 10545.789084218426, 10569.312994655324, 10585.665515362636, 10608.787824243625, 10888.18338624622, 41495.0, 41765.58234417617, 43594.56405436032, 43701.34447983346, 43857.56142438662, 53419.19871202013, 53759.462405375445, 54552.45447545474, 54814.45185548093, 54816.45183548273, 14960.0, 15394.538163855103, 15523.922380388025, 15544.145072021147, 15791.763123553386, 17502.0, 17629.382971595933, 17810.821891780917, 17927.19327630286, 17995.460136195936, 19737.506562336057, 19874.0, 20198.39404817858, 20326.390208293775, 20758.688619670414, 18913.810861891205, 19256.518587034876, 19680.803191967898, 19851.205951761767, 20251.18995240174, 18483.90758046255, 19557.31549395764, 19749.60500790005, 20286.0, 20561.79438205599, 13230.867691323348, 13557.186568805902, 13575.592732218049, 13670.0, 13909.513167039106, 13733.45066197341, 14030.719385612434, 14088.859111408754, 14156.787648185491, 14196.43214271459], "value": 9146.599812560613, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 119.0, 108.0, 110.0, 117.0, 118.0, 115.0, 108.0, 112.0, 116.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 116.0, 144.0, 167.0, 118.0, 156.0, 149.0, 124.0, 170.0, 118.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 163.0, 164.0, 165.0, 166.0, 172.0, 167.0, 161.0, 163.0, 165.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 172.0, 76.0, 86.0, 85.0, 92.0, 104.0, 74.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 124.0, 82.0, 81.0, 89.0, 131.0, 82.0, 80.0, 144.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 120.0, 114.0, 114.0, 123.0, 114.0, 124.0, 117.0, 114.0, 123.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 149.0, 150.0, 151.0, 149.0, 159.0, 148.0, 155.0, 157.0], "value": 152.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 94.0, 101.0, 95.0, 104.0, 94.0, 95.0, 101.0, 95.0], "value": 97.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 55.0, 53.0, 53.0, 54.0, 52.0, 52.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 42.0, 39.0, 38.0, 49.0, 48.0, 39.0, 44.0, 39.0, 46.0], "value": 42.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 82.0, 84.0, 74.0, 77.0, 75.0, 75.0, 75.0, 75.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 128.0, 117.0, 134.0, 124.0, 117.0, 122.0, 119.0, 127.0, 164.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 171.0, 172.0, 174.0, 169.0, 175.0, 169.0, 179.0, 167.0, 166.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 63.0, 66.0, 65.0, 65.0, 63.0, 64.0, 66.0, 70.0, 65.0], "value": 65.9, "unit": "score"}]}]} 03:05:10 INFO - Return code: 0 03:05:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:05:10 INFO - # TBPL SUCCESS # 03:05:10 INFO - Running post-action listener: _package_coverage_data 03:05:10 INFO - Running post-action listener: _resource_record_post_action 03:05:10 INFO - [mozharness: 2017-09-03 10:05:10.256517Z] Finished run-tests step (success) 03:05:10 INFO - Running post-run listener: _resource_record_post_run 03:05:10 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 782336; Write bytes: 398499840; Read time: 256; Write time: 203024 03:05:10 INFO - TinderboxPrint: CPU usage
13.3% 03:05:10 INFO - TinderboxPrint: I/O read bytes / time
782,336 / 256 03:05:10 INFO - TinderboxPrint: I/O write bytes / time
398,499,840 / 203,024 03:05:10 INFO - TinderboxPrint: CPU idle
8,245.3 (86.7%) 03:05:10 INFO - TinderboxPrint: CPU user
1,201.7 (12.6%) 03:05:10 INFO - TinderboxPrint: Swap in / out
0 / 0 03:05:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117448704; Read time: 0; Write time: 72956 03:05:10 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:05:10 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 782336; Write bytes: 281051136; Read time: 256; Write time: 130068 03:05:10 INFO - Running post-run listener: _upload_blobber_files 03:05:10 INFO - Blob upload gear active. 03:05:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:05:10 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 03:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:05:11 INFO - (blobuploader) - INFO - Open directory for files ... 03:05:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:05:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:05:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:12 INFO - (blobuploader) - INFO - Done attempting. 03:05:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:05:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:05:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:13 INFO - (blobuploader) - INFO - Done attempting. 03:05:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:05:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:05:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:20 INFO - (blobuploader) - INFO - Done attempting. 03:05:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:05:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:05:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:21 INFO - (blobuploader) - INFO - Done attempting. 03:05:21 INFO - (blobuploader) - INFO - Iteration through files over. 03:05:21 INFO - Return code: 0 03:05:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:05:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:05:21 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ac4603a2a4cf74ac0abd0a1497cda50ef8cd23ca174182eea63928e66b91c25f8b0863bb538da33a81a6d7538c7d5026de5aeeddf08c383c2eab7a18ea5476b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f017456dab4d4cf8c93aeb01bcacbf1986404df48e51b5078fd6f9c6660ee0efd2378b7a3afc5358a06e5d9c0f4a3adb96a91b75e2c9aa0457d01d5488b2d0dc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e03b85600667763b8af71e153a5abc5abe5a1135a4305972bdae1aad541a7d0f80848ebe4e2d069663c03ed6511fd0434892c960c2c7ebafff50ce156430c8a5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd140a4df2d9e876003b45f6e24601d805796fd791ce4e1b1a8bab838cd5c6b30ca4a7ea0141143337fe878b2baa32f6687b410863ec36a19a0d572fbd5b4f6e"} 03:05:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:05:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:05:21 INFO - Contents: 03:05:21 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ac4603a2a4cf74ac0abd0a1497cda50ef8cd23ca174182eea63928e66b91c25f8b0863bb538da33a81a6d7538c7d5026de5aeeddf08c383c2eab7a18ea5476b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f017456dab4d4cf8c93aeb01bcacbf1986404df48e51b5078fd6f9c6660ee0efd2378b7a3afc5358a06e5d9c0f4a3adb96a91b75e2c9aa0457d01d5488b2d0dc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e03b85600667763b8af71e153a5abc5abe5a1135a4305972bdae1aad541a7d0f80848ebe4e2d069663c03ed6511fd0434892c960c2c7ebafff50ce156430c8a5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd140a4df2d9e876003b45f6e24601d805796fd791ce4e1b1a8bab838cd5c6b30ca4a7ea0141143337fe878b2baa32f6687b410863ec36a19a0d572fbd5b4f6e"} 03:05:21 INFO - Running post-run listener: copy_logs_to_upload_dir 03:05:21 INFO - Copying logs to upload dir... 03:05:21 INFO - mkdir: /builds/slave/test/build/upload/logs 03:05:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.849266 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-09-03 03:05:21.191507) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-03 03:05:21.195155) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ac4603a2a4cf74ac0abd0a1497cda50ef8cd23ca174182eea63928e66b91c25f8b0863bb538da33a81a6d7538c7d5026de5aeeddf08c383c2eab7a18ea5476b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f017456dab4d4cf8c93aeb01bcacbf1986404df48e51b5078fd6f9c6660ee0efd2378b7a3afc5358a06e5d9c0f4a3adb96a91b75e2c9aa0457d01d5488b2d0dc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e03b85600667763b8af71e153a5abc5abe5a1135a4305972bdae1aad541a7d0f80848ebe4e2d069663c03ed6511fd0434892c960c2c7ebafff50ce156430c8a5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd140a4df2d9e876003b45f6e24601d805796fd791ce4e1b1a8bab838cd5c6b30ca4a7ea0141143337fe878b2baa32f6687b410863ec36a19a0d572fbd5b4f6e"} build_url:https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011552 build_url: 'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ac4603a2a4cf74ac0abd0a1497cda50ef8cd23ca174182eea63928e66b91c25f8b0863bb538da33a81a6d7538c7d5026de5aeeddf08c383c2eab7a18ea5476b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f017456dab4d4cf8c93aeb01bcacbf1986404df48e51b5078fd6f9c6660ee0efd2378b7a3afc5358a06e5d9c0f4a3adb96a91b75e2c9aa0457d01d5488b2d0dc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e03b85600667763b8af71e153a5abc5abe5a1135a4305972bdae1aad541a7d0f80848ebe4e2d069663c03ed6511fd0434892c960c2c7ebafff50ce156430c8a5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd140a4df2d9e876003b45f6e24601d805796fd791ce4e1b1a8bab838cd5c6b30ca4a7ea0141143337fe878b2baa32f6687b410863ec36a19a0d572fbd5b4f6e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-03 03:05:21.223416) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 03:05:21.223789) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1504407190.617951-1972707217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 03:05:21.307820) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-03 03:05:21.308133) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-03 03:05:21.308469) ========= ========= Total master_lag: 0.19 =========