builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-032 starttime: 1507057583.21 results: success (0) revision: bb2a1f41d82a1fc2414c6f0d435fa6c054244d62 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-03 12:06:23.210123) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-03 12:06:23.210534) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-03 12:06:23.210832) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-03 12:06:23.227358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 12:06:23.227642) ========= 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=745a4373a2a16df560f216e000000264-1507057582.425595-871374012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-03 12:06: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% 12.1M=0.001s 2017-10-03 12:06:23 (12.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.155557 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 12:06:23.397880) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 12:06:23.398213) ========= 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=745a4373a2a16df560f216e000000264-1507057582.425595-871374012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021419 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 12:06:23.447884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-03 12:06:23.448204) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bb2a1f41d82a1fc2414c6f0d435fa6c054244d62 --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 bb2a1f41d82a1fc2414c6f0d435fa6c054244d62 --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=745a4373a2a16df560f216e000000264-1507057582.425595-871374012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-03 12:06:23,540 truncating revision to first 12 chars 2017-10-03 12:06:23,540 Setting DEBUG logging. 2017-10-03 12:06:23,540 attempt 1/10 2017-10-03 12:06:23,540 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bb2a1f41d82a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-03 12:06:24,465 unpacking tar archive at: mozilla-central-bb2a1f41d82a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.271985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-03 12:06:24.737713) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-03 12:06:24.738049) ========= script_repo_revision: bb2a1f41d82a1fc2414c6f0d435fa6c054244d62 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-03 12:06:24.738405) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-03 12:06:24.738720) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-03 12:06:24.752344) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-10-03 12:06:24.752673) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1507057582.425595-871374012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:06:24 INFO - MultiFileLogger online at 20171003 12:06:24 in /builds/slave/test 12:06:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:06:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:06:24 INFO - {'append_to_log': False, 12:06:24 INFO - 'base_work_dir': '/builds/slave/test', 12:06:24 INFO - 'blob_upload_branch': 'Firefox', 12:06:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:06:24 INFO - 'branch': 'Firefox', 12:06:24 INFO - 'buildbot_json_path': 'buildprops.json', 12:06:24 INFO - 'code_coverage': False, 12:06:24 INFO - 'config_files': ('talos/linux_config.py',), 12:06:24 INFO - 'default_actions': ('clobber', 12:06:24 INFO - 'read-buildbot-config', 12:06:24 INFO - 'download-and-extract', 12:06:24 INFO - 'populate-webroot', 12:06:24 INFO - 'create-virtualenv', 12:06:24 INFO - 'install', 12:06:24 INFO - 'setup-mitmproxy', 12:06:24 INFO - 'run-tests'), 12:06:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:06:24 INFO - 'disable_ccov_upload': False, 12:06:24 INFO - 'disable_stylo': False, 12:06:24 INFO - 'download_minidump_stackwalk': True, 12:06:24 INFO - 'download_symbols': 'ondemand', 12:06:24 INFO - 'enable_stylo': False, 12:06:24 INFO - 'enable_webrender': False, 12:06:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:06:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:06:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:06:24 INFO - 'gecko_profile': False, 12:06:24 INFO - 'gecko_profile_interval': 0, 12:06:24 INFO - 'installer_path': 'installer.exe', 12:06:24 INFO - 'log_level': 'info', 12:06:24 INFO - 'log_name': 'talos', 12:06:24 INFO - 'log_to_console': True, 12:06:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:06:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:06:24 INFO - 'opt_config_files': (), 12:06:24 INFO - 'pip_index': False, 12:06:24 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 12:06:24 INFO - 'system_bits': '32', 12:06:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:06:24 INFO - 'title': 'talos-linux64-ix-032', 12:06:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:06:24 INFO - 'use_talos_json': True, 12:06:24 INFO - 'verify': 'False', 12:06:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:06:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:06:24 INFO - 'work_dir': 'build'} 12:06:24 INFO - [mozharness: 2017-10-03 19:06:24.983089Z] Running clobber step. 12:06:24 INFO - Running pre-action listener: _resource_record_pre_action 12:06:24 INFO - Running main action method: clobber 12:06:24 INFO - rmtree: /builds/slave/test/build 12:06:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:06:25 INFO - Running post-action listener: _resource_record_post_action 12:06:25 INFO - [mozharness: 2017-10-03 19:06:25.980648Z] Finished clobber step (success) 12:06:25 INFO - [mozharness: 2017-10-03 19:06:25.980745Z] Running read-buildbot-config step. 12:06:25 INFO - Running pre-action listener: _resource_record_pre_action 12:06:25 INFO - Running main action method: read_buildbot_config 12:06:25 INFO - Using buildbot properties: 12:06:25 INFO - { 12:06:25 INFO - "project": "", 12:06:25 INFO - "product": "firefox", 12:06:25 INFO - "who": "ffxbld@noreply.mozilla.org", 12:06:25 INFO - "installer_path": "public/build/target.tar.bz2", 12:06:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 12:06:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 12:06:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 12:06:25 INFO - "stage_platform": "linux64-pgo", 12:06:25 INFO - "basedir": "/builds/slave/test", 12:06:25 INFO - "buildnumber": 11, 12:06:25 INFO - "platform": "ubuntu64_hw", 12:06:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:06:25 INFO - "slavebuilddir": "test", 12:06:25 INFO - "taskId": "c27GtqNxSziMFSHl069_GA", 12:06:25 INFO - "branch": "mozilla-central", 12:06:25 INFO - "script_repo_revision": "production", 12:06:25 INFO - "revision": "bb2a1f41d82a1fc2414c6f0d435fa6c054244d62", 12:06:25 INFO - "slavename": "talos-linux64-ix-032", 12:06:25 INFO - "repo_path": "mozilla-central" 12:06:25 INFO - } 12:06:25 INFO - Finding installer, test and symbols from parent task. 12:06:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c27GtqNxSziMFSHl069_GA'}, attempt #1 12:06:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c27GtqNxSziMFSHl069_GA'}, attempt #1 12:06:27 INFO - Task dependencies: Ff5cRZkeTlSpMEK3fGAQkw 12:06:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw'}, attempt #1 12:06:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.tar.bz2 12:06:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.test_packages.json 12:06:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.crashreporter-symbols.zip 12:06:27 INFO - Running post-action listener: _resource_record_post_action 12:06:27 INFO - [mozharness: 2017-10-03 19:06:27.895909Z] Finished read-buildbot-config step (success) 12:06:27 INFO - [mozharness: 2017-10-03 19:06:27.896127Z] Running download-and-extract step. 12:06:27 INFO - Running pre-action listener: _resource_record_pre_action 12:06:27 INFO - Running main action method: download_and_extract 12:06:27 INFO - mkdir: /builds/slave/test/build/tests 12:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:27 INFO - trying https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.test_packages.json 12:06:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:06:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:06:28 INFO - Downloaded 989 bytes. 12:06:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:06:28 INFO - Using the following test package requirements: 12:06:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:06:28 INFO - u'common': [u'target.common.tests.zip'], 12:06:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:06:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:06:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:06:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:06:28 INFO - u'mozbase': [u'target.common.tests.zip'], 12:06:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:06:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:06:28 INFO - u'web-platform': [u'target.common.tests.zip', 12:06:28 INFO - u'target.web-platform.tests.tar.gz'], 12:06:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:06:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 12:06:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.common.tests.zip 12:06:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:06:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.common.tests.zip into memory 12:06:29 INFO - Content-Length response header: 55869435 12:06:29 INFO - Bytes received: 55869435 12:06:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.talos.tests.zip 12:06:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:06:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.talos.tests.zip into memory 12:06:40 INFO - Content-Length response header: 14522427 12:06:40 INFO - Bytes received: 14522427 12:06:41 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')]} 12:06:41 INFO - trying https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.tar.bz2 12:06:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:06:42 INFO - Downloaded 62338571 bytes. 12:06:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.tar.bz2 12:06:42 INFO - mkdir: /builds/slave/test/properties 12:06:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:06:42 INFO - Writing to file /builds/slave/test/properties/build_url 12:06:42 INFO - Contents: 12:06:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.tar.bz2 12:06:42 INFO - Running post-action listener: _resource_record_post_action 12:06:42 INFO - Running post-action listener: find_tests_for_verification 12:06:42 INFO - Running post-action listener: set_extra_try_arguments 12:06:42 INFO - [mozharness: 2017-10-03 19:06:42.389176Z] Finished download-and-extract step (success) 12:06:42 INFO - [mozharness: 2017-10-03 19:06:42.389324Z] Running populate-webroot step. 12:06:42 INFO - Running pre-action listener: _resource_record_pre_action 12:06:42 INFO - Running main action method: populate_webroot 12:06:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:06:42 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:06:42 INFO - 'tests': ['tresize', 12:06:42 INFO - 'tcanvasmark']}, 12:06:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:06:42 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:06:42 INFO - 'tests': ['dromaeo_css', 12:06:42 INFO - 'kraken']}, 12:06:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:06:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:06:42 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:06:42 INFO - 'talos_options': ['--disable-stylo'], 12:06:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:06:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:06:42 INFO - 'tests': ['damp', 'tps']}, 12:06:42 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:06:42 INFO - 'talos_options': ['--disable-stylo'], 12:06:42 INFO - 'tests': ['damp', 'tps']}, 12:06:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:06:42 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:06:42 INFO - 'tests': ['dromaeo_dom']}, 12:06:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:06:42 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:06:42 INFO - 'tests': ['basic_compositor_video', 12:06:42 INFO - 'glvideo']}, 12:06:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:06:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:06:42 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:06:42 INFO - 'talos_options': ['--disable-stylo'], 12:06:42 INFO - 'tests': ['ts_paint_webext', 12:06:42 INFO - 'tp5o_webext']}, 12:06:42 INFO - 'other-e10s': {'tests': ['a11yr', 12:06:42 INFO - 'ts_paint', 12:06:42 INFO - 'tpaint', 12:06:42 INFO - 'sessionrestore', 12:06:42 INFO - 'sessionrestore_many_windows', 12:06:42 INFO - 'sessionrestore_no_auto_restore', 12:06:42 INFO - 'tabpaint', 12:06:42 INFO - 'cpstartup']}, 12:06:42 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:06:42 INFO - 'tests': ['a11yr', 12:06:42 INFO - 'ts_paint', 12:06:42 INFO - 'tpaint', 12:06:42 INFO - 'sessionrestore', 12:06:42 INFO - 'sessionrestore_many_windows', 12:06:42 INFO - 'sessionrestore_no_auto_restore', 12:06:42 INFO - 'tabpaint', 12:06:42 INFO - 'cpstartup']}, 12:06:42 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 12:06:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 12:06:42 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:06:42 INFO - 'tests': ['perf_reftest_singletons']}, 12:06:42 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:06:42 INFO - 'tests': ['perf_reftest']}, 12:06:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:06:42 INFO - 'tsvgr_opacity', 12:06:42 INFO - 'tart', 12:06:42 INFO - 'tscrollx', 12:06:42 INFO - 'tsvg_static']}, 12:06:42 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:06:42 INFO - 'tests': ['tsvgx', 12:06:42 INFO - 'tsvgr_opacity', 12:06:42 INFO - 'tart', 12:06:42 INFO - 'tscrollx', 12:06:42 INFO - 'tsvg_static']}, 12:06:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:06:42 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:06:42 INFO - 'talos_options': ['--disable-stylo'], 12:06:42 INFO - 'tests': ['tp5o']}, 12:06:42 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:06:42 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:06:42 INFO - 'talos_options': ['--mitmproxy', 12:06:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:06:42 INFO - '--firstNonBlankPaint'], 12:06:42 INFO - 'tests': ['tp6_google', 12:06:42 INFO - 'tp6_youtube', 12:06:42 INFO - 'tp6_amazon', 12:06:42 INFO - 'tp6_facebook']}, 12:06:42 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:06:42 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:06:42 INFO - 'talos_options': ['--disable-stylo', 12:06:42 INFO - '--mitmproxy', 12:06:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:06:42 INFO - '--firstNonBlankPaint'], 12:06:42 INFO - 'tests': ['tp6_google', 12:06:42 INFO - 'tp6_youtube', 12:06:42 INFO - 'tp6_amazon', 12:06:42 INFO - 'tp6_facebook']}, 12:06:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:06:42 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:06:42 INFO - 'talos_options': ['--stylo-threads=1', 12:06:42 INFO - '--mitmproxy', 12:06:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:06:42 INFO - '--firstNonBlankPaint'], 12:06:42 INFO - 'tests': ['tp6_google', 12:06:42 INFO - 'tp6_youtube', 12:06:42 INFO - 'tp6_amazon', 12:06:42 INFO - 'tp6_facebook']}, 12:06:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:06:42 INFO - 'talos_options': ['--xperf_path', 12:06:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:06:42 INFO - 'tests': ['tp5n']}, 12:06:42 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:06:42 INFO - 'talos_options': ['--disable-stylo', 12:06:42 INFO - '--xperf_path', 12:06:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:06:42 INFO - 'tests': ['tp5n']}}} 12:06:42 INFO - Running post-action listener: _resource_record_post_action 12:06:42 INFO - [mozharness: 2017-10-03 19:06:42.843412Z] Finished populate-webroot step (success) 12:06:42 INFO - [mozharness: 2017-10-03 19:06:42.843565Z] Running create-virtualenv step. 12:06:42 INFO - Running pre-action listener: _resource_record_pre_action 12:06:42 INFO - Running main action method: create_virtualenv 12:06:42 INFO - Creating virtualenv /builds/slave/test/build/venv 12:06:42 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:06:42 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:06:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:06:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:06:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:06:44 INFO - Installing distribute.............................................................................................................................................................................................done. 12:06:45 INFO - Installing pip...............done. 12:06:45 INFO - Return code: 0 12:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:06:45 INFO - Reading from file tmpfile_stdout 12:06:45 INFO - Output received: 12:06:45 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 12:06:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:45 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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e8d60>, '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 0x27e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, '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': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', '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 12:06:45 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 12:06:45 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 12:06:45 INFO - Using env: {'DISPLAY': ':0', 12:06:45 INFO - 'HOME': '/home/cltbld', 12:06:45 INFO - 'LANG': 'en_US.UTF-8', 12:06:45 INFO - 'LANGUAGE': 'en_US:en', 12:06:45 INFO - 'LOGNAME': 'cltbld', 12:06:45 INFO - 'MAIL': '/var/mail/cltbld', 12:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:45 INFO - 'MOZ_NO_REMOTE': '1', 12:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:45 INFO - 'NO_EM_RESTART': '1', 12:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:45 INFO - 'PWD': '/builds/slave/test', 12:06:45 INFO - 'SHELL': '/bin/bash', 12:06:45 INFO - 'SHLVL': '1', 12:06:45 INFO - 'TERM': 'linux', 12:06:45 INFO - 'TMOUT': '86400', 12:06:45 INFO - 'USER': 'cltbld', 12:06:45 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', 12:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:45 INFO - '_': '/tools/buildbot/bin/python'} 12:06:46 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:06:46 INFO - Downloading/unpacking pip>=1.5 12:06:46 INFO - Running setup.py egg_info for package pip 12:06:46 INFO - warning: no files found matching 'pip/cacert.pem' 12:06:46 INFO - warning: no files found matching '*.html' under directory 'docs' 12:06:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:06:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:06:46 INFO - Installing collected packages: pip 12:06:46 INFO - Found existing installation: pip 1.1 12:06:46 INFO - Uninstalling pip: 12:06:46 INFO - Successfully uninstalled pip 12:06:46 INFO - Running setup.py install for pip 12:06:46 INFO - warning: no files found matching 'pip/cacert.pem' 12:06:46 INFO - warning: no files found matching '*.html' under directory 'docs' 12:06:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:06:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:06:46 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:06:46 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:06:46 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:06:46 INFO - Successfully installed pip 12:06:46 INFO - Cleaning up... 12:06:46 INFO - Return code: 0 12:06:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:06:46 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')]} 12:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:46 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')]} 12:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:46 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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e8d60>, '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 0x27e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, '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': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', '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 12:06:46 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 12:06:46 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 12:06:46 INFO - Using env: {'DISPLAY': ':0', 12:06:46 INFO - 'HOME': '/home/cltbld', 12:06:46 INFO - 'LANG': 'en_US.UTF-8', 12:06:46 INFO - 'LANGUAGE': 'en_US:en', 12:06:46 INFO - 'LOGNAME': 'cltbld', 12:06:46 INFO - 'MAIL': '/var/mail/cltbld', 12:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:46 INFO - 'MOZ_NO_REMOTE': '1', 12:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:46 INFO - 'NO_EM_RESTART': '1', 12:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:46 INFO - 'PWD': '/builds/slave/test', 12:06:46 INFO - 'SHELL': '/bin/bash', 12:06:46 INFO - 'SHLVL': '1', 12:06:46 INFO - 'TERM': 'linux', 12:06:46 INFO - 'TMOUT': '86400', 12:06:46 INFO - 'USER': 'cltbld', 12:06:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', 12:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:46 INFO - '_': '/tools/buildbot/bin/python'} 12:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:46 INFO - Downloading/unpacking psutil>=3.1.1 12:06:46 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 12:06:46 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 12:06:46 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 12:06:46 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 12:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:06:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:06:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:06:48 INFO - Installing collected packages: psutil 12:06:48 INFO - Running setup.py install for psutil 12:06:48 INFO - building 'psutil._psutil_linux' extension 12:06:48 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 12:06:48 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 12:06:48 INFO - building 'psutil._psutil_posix' extension 12:06:48 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 12:06:48 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 12:06:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:06:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:06:48 INFO - Successfully installed psutil 12:06:48 INFO - Cleaning up... 12:06:48 INFO - Return code: 0 12:06:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e8d60>, '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 0x27e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, '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': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', '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 12:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:06:48 INFO - Using env: {'DISPLAY': ':0', 12:06:48 INFO - 'HOME': '/home/cltbld', 12:06:48 INFO - 'LANG': 'en_US.UTF-8', 12:06:48 INFO - 'LANGUAGE': 'en_US:en', 12:06:48 INFO - 'LOGNAME': 'cltbld', 12:06:48 INFO - 'MAIL': '/var/mail/cltbld', 12:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:48 INFO - 'MOZ_NO_REMOTE': '1', 12:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:48 INFO - 'NO_EM_RESTART': '1', 12:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:48 INFO - 'PWD': '/builds/slave/test', 12:06:48 INFO - 'SHELL': '/bin/bash', 12:06:48 INFO - 'SHLVL': '1', 12:06:48 INFO - 'TERM': 'linux', 12:06:48 INFO - 'TMOUT': '86400', 12:06:48 INFO - 'USER': 'cltbld', 12:06:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', 12:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:48 INFO - '_': '/tools/buildbot/bin/python'} 12:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:06:48 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 12:06:48 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 12:06:48 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 12:06:48 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 12:06:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:06:49 INFO - Installing collected packages: mozsystemmonitor 12:06:49 INFO - Running setup.py install for mozsystemmonitor 12:06:50 INFO - Successfully installed mozsystemmonitor 12:06:50 INFO - Cleaning up... 12:06:51 INFO - Return code: 0 12:06:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e8d60>, '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 0x27e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, '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': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', '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 12:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:06:51 INFO - Using env: {'DISPLAY': ':0', 12:06:51 INFO - 'HOME': '/home/cltbld', 12:06:51 INFO - 'LANG': 'en_US.UTF-8', 12:06:51 INFO - 'LANGUAGE': 'en_US:en', 12:06:51 INFO - 'LOGNAME': 'cltbld', 12:06:51 INFO - 'MAIL': '/var/mail/cltbld', 12:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:51 INFO - 'MOZ_NO_REMOTE': '1', 12:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:51 INFO - 'NO_EM_RESTART': '1', 12:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:51 INFO - 'PWD': '/builds/slave/test', 12:06:51 INFO - 'SHELL': '/bin/bash', 12:06:51 INFO - 'SHLVL': '1', 12:06:51 INFO - 'TERM': 'linux', 12:06:51 INFO - 'TMOUT': '86400', 12:06:51 INFO - 'USER': 'cltbld', 12:06:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', 12:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:51 INFO - '_': '/tools/buildbot/bin/python'} 12:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:51 INFO - Downloading/unpacking jsonschema==2.5.1 12:06:51 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 12:06:51 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 12:06:51 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 12:06:51 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 12:06:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:06:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:52 INFO - Downloading functools32-3.2.3-2.tar.gz 12:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:06:52 INFO - warning: no files found matching '*.txt' 12:06:52 INFO - no previously-included directories found matching 'build' 12:06:52 INFO - no previously-included directories found matching 'dist' 12:06:52 INFO - no previously-included directories found matching '.git*' 12:06:52 INFO - Installing collected packages: jsonschema, functools32 12:06:53 INFO - Running setup.py install for functools32 12:06:53 INFO - warning: no files found matching '*.txt' 12:06:53 INFO - no previously-included directories found matching 'build' 12:06:53 INFO - no previously-included directories found matching 'dist' 12:06:53 INFO - no previously-included directories found matching '.git*' 12:06:53 INFO - Successfully installed jsonschema functools32 12:06:53 INFO - Cleaning up... 12:06:53 INFO - Return code: 0 12:06:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e8d60>, '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 0x27e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, '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': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', '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 12:06:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:06:53 INFO - Using env: {'DISPLAY': ':0', 12:06:53 INFO - 'HOME': '/home/cltbld', 12:06:53 INFO - 'LANG': 'en_US.UTF-8', 12:06:53 INFO - 'LANGUAGE': 'en_US:en', 12:06:53 INFO - 'LOGNAME': 'cltbld', 12:06:53 INFO - 'MAIL': '/var/mail/cltbld', 12:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:53 INFO - 'MOZ_NO_REMOTE': '1', 12:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:53 INFO - 'NO_EM_RESTART': '1', 12:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:53 INFO - 'PWD': '/builds/slave/test', 12:06:53 INFO - 'SHELL': '/bin/bash', 12:06:53 INFO - 'SHLVL': '1', 12:06:53 INFO - 'TERM': 'linux', 12:06:53 INFO - 'TMOUT': '86400', 12:06:53 INFO - 'USER': 'cltbld', 12:06:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', 12:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:53 INFO - '_': '/tools/buildbot/bin/python'} 12:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:06:53 INFO - Cleaning up... 12:06:53 INFO - Return code: 0 12:06:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e8d60>, '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 0x27e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, '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': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', '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 12:06:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:06:53 INFO - Using env: {'DISPLAY': ':0', 12:06:53 INFO - 'HOME': '/home/cltbld', 12:06:53 INFO - 'LANG': 'en_US.UTF-8', 12:06:53 INFO - 'LANGUAGE': 'en_US:en', 12:06:53 INFO - 'LOGNAME': 'cltbld', 12:06:53 INFO - 'MAIL': '/var/mail/cltbld', 12:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:53 INFO - 'MOZ_NO_REMOTE': '1', 12:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:53 INFO - 'NO_EM_RESTART': '1', 12:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:53 INFO - 'PWD': '/builds/slave/test', 12:06:53 INFO - 'SHELL': '/bin/bash', 12:06:53 INFO - 'SHLVL': '1', 12:06:53 INFO - 'TERM': 'linux', 12:06:53 INFO - 'TMOUT': '86400', 12:06:53 INFO - 'USER': 'cltbld', 12:06:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', 12:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:53 INFO - '_': '/tools/buildbot/bin/python'} 12:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:53 INFO - Downloading/unpacking blobuploader==1.2.4 12:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:54 INFO - Downloading blobuploader-1.2.4.tar.gz 12:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:06:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:06:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:55 INFO - Downloading docopt-0.6.1.tar.gz 12:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:06:55 INFO - Installing collected packages: blobuploader, requests, docopt 12:06:55 INFO - Running setup.py install for blobuploader 12:06:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:06:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:06:55 INFO - Running setup.py install for requests 12:06:55 INFO - Running setup.py install for docopt 12:06:55 INFO - Successfully installed blobuploader requests docopt 12:06:55 INFO - Cleaning up... 12:06:55 INFO - Return code: 0 12:06:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06: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')]} 12:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06: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')]} 12:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:55 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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e8d60>, '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 0x27e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, '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': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', '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 12:06:55 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 12:06:55 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 12:06:55 INFO - Using env: {'DISPLAY': ':0', 12:06:55 INFO - 'HOME': '/home/cltbld', 12:06:55 INFO - 'LANG': 'en_US.UTF-8', 12:06:55 INFO - 'LANGUAGE': 'en_US:en', 12:06:55 INFO - 'LOGNAME': 'cltbld', 12:06:55 INFO - 'MAIL': '/var/mail/cltbld', 12:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:55 INFO - 'MOZ_NO_REMOTE': '1', 12:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:55 INFO - 'NO_EM_RESTART': '1', 12:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:55 INFO - 'PWD': '/builds/slave/test', 12:06:55 INFO - 'SHELL': '/bin/bash', 12:06:55 INFO - 'SHLVL': '1', 12:06:55 INFO - 'TERM': 'linux', 12:06:55 INFO - 'TMOUT': '86400', 12:06:55 INFO - 'USER': 'cltbld', 12:06:55 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', 12:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:55 INFO - '_': '/tools/buildbot/bin/python'} 12:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:06:56 INFO - Running setup.py (path:/tmp/pip-qIBmGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:06:56 INFO - Running setup.py (path:/tmp/pip-toyKes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:06:56 INFO - Running setup.py (path:/tmp/pip-KiKlUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:06:56 INFO - Running setup.py (path:/tmp/pip-yQpEav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:06:56 INFO - Running setup.py (path:/tmp/pip-fg4z1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:06:56 INFO - Running setup.py (path:/tmp/pip-XB98Rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:06:56 INFO - Running setup.py (path:/tmp/pip-bqb48R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:06:56 INFO - Running setup.py (path:/tmp/pip-ir9h23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:06:56 INFO - Running setup.py (path:/tmp/pip-yOD_bI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:06:56 INFO - Running setup.py (path:/tmp/pip-zwxSb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:06:56 INFO - Running setup.py (path:/tmp/pip-rLxwC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:06:56 INFO - Running setup.py (path:/tmp/pip-NFNSHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:06:56 INFO - Running setup.py (path:/tmp/pip-ng59In-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:06:57 INFO - Running setup.py (path:/tmp/pip-7Tdt_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:57 INFO - Running setup.py (path:/tmp/pip-b58Rkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:06:57 INFO - Running setup.py (path:/tmp/pip-uKrDGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:06:57 INFO - Running setup.py (path:/tmp/pip-Uj6vKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:06:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:06:57 INFO - Running setup.py install for manifestparser 12:06:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:06:57 INFO - Running setup.py install for mozcrash 12:06:57 INFO - Running setup.py install for mozdebug 12:06:57 INFO - Running setup.py install for mozdevice 12:06:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:06:57 INFO - Running setup.py install for mozfile 12:06:57 INFO - Running setup.py install for mozhttpd 12:06:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:06:57 INFO - Running setup.py install for mozinfo 12:06:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:06:57 INFO - Running setup.py install for mozInstall 12:06:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:06:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:06:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:06:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:06:58 INFO - Running setup.py install for mozleak 12:06:58 INFO - Running setup.py install for mozlog 12:06:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:06:58 INFO - Running setup.py install for moznetwork 12:06:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:06:58 INFO - Running setup.py install for mozprocess 12:06:58 INFO - Running setup.py install for mozprofile 12:06:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:06:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:06:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:06:58 INFO - Running setup.py install for mozrunner 12:06:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:06:58 INFO - Running setup.py install for mozscreenshot 12:06:58 INFO - Running setup.py install for moztest 12:06:58 INFO - Running setup.py install for mozversion 12:06:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:06:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:06:59 INFO - Cleaning up... 12:06:59 INFO - Return code: 0 12:06:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06: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')]} 12:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06: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')]} 12:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:59 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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e8d60>, '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 0x27e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, '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': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', '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 12:06:59 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 12:06:59 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 12:06:59 INFO - Using env: {'DISPLAY': ':0', 12:06:59 INFO - 'HOME': '/home/cltbld', 12:06:59 INFO - 'LANG': 'en_US.UTF-8', 12:06:59 INFO - 'LANGUAGE': 'en_US:en', 12:06:59 INFO - 'LOGNAME': 'cltbld', 12:06:59 INFO - 'MAIL': '/var/mail/cltbld', 12:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:59 INFO - 'MOZ_NO_REMOTE': '1', 12:06:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:59 INFO - 'NO_EM_RESTART': '1', 12:06:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:59 INFO - 'PWD': '/builds/slave/test', 12:06:59 INFO - 'SHELL': '/bin/bash', 12:06:59 INFO - 'SHLVL': '1', 12:06:59 INFO - 'TERM': 'linux', 12:06:59 INFO - 'TMOUT': '86400', 12:06:59 INFO - 'USER': 'cltbld', 12:06:59 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', 12:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:59 INFO - '_': '/tools/buildbot/bin/python'} 12:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:06:59 INFO - Running setup.py (path:/tmp/pip-n4eNzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:06:59 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)) 12:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:06:59 INFO - Running setup.py (path:/tmp/pip-QpbuCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:06:59 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)) 12:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:06:59 INFO - Running setup.py (path:/tmp/pip-aFGF9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:06:59 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)) 12:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:06:59 INFO - Running setup.py (path:/tmp/pip-Ipl95a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:06:59 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)) 12:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:06:59 INFO - Running setup.py (path:/tmp/pip-gPbYqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:06:59 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)) 12:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:06:59 INFO - Running setup.py (path:/tmp/pip-8SvnP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:06:59 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)) 12:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:06:59 INFO - Running setup.py (path:/tmp/pip-JOUPVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:06:59 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)) 12:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:06:59 INFO - Running setup.py (path:/tmp/pip-k3xMva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:06:59 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)) 12:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:06:59 INFO - Running setup.py (path:/tmp/pip-WoC4JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:06:59 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)) 12:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:06:59 INFO - Running setup.py (path:/tmp/pip-1ZM1NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:07:00 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)) 12:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:07:00 INFO - Running setup.py (path:/tmp/pip-UiQ8Nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:07:00 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)) 12:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:07:00 INFO - Running setup.py (path:/tmp/pip-MnS9Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:07:00 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)) 12:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:07:00 INFO - Running setup.py (path:/tmp/pip-qlrgn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:07:00 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)) 12:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:07:00 INFO - Running setup.py (path:/tmp/pip-wRTYh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:07:00 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)) 12:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:07:00 INFO - Running setup.py (path:/tmp/pip-obksSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:07:00 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)) 12:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:07:00 INFO - Running setup.py (path:/tmp/pip-v32XKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:07:00 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)) 12:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:07:00 INFO - Running setup.py (path:/tmp/pip-E2AEWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:07:00 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)) 12:07:00 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)) 12:07:00 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)) 12:07:00 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)) 12:07:00 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)) 12:07:00 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)) 12:07:00 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)) 12:07:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:07:01 INFO - Downloading blessings-1.6.tar.gz 12:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:07:01 INFO - Installing collected packages: blessings 12:07:01 INFO - Running setup.py install for blessings 12:07:01 INFO - Successfully installed blessings 12:07:01 INFO - Cleaning up... 12:07:01 INFO - Return code: 0 12:07:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:07:02 INFO - Reading from file tmpfile_stdout 12:07:02 INFO - Current package versions: 12:07:02 INFO - argparse == 1.2.1 12:07:02 INFO - blessings == 1.6 12:07:02 INFO - blobuploader == 1.2.4 12:07:02 INFO - docopt == 0.6.1 12:07:02 INFO - functools32 == 3.2.3-2 12:07:02 INFO - jsonschema == 2.5.1 12:07:02 INFO - manifestparser == 1.1 12:07:02 INFO - mozInstall == 1.13 12:07:02 INFO - mozcrash == 1.0 12:07:02 INFO - mozdebug == 0.1 12:07:02 INFO - mozdevice == 0.51 12:07:02 INFO - mozfile == 1.2 12:07:02 INFO - mozhttpd == 0.7 12:07:02 INFO - mozinfo == 0.10 12:07:02 INFO - mozleak == 0.1 12:07:02 INFO - mozlog == 3.5 12:07:02 INFO - moznetwork == 0.27 12:07:02 INFO - mozprocess == 0.25 12:07:02 INFO - mozprofile == 0.28 12:07:02 INFO - mozrunner == 6.13 12:07:02 INFO - mozscreenshot == 0.1 12:07:02 INFO - mozsystemmonitor == 0.3 12:07:02 INFO - moztest == 0.8 12:07:02 INFO - mozversion == 1.4 12:07:02 INFO - psutil == 3.1.1 12:07:02 INFO - requests == 1.2.3 12:07:02 INFO - wsgiref == 0.1.2 12:07:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:07:02 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')]} 12:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:07:02 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')]} 12:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:07:02 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 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e8d60>, '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 0x27e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, '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': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', '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 12:07:02 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 12:07:02 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 12:07:02 INFO - Using env: {'DISPLAY': ':0', 12:07:02 INFO - 'HOME': '/home/cltbld', 12:07:02 INFO - 'LANG': 'en_US.UTF-8', 12:07:02 INFO - 'LANGUAGE': 'en_US:en', 12:07:02 INFO - 'LOGNAME': 'cltbld', 12:07:02 INFO - 'MAIL': '/var/mail/cltbld', 12:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:02 INFO - 'MOZ_NO_REMOTE': '1', 12:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:02 INFO - 'NO_EM_RESTART': '1', 12:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:02 INFO - 'PWD': '/builds/slave/test', 12:07:02 INFO - 'SHELL': '/bin/bash', 12:07:02 INFO - 'SHLVL': '1', 12:07:02 INFO - 'TERM': 'linux', 12:07:02 INFO - 'TMOUT': '86400', 12:07:02 INFO - 'USER': 'cltbld', 12:07:02 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', 12:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:02 INFO - '_': '/tools/buildbot/bin/python'} 12:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:07:02 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)) 12:07:02 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)) 12:07:02 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)) 12:07:02 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)) 12:07:02 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)) 12:07:02 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)) 12:07:02 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)) 12:07:02 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)) 12:07:02 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)) 12:07:02 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:07:02 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 12:07:02 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 12:07:02 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 12:07:02 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 12:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:07:03 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)) 12:07:03 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)) 12:07:03 INFO - Installing collected packages: simplejson 12:07:03 INFO - Running setup.py install for simplejson 12:07:03 INFO - building 'simplejson._speedups' extension 12:07:03 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 12:07:04 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 12:07:04 INFO - Successfully installed simplejson 12:07:04 INFO - Cleaning up... 12:07:04 INFO - Return code: 0 12:07:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:07: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')]} 12:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:07: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')]} 12:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:07: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e8d60>, '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 0x27e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, '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': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', '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 12:07: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', 'jsonschema'] in /builds/slave/test/build 12:07: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 jsonschema 12:07:04 INFO - Using env: {'DISPLAY': ':0', 12:07:04 INFO - 'HOME': '/home/cltbld', 12:07:04 INFO - 'LANG': 'en_US.UTF-8', 12:07:04 INFO - 'LANGUAGE': 'en_US:en', 12:07:04 INFO - 'LOGNAME': 'cltbld', 12:07:04 INFO - 'MAIL': '/var/mail/cltbld', 12:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:04 INFO - 'MOZ_NO_REMOTE': '1', 12:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:04 INFO - 'NO_EM_RESTART': '1', 12:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:04 INFO - 'PWD': '/builds/slave/test', 12:07:04 INFO - 'SHELL': '/bin/bash', 12:07:04 INFO - 'SHLVL': '1', 12:07:04 INFO - 'TERM': 'linux', 12:07:04 INFO - 'TMOUT': '86400', 12:07:04 INFO - 'USER': 'cltbld', 12:07:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', 12:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:04 INFO - '_': '/tools/buildbot/bin/python'} 12:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:07:04 INFO - Cleaning up... 12:07:04 INFO - Return code: 0 12:07:04 INFO - Running post-action listener: _resource_record_post_action 12:07:04 INFO - Running post-action listener: _start_resource_monitoring 12:07:04 INFO - Starting resource monitoring. 12:07:04 INFO - [mozharness: 2017-10-03 19:07:04.798162Z] Finished create-virtualenv step (success) 12:07:04 INFO - [mozharness: 2017-10-03 19:07:04.798676Z] Running install step. 12:07:04 INFO - Running pre-action listener: _resource_record_pre_action 12:07:04 INFO - Running main action method: install 12:07:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:07:05 INFO - Reading from file tmpfile_stdout 12:07:05 INFO - Detecting whether we're running mozinstall >=1.0... 12:07:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:07:05 INFO - Reading from file tmpfile_stdout 12:07:05 INFO - Output received: 12:07:05 INFO - Usage: mozinstall [options] installer 12:07:05 INFO - Options: 12:07:05 INFO - -h, --help show this help message and exit 12:07:05 INFO - -d DEST, --destination=DEST 12:07:05 INFO - Directory to install application into. [default: 12:07:05 INFO - "/builds/slave/test"] 12:07:05 INFO - --app=APP Application being installed. [default: firefox] 12:07:05 INFO - mkdir: /builds/slave/test/build/application 12:07:05 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'] 12:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:07:22 INFO - Reading from file tmpfile_stdout 12:07:22 INFO - Output received: 12:07:22 INFO - /builds/slave/test/build/application/firefox/firefox 12:07:22 INFO - Running post-action listener: _resource_record_post_action 12:07:22 INFO - [mozharness: 2017-10-03 19:07:22.768946Z] Finished install step (success) 12:07:22 INFO - [mozharness: 2017-10-03 19:07:22.769198Z] Running setup-mitmproxy step. 12:07:22 INFO - Running pre-action listener: _resource_record_pre_action 12:07:22 INFO - Running main action method: setup_mitmproxy 12:07:22 INFO - Skipping: mitmproxy is not required 12:07:22 INFO - Running post-action listener: _resource_record_post_action 12:07:22 INFO - [mozharness: 2017-10-03 19:07:22.770433Z] Finished setup-mitmproxy step (success) 12:07:22 INFO - [mozharness: 2017-10-03 19:07:22.770653Z] Running run-tests step. 12:07:22 INFO - Running pre-action listener: _resource_record_pre_action 12:07:22 INFO - Running pre-action listener: _set_gcov_prefix 12:07:22 INFO - Running main action method: run_tests 12:07:22 WARNING - Try message not found. 12:07:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:07:22 INFO - Python 2.7.3 12:07:22 INFO - Return code: 0 12:07:22 INFO - grabbing minidump binary from tooltool 12:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:07:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e8d60>, '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 0x27e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:07:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:07:22 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:07:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:07:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:07:22 INFO - Return code: 0 12:07:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:07:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:07:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:07:22 INFO - ENV: RUST_BACKTRACE is now full 12:07:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:07:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:07:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 12:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 12:07:22 INFO - Using env: {'DISPLAY': ':0', 12:07:22 INFO - 'HOME': '/home/cltbld', 12:07:22 INFO - 'LANG': 'en_US.UTF-8', 12:07:22 INFO - 'LANGUAGE': 'en_US:en', 12:07:22 INFO - 'LOGNAME': 'cltbld', 12:07:22 INFO - 'MAIL': '/var/mail/cltbld', 12:07:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:07:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:22 INFO - 'MOZ_NO_REMOTE': '1', 12:07:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:22 INFO - 'NO_EM_RESTART': '1', 12:07:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:22 INFO - 'PWD': '/builds/slave/test', 12:07:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:07:22 INFO - 'RUST_BACKTRACE': 'full', 12:07:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:07:22 INFO - 'SHELL': '/bin/bash', 12:07:22 INFO - 'SHLVL': '1', 12:07:22 INFO - 'TERM': 'linux', 12:07:22 INFO - 'TMOUT': '86400', 12:07:22 INFO - 'USER': 'cltbld', 12:07:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', 12:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:22 INFO - '_': '/tools/buildbot/bin/python'} 12:07:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 12:07:23 INFO - mozversion application_buildid: 20171003174132 12:07:23 INFO - mozversion application_changeset: bb2a1f41d82a1fc2414c6f0d435fa6c054244d62 12:07:23 INFO - mozversion application_display_name: Nightly 12:07:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:07:23 INFO - mozversion application_name: Firefox 12:07:23 INFO - mozversion application_remotingname: firefox 12:07:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:07:23 INFO - mozversion application_vendor: Mozilla 12:07:23 INFO - mozversion application_version: 58.0a1 12:07:23 INFO - mozversion platform_buildid: 20171003174132 12:07:23 INFO - mozversion platform_changeset: bb2a1f41d82a1fc2414c6f0d435fa6c054244d62 12:07:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:07:23 INFO - mozversion platform_version: 58.0a1 12:07:23 INFO - using testdate: 1507057643 12:07:23 INFO - actual date: 1507057643 12:07:23 INFO - starting webserver on 'localhost:33324' 12:07:23 INFO - SUITE-START | Running 2 tests 12:07:23 INFO - TEST-START | dromaeo_css 12:07:23 INFO - Initialising browser for dromaeo_css test... 12:07:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33324/getInfo.html -profile /tmp/tmpQeXrlq/profile 12:07:23 INFO - TEST-INFO | started process 6202 (/builds/slave/test/build/application/firefox/firefox http://localhost:33324/getInfo.html) 12:07:29 INFO - TEST-INFO | 6202: exit 0 12:07:29 INFO - Browser initialized. 12:07:29 INFO - Running cycle 1/1 for dromaeo_css test... 12:07:29 INFO - Using env: {'DISPLAY': ':0', 12:07:29 INFO - 'HOME': '/home/cltbld', 12:07:29 INFO - 'JSGC_DISABLE_POISONING': '1', 12:07:29 INFO - 'LANG': 'en_US.UTF-8', 12:07:29 INFO - 'LANGUAGE': 'en_US:en', 12:07:29 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:07:29 INFO - 'LOGNAME': 'cltbld', 12:07:29 INFO - 'MAIL': '/var/mail/cltbld', 12:07:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:07:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:07:29 INFO - 'MOZ_CRASHREPORTER': '1', 12:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:29 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:07:29 INFO - 'MOZ_NO_REMOTE': '1', 12:07:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:29 INFO - 'NO_EM_RESTART': '1', 12:07:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:29 INFO - 'PWD': '/builds/slave/test', 12:07:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:07:29 INFO - 'RUST_BACKTRACE': 'full', 12:07:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:07:29 INFO - 'SHELL': '/bin/bash', 12:07:29 INFO - 'SHLVL': '1', 12:07:29 INFO - 'STYLO_FORCE_DISABLED': '1', 12:07:29 INFO - 'TERM': 'linux', 12:07:29 INFO - 'TMOUT': '86400', 12:07:29 INFO - 'USER': 'cltbld', 12:07:29 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', 12:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:29 INFO - '_': '/tools/buildbot/bin/python'} 12:07:29 INFO - TEST-INFO | started process 6476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQeXrlq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:07:30 INFO - PID 6476 | 12:07:30 INFO - PID 6476 | (/builds/slave/test/build/application/firefox/firefox:6526): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:07:30 INFO - PID 6476 | 12:07:40 INFO - PID 6476 | RSS: Main: 142848000 12:07:40 INFO - PID 6476 | 12:10:37 INFO - PID 6476 | Cycle 1(1): loaded http://localhost:33324/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33324/tests/dromaeo/cssquery-ext.html) 12:10:38 INFO - PID 6476 | RSS: Main: 142487552 12:10:38 INFO - PID 6476 | 12:13:40 INFO - PID 6476 | Cycle 1(1): loaded http://localhost:33324/tests/dromaeo/cssquery-ext.html (next: http://localhost:33324/tests/dromaeo/cssquery-jquery.html) 12:13:40 INFO - PID 6476 | RSS: Main: 144355328 12:13:40 INFO - PID 6476 | 12:16:42 INFO - PID 6476 | Cycle 1(1): loaded http://localhost:33324/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33324/tests/dromaeo/cssquery-mootools.html) 12:16:43 INFO - PID 6476 | RSS: Main: 145358848 12:16:43 INFO - PID 6476 | 12:19:44 INFO - PID 6476 | Cycle 1(1): loaded http://localhost:33324/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33324/tests/dromaeo/cssquery-prototype.html) 12:19:45 INFO - PID 6476 | RSS: Main: 144912384 12:19:45 INFO - PID 6476 | 12:22:48 INFO - PID 6476 | Cycle 1(1): loaded http://localhost:33324/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33324/tests/dromaeo/cssquery-yui.html) 12:22:49 INFO - PID 6476 | RSS: Main: 147947520 12:22:49 INFO - PID 6476 | 12:25:50 INFO - PID 6476 | Cycle 1(1): loaded http://localhost:33324/tests/dromaeo/cssquery-yui.html (next: http://localhost:33324/tests/dromaeo/cssquery-dojo.html) 12:25:50 INFO - PID 6476 | RSS: Main: 149020672 12:25:50 INFO - PID 6476 | 12:25:50 INFO - PID 6476 | __start_tp_report 12:25:50 INFO - PID 6476 | _x_x_mozilla_page_load 12:25:50 INFO - PID 6476 | _x_x_mozilla_page_load_details 12:25:50 INFO - PID 6476 | |i|pagename|runs| 12:25:50 INFO - PID 6476 | |0;dojo.html;3838.0788610733425;3909.6872250219985;3913.608639136087;3930.331843586591;3941.86203482878;6218.968905155479;6299.843666514951;6316.905246421307;6472.8381790455205;6473.02904564315;6352.491800655948;6368.108464814918;6373.776917807878;6378.107065010902;6397.8400539986405;5662.292213473316;5668.43315668434;5686.630369026021;5705.030144875361;5745.482906538432;5719.799807006755;5726.455986681259;5744.6840423776675;5783.566232532556;5791.276090488689;5726.226959360475;5777.480026797587;5787.971060144693;5832.533397328203;5848.912266316009;546.1119081779053;5271.710055946922;5687.203791469197;5703.942960570383;5808.041673123972;5676.744546495376;5703.914441283384;5711.200431939532;5759.942400575983;5763.596548241583;6305.779297724557;6360.968195159041;6363.236411630634;6426.775062872824;6426.907425737636;6898.1377327834025;6911.205211400653;6926.341997510229;6986.61573613451;7021.719131234796;6951.08054617062;6975.755848545327;7038.6128762918015;7041.964790176016;7044.506884518086;6313.431791138773;6368.458681012119;6426.036094585803;6430.774922877724;6436.195475565554;7102.928970710227;7174.3184397482155;7189.245129261457;7201.459890508233;7218.711251549879;6812.080369150101;6815.182178138556;6868.965655171693;6901.068355772007;6912.239653638096;6821.317868213238;6913.654317284116;6926.722931082801;6934.029235906977;6944.791656250321;6834.794956151323;6849.2465828758795;6852.6916288767125;6882.965585172142;6956.060931774247;6861.416779573692;6946.548474349152;6948.096747422803;6952.270011648805;6961.860762784716;4950.232713929347;4958.380202474691;5054.317667114892;5056.721880296619;5056.924146137811;4473.485549161823;4493.73037617744;4503.797329120198;4514.32285157229;4516.141933032779;6367.840803979845;6370.522210834206;6409.487241020707;6414.326495717975;6417.229932408048;6863.725450981905;6864.931350686529;6867.83246848037;6943.72225111;6979.162500499972;6301.936980630227;6304.085907543381;6307.779227727099;6379.553431259767;6426.3573642635365;5542.445755424425;5555.50000499957;5556.583256255797;5558.583106267046;5562.554995600342;7014.754483593049;7059.470539709542;7067.363937245673;7170.6056166910275;7179.964100179465;6859.451243900576;6876.896846547305;6884.449244060564;6895.620740859301;6904.482163837632;7108.324709152622;7116.466265030247;7132;7153.964230179024;7157.713691452492;6765.661716914036;6769.424598909148;6806.659667016728;6819.488538359742;6827.863442731217;6888.931110689029;6892.310768923067;6954.3393377629045;6971.755988540377;7022.262662420372;6674.599524028574;6680.4989625779235;6687.899681504684;6775.254721980677;6781.694823732845;6565.868682626417;6653.534252602271;6679.398854103154;6762.357576030269;6768.492363072888;6654.83362915931;6678.365555272241;6678.465722742072;6683.732650693918;6691.364320389555;6755.3244675534015;6761.729530818909;6832.521723479309;6834;6854;6519.478441724746;6520.250171230179;6601.636909969998;6612.801615951529;6618.702158402787 12:25:50 INFO - PID 6476 | |1;ext.html;947.6493697331988;961.8028304197641;976.9120779129879;1018.6994836523224;1025.0979138358243;43937.34093988593;45010.32484512731;45118.77440612792;45199.322010169875;45340.54659453413;40946.18107637853;41134.58865411345;41187.79406102965;41395.58604413955;41432.378514322234;7437.888431673529;7542.547447153188;7545.584992825392;7550.0939887213335;7568.205338439468;7568.09182898053;7576.469647124703;7637.045369328834;7649.273319034711;7666.616669166548;7685.346745526609;8341.332693384546;8510.1915318045;8540.103289154642;8555.10171432;8435.662573497053;8508.74473765788;8514.829703405929;8516.78708032298;8517.44636598619;8271.255586997138;8393.958030209871;8441.915580844236;8494.78763030923;8503.022152452486;41411.37882931758;41769.582304176874;41922.37116443256;41924.37113443301;42039.36940945888;3694.2796154749835;3743.7005039596766;3743.794091324976;3748.231612519427;3750.7374483786148;33496.33007339839;33626.1593460163;33852.32295354079;34012.319753605036;34014.659853401645;5404.891902161974;5463.9180412293845;5488.874780669953;5500.834974950758;5505;242628;244967;245821;246098;247129;54249.72875135599;54307.72846135744;54321;54401;54544;57459.71270143623;57468.42531574715;57476;57488.712556437786;57508;16591.170441477876;16860;16862.83137168637;16872.83127168737;16873.39702728239;13579.45682172702;13643;13647.931760341135;13664.111832730841;13711.245881476614;15288.235588220545;15407.229638518253;15523.357481888583;15549.378024878879;15664.843351566566;6090.9390906090375;6097.908531372033;6233;6267.800573615688;6330.873382532415;1104.7845670094255;1105.8783533811275;1109.367660433545;1113.33200079953;1126.6113190949109;25520.872395637904;25522.48955020889;25527.61708574373;25623.231303060937;25822.74177258241;1194.924567888907;1220.5117952818944;1221.4625564751482;1222.7248869004402;1223.424990254579;13241.470341186438;13304.800427993589;13383.063185577112;13532.661683457993;13609;292735;294932;294935;295572;296125;51471.74264128655;52321;57431;58210.4178958205;58839.70580147072;1540.2991638804317;1552.8136623605014;1555.2146166186003;1558.516859773474;1568.8588027077617;30507.847460762554;30773.384532309676;31211.68364619308;31637.20906977344;31689.36621267608;41201.38197926973;41273.587264128175;41360;41393.79303103465;41419;240436;241555;242190;243389;243610;35633.28733425369;35820.820895895355;35913.10217244485;35932;35983.28033439369;44971.32543011923;45344.31983520184;45354.319685204086;45564.31653525266;45924;34280.48579271263;34585;34758.65241347655;34930.301393972484;34935.30129397449;33932.49101263434;34303.82848085744;34398;34427.4835877457;35096.29807403889;39680.80159599299;39902.80048599738;40339.3949090758;40363.3945490812;40431;33627.66372336343;33926.491102633976;33950.66049339475;34363;34569.65430345664;25871.223863284133;25926.35184120412;26079;26179.214623561325;26943.191704248904 12:25:50 INFO - PID 6476 | |2;jquery.html;608.4463138543925;624.3226099681845;630.6032138812529;634.7968650031991;647.7311915555043;22350.88824555877;23274.88362558189;23563.29310120695;23574.29277121689;23582.646260306065;24053;25411.237662870142;25437.491250174986;25460.872695636543;25464.36339091519;6628.038934354528;6740.191177058735;6810.931890681104;6812.727490900358;6815.454763618898;6583.2429270633775;6758.695858686371;6808.523403361766;6855.040294358794;6872.106626138595;6780.186377634691;6837.1795384553925;6860.72557097718;6864.382205601495;6875.931240687604;6668.599884006975;6966.268541803139;6966.5820050796865;6994.265602111806;6994.685239164199;6513.348665133496;6534.411902928711;6551.344865513458;6553.836154096138;6563.54055216135;29303.413931721247;29844.55233171504;30037.098887033422;30112.84943575268;30191.547126793117;2270.738865030526;2307.3424074138957;2329.1847853251397;2334.579775640384;2353.576356255873;19915;20605.072771725307;20675.5864882703;20678.793212067987;20687.172513099456;2419.8669073200967;2444.4744379958215;2496.6504689343506;2512.648229247907;2534.9873250633814;148134;155449;165781;171900;172186;16449.25978330978;17105.914470427568;17140;17354.219060142324;17989;27378.726212737616;27415.17754467369;27420.588691169647;27429.45141097207;27481;10860.891391086147;10967.780644387067;11087.113030957504;11113.666590002313;11174.944125279322;9583.808323833484;9753.317267791328;9844.556994935245;9890.851637225447;9986.900130998742;9866.703998880044;10127.544260508295;10188.745281367877;10319.587216511256;10642;2796.6504186976626;2844.9146525604265;2848.273690209025;3052.084374687585;3060.173753086654;1032.2980373346047;1038.2420832792104;1051.6109039655375;1065.3767545985686;1074.505727365405;22078.558428831333;22358.55282894333;22642.66036009461;22734.431639209153;22912;1097.6981330134277;1125.189863298424;1129.88701129888;1138.430784607696;1152.9077673786078;12176.81734773979;12246.571370002008;12288.815667764991;12439.813402798965;12644.43100060481;572209;573279;582658;587384;596540;127249;129128;130115.34942325228;130801;133046.33476832553;1091.3015669971226;1221.3099598726692;1242.3912282981455;1245.1346314311465;1251.167973297765;22841.543169136858;23228.3031509055;23314.883425582764;23565.29304120879;23666.526669466857;62713.37286627075;63517.682411587644;64766.35233647603;65577.34422655712;66689.33310667025;82430.17569824465;82738.17261827545;83008;83530.58234709031;84369.15630843613;16490.83509164893;16930.492085237463;17041;17153.742693859353;17226.397076102276;24630.630540541548;24772.628410574216;24905.128320508695;24947.62578561287;25000.74999249984;19430.708539372205;20129.79870201279;20181.49546261355;20390.388288351372;20399.59200816005;17396.739048914023;17721;17946.461606151835;18056.368027118988;18370.81629183691;19708.901455493204;20462.590748185252;20660.690089648968;20847.37457876266;20932.16271349129;16598.087105209328;16610.58473538171;16653.084080375695;16666.50000499987;16845.747313790056;19832.801671983096;19855.702164467257;20173;20270.898645506677;20380.08289627 12:25:50 INFO - PID 6476 | |3;mootools.html;1423.9644008899777;1460.9780853287202;1481.3259966715132;1484.487851691167;1498.7152441036205;16451.670966580677;17269.136543172837;17292.048937308427;17406.738898916494;17434.476965691018;16776.580585485368;16889.662206755856;16949.83050169501;17078;17147.142642867868;2904.1287613715854;2944.9852750736322;2945.896893608724;2949.911502654924;2950.7934444588886;2858.6855445900933;2895.2617082644;2941.279386550298;2951.439226546949;2952.6013988111654;2916.6937471565498;2945.39619378027;2981.3590078133197;2982.060650894972;2983.3436643938408;2816.3381605322734;2830.745232929036;2860.199144239616;2871.483133036042;2926.9853650731825;2877.5539791332167;2904.099729083991;2907.0552070577146;2911.213972227487;2911.708829117071;16902.323907043705;17021.404250851283;17025.148742562822;17026.659466810717;17040.233189506504;8421.536815475147;8424.620892059873;8800;8824.117588241188;8835.734927952108;5755.827325180251;5955.434233747787;6064.696765161724;6167.722452489649;6184.690765461709;2116.9576608467896;2161.384005558424;2161.4164175672636;2167.53398019425;2198.41658097302;30939.690603093906;31098.378032439225;31268;31324.21689457759;32110.678893211003;7528.397728181732;7598;7675.347595454449;7724.536527808349;7830.373570114377;20365;20415.183392664425;20426.182952681727;20483.795162048486;20551.383458496268;8709.738707838775;8899.688510902088;8900.287976961827;8905.955470222738;8930.19628233462;7519.924800752032;7685.692572297157;7758.68965241384;7790.5325680459355;7896.131425543185;5781.392953739797;5891.587588868738;5989.8203053908455;6013.218281623361;6017.217761690952;1688.814230434651;1745.4850819008423;1756.0956107604593;1764.2854643869252;1767.169430367725;999.9900100898145;1007.8236308645958;1013.8834034086175;1017.5370206555999;1040.4433628008978;9036.457812531138;9118.72031992002;9138.223251023737;9201.125893040151;9242.12199841014;785.53653344527;801.8997625296838;811.1158836867843;822.551709318411;831.339085427087;5426.8914621707345;5455.645383050089;5469.15228139631;5910.527157827363;6289.685515724195;25118;25509.872450637627;25657.48685026289;25829.095981640552;25843.61234581483;24235.636465453033;26284.605730914052;26309.473810523683;26329.341766455993;26367.208983730518;11044.558217671363;11077.667669969915;12472.563460279029;12662.873371266169;12805.295708736108;9551.474668893277;9927.503624818875;10064.597416103274;10241;10299.948500257451;21418.250361237282;21425;21475.355739327846;21480.78519214788;22085.779142208372;21948.451288717908;22052.558948821254;22065.33803985883;22170.667439988734;22403.43991400163;12634.747305054032;12855.421506032064;12860.807087893501;12877.484900603871;12878.227306361649;15539.611509712347;15684.294206760494;15815.288312025756;15900.204989750697;15961.521154365388;11785.823212651989;11800.52797888075;11812.055035597303;12084.154109212272;12259.509619615115;12090.879091209326;12333.260004399765;12352.444140013542;12531.18547294423;12565.246085234916;10880.619178328721;10953.397563134104;11036.11711063129;11127.499262533367;11144.665660030212;8442.197991190827;8704.738857834274;8736.432131911406;8808.647654093764;8848.64605415802;8695.60869760875;8865.64537418496;8893.866592001255;8895.955520222358;8924.955375223082 12:25:50 INFO - PID 6476 | |4;prototype.html;550.9752061157247;568.9745053744751;581.3111462916444;588.596811184339;589.0457458916555;6179.196704428424;6204.503639708818;6339.429451349378;6346.238451385841;6392.968035159824;6224.315325314223;6242.563020588561;6275.623462592248;6280.120783090371;6324.1462402575635;5183.222516622518;5185.092608793446;5194.688318700881;5237.47625237477;5248.396434410053;4865.562099411052;5026.396832380119;5182.714950677711;5188.584913206934;5213.478652134775;4988.875278118058;4998.925016124761;5005.124103281929;5023.472535383768;5037.798488060474;4945.975270123627;4996.500349964975;5005.299258103868;5015.774290156952;5024.874378140521;4508.120916421299;4584.174848527264;4585.987261146497;4586.862394128181;4599.471060827981;6078.756849726005;6081.908771368388;6108.847278818021;6153.015787343135;6193.783217587363;5916.230889984317;5918.881622367571;5920.911186332209;5934.287885453773;5962.34414214436;6644.966775166142;6670.966000269966;6690.63201523916;6714.899276510856;6743.831404214885;5163;5197.532222100029;5199.376074871002;5214.270002199695;5225.712585807779;6697.03963472505;6749.7300107995625;6844.828879278008;6850.725970961155;6973.302669733037;5229.869253268699;5265.893123057414;5270.151460656206;5274.525292723597;5332.7067011313975;5346.7861285548925;5349.277847490617;5349.759260833272;5361.31118697609;5417.918731219035;5914.349421563625;5956.493698035629;5970.552208584373;5978.103284507359;5995.880082398327;6623.443490779663;6634.369734875179;6699.564528305645;6770.424513916274;6778.4916131289365;1828.9725654115198;1832.3037245846492;1858.293848337623;1858.87917285376;1873.7095750158746;1292.5734507612465;1333.513267657298;1335.3256605414203;1336.8663133686553;1341.9194848309132;5969.671668058211;6029.8191054268445;6068.33248342682;6072.423119803611;6126.203593532812;6617.933820661732;6750.886103792819;6784.423324017415;6795.791367805483;6838.555493892881;6028.306744724325;6153.753849845956;6165.242905771834;6194.5044396448175;6273.404026617464;3527.5061491391225;3559.6796288334176;3576.302620988882;3610.2779444111284;3618.800965946898;7062.752803651848;7083.397911177504;7106.786796396116;7139.714411423485;7140.714371425085;6946.722131114699;6985.89521157183;7033.507654464139;7103.964480177566;7107.395871350993;7042.190148133031;7047.929520704727;7054.6472676365975;7092.943046516659;7097.899825527052;6762.289959554373;6781.457483401415;6790.388865002174;6803.625800581016;6813.318668133147;6620.966895165493;6698.229703583956;6721.563098398588;6728.428083612947;6747.325267473213;6930.618815964968;6943.340382663639;6963.9651801740665;7065.964670176616;7080.539764915264;5225.216217567396;5287.709175995357;5306.681599104066;5306.789392417686;5324.680519168863;6638.734450622114;6654;6735.191776986793;6749.49378796602;6810.31896810315;6500;6534.640594767334;6542.934570654233;6600.471962243105;6656.068150458843;6423.29343772194;6453.354394629528;6499.707513162014;6629.138212032405;6648.767293144717;6324;6372.458341040878;6382.329855365306;6391.2330520337855;6460.547761656639;6600.636964966973;6662.200535935525;6662.500312476487;6701.564398314094;6713.261541230559;6335.556511044367;6391.360863913572;6412.871742565029;6464.935350646433;6521.934780652323 12:25:50 INFO - PID 6476 | |5;yui.html;986.7089208683437;1005.3716427232978;1009.2481101579325;1015.7460634841285;1034.059006304263;20201.696974545375;20381;20555.177792888284;20620.381388558366;20649.483762905937;18137;18137;18302.26790928361;19180;19412.51468713283;1051.532068229638;1052.5263631365879;1052.557925671218;1058.5871510111062;1062.1237479079753;1048.8426735989585;1057.5505410200672;1066.632011955874;1067.9038886500214;1082.112667612558;1124.6569796212152;1128.6783266768973;1129.6385156749843;1133.5692436873976;1136.0343707848303;1126.2960649594004;1130.203206739251;1132.2074547816521;1132.5809450503325;1135.6422726841101;836.0719601242616;836.1053672570353;836.6193382011231;838.7357982235576;839.030919288217;19949.401517954484;20044.59910801776;20074.698879516818;20190.293339733038;20232.39302820903;23150.53698926012;23545.646815297783;23859.88070059656;23897;23903.880480597487;18268.086595670295;18277.3602923897;18347.082645867653;18421.723674144898;18465.44603661879;3962.0491082140366;4038.7778672173017;4072.5723799000975;4072.5927407259037;4075.735077219971;119608;139333;153015.23492382467;166966;169428.15285923614;16694.081825499714;17032.57418564521;17042.403515876886;17058.317667293417;17940.19269132892;34548.13629659228;36007.4598881017;36135;36137.63862361343;36188.819055904554;9966.302358834811;10144.340617859816;10200.846987295197;10208.285420020677;10288.331258468175;4758.2386818108935;4773.9761301193275;4819.855404337875;4826.420829500483;4832.9275060874115;5882.323532793698;5905.173275741399;5911.261092363455;5936.851578710567;5937.554683398763;1149.8102813035755;1186.424584076722;1194.4923407551755;1202.104432198018;1202.1584890576632;739.8853177757456;752.8720117579915;771.248033167657;774.3727580659684;775.9612019399008;13276.933615331862;13459.663508412368;13539.932300338436;13686.452541898412;13819.516316928859;733.886247631618;738.3059923671732;753.0549160803266;755.4107795919192;758.4766511107318;6071.2714474263375;6237.1891654084675;6248.375162483806;6271.404216599416;6272.560920735505;156455;158011;158142.2092889551;158391;160627;134377;140233;141556.5844341564;142660;145251.5474845238;120514;124085.37957310336;124514;125975;127365;11546.59586914454;11619.30284182918;11748.118891083031;11795.52817887275;11990.760184796081;54182.72908635432;56372;56626;57479.712601436724;58029.709851452164;71355.92966105409;71874;73381.63309183634;74038;74747.62626186834;16506.917465412596;16593.83406165923;16684.082375469465;16724.16379181012;16996.320147194467;18294.90852545729;18363.724544131583;18374;18461.353852615095;18480.353187638368;17536.210870510604;17542.298308067533;17586.912065439592;17645.29418823233;17747.556311092325;18204.544886377946;18390.540236494195;18491.075446227904;18619.627607448045;18696.439106826816;17395.739063914305;17472.91263543674;17496.47510574685;17689.557761055563;17732.202050908;11772.234804737665;11952.34262115592;12133.878661213275;12287.262764233818;12421.93789031049;12806.295653739135;12918.547850825176;12930.030247731269;13014.089013768946;13138.605841824761 12:25:50 INFO - PID 6476 | __end_tp_report 12:25:50 INFO - PID 6476 | __start_cc_report 12:25:50 INFO - PID 6476 | _x_x_mozilla_cycle_collect,263 12:25:50 INFO - PID 6476 | __end_cc_report 12:25:50 INFO - PID 6476 | __startTimestamp1507058750695__endTimestamp 12:25:50 INFO - PID 6476 | 12:25:50 INFO - PID 6476 | ------- Summary: start ------- 12:25:50 INFO - PID 6476 | Number of tests: 6 12:25:50 INFO - PID 6476 | 12:25:50 INFO - PID 6476 | [#0] dojo.html Cycles:165 Average:6325.22 Median:6654.83 stddev:892.84 (13.4%) stddev-sans-first:874.00 12:25:50 INFO - PID 6476 | Values: 3838.1 3909.7 3913.6 3930.3 3941.9 6219.0 6299.8 6316.9 6472.8 6473.0 6352.5 6368.1 6373.8 6378.1 6397.8 5662.3 5668.4 5686.6 5705.0 5745.5 5719.8 5726.5 5744.7 5783.6 5791.3 5726.2 5777.5 5788.0 5832.5 5848.9 546.1 5271.7 5687.2 5703.9 5808.0 5676.7 5703.9 5711.2 5759.9 5763.6 6305.8 6361.0 6363.2 6426.8 6426.9 6898.1 6911.2 6926.3 6986.6 7021.7 6951.1 6975.8 7038.6 7042.0 7044.5 6313.4 6368.5 6426.0 6430.8 6436.2 7102.9 7174.3 7189.2 7201.5 7218.7 6812.1 6815.2 6869.0 6901.1 6912.2 6821.3 6913.7 6926.7 6934.0 6944.8 6834.8 6849.2 6852.7 6883.0 6956.1 6861.4 6946.5 6948.1 6952.3 6961.9 4950.2 4958.4 5054.3 5056.7 5056.9 4473.5 4493.7 4503.8 4514.3 4516.1 6367.8 6370.5 6409.5 6414.3 6417.2 6863.7 6864.9 6867.8 6943.7 6979.2 6301.9 6304.1 6307.8 6379.6 6426.4 5542.4 5555.5 5556.6 5558.6 5562.6 7014.8 7059.5 7067.4 7170.6 7180.0 6859.5 6876.9 6884.4 6895.6 6904.5 7108.3 7116.5 7132.0 7154.0 7157.7 6765.7 6769.4 6806.7 6819.5 6827.9 6888.9 6892.3 6954.3 6971.8 7022.3 6674.6 6680.5 6687.9 6775.3 6781.7 6565.9 6653.5 6679.4 6762.4 6768.5 6654.8 6678.4 6678.5 6683.7 6691.4 6755.3 6761.7 6832.5 6834.0 6854.0 6519.5 6520.3 6601.6 6612.8 6618.7 12:25:50 INFO - PID 6476 | 12:25:50 INFO - PID 6476 | [#1] ext.html Cycles:180 Average:43907.30 Median:35957.64 stddev:68140.37 (189.5%) stddev-sans-first:68255.17 12:25:50 INFO - PID 6476 | Values: 947.6 961.8 976.9 1018.7 1025.1 43937.3 45010.3 45118.8 45199.3 45340.5 40946.2 41134.6 41187.8 41395.6 41432.4 7437.9 7542.5 7545.6 7550.1 7568.2 7568.1 7576.5 7637.0 7649.3 7666.6 7685.3 8341.3 8510.2 8540.1 8555.1 8435.7 8508.7 8514.8 8516.8 8517.4 8271.3 8394.0 8441.9 8494.8 8503.0 41411.4 41769.6 41922.4 41924.4 42039.4 3694.3 3743.7 3743.8 3748.2 3750.7 33496.3 33626.2 33852.3 34012.3 34014.7 5404.9 5463.9 5488.9 5500.8 5505.0 242628.0 244967.0 245821.0 246098.0 247129.0 54249.7 54307.7 54321.0 54401.0 54544.0 57459.7 57468.4 57476.0 57488.7 57508.0 16591.2 16860.0 16862.8 16872.8 16873.4 13579.5 13643.0 13647.9 13664.1 13711.2 15288.2 15407.2 15523.4 15549.4 15664.8 6090.9 6097.9 6233.0 6267.8 6330.9 1104.8 1105.9 1109.4 1113.3 1126.6 25520.9 25522.5 25527.6 25623.2 25822.7 1194.9 1220.5 1221.5 1222.7 1223.4 13241.5 13304.8 13383.1 13532.7 13609.0 292735.0 294932.0 294935.0 295572.0 296125.0 51471.7 52321.0 57431.0 58210.4 58839.7 1540.3 1552.8 1555.2 1558.5 1568.9 30507.8 30773.4 31211.7 31637.2 31689.4 41201.4 41273.6 41360.0 41393.8 41419.0 240436.0 241555.0 242190.0 243389.0 243610.0 35633.3 35820.8 35913.1 35932.0 35983.3 44971.3 45344.3 45354.3 45564.3 45924.0 34280.5 34585.0 34758.7 34930.3 34935.3 33932.5 34303.8 34398.0 34427.5 35096.3 39680.8 39902.8 40339.4 40363.4 40431.0 33627.7 33926.5 33950.7 34363.0 34569.7 25871.2 25926.4 26079.0 26179.2 26943.2 12:25:50 INFO - PID 6476 | 12:25:50 INFO - PID 6476 | [#2] jquery.html Cycles:180 Average:39959.31 Median:12822.03 stddev:98088.74 (765.0%) stddev-sans-first:98319.41 12:25:50 INFO - PID 6476 | Values: 608.4 624.3 630.6 634.8 647.7 22350.9 23274.9 23563.3 23574.3 23582.6 24053.0 25411.2 25437.5 25460.9 25464.4 6628.0 6740.2 6810.9 6812.7 6815.5 6583.2 6758.7 6808.5 6855.0 6872.1 6780.2 6837.2 6860.7 6864.4 6875.9 6668.6 6966.3 6966.6 6994.3 6994.7 6513.3 6534.4 6551.3 6553.8 6563.5 29303.4 29844.6 30037.1 30112.8 30191.5 2270.7 2307.3 2329.2 2334.6 2353.6 19915.0 20605.1 20675.6 20678.8 20687.2 2419.9 2444.5 2496.7 2512.6 2535.0 148134.0 155449.0 165781.0 171900.0 172186.0 16449.3 17105.9 17140.0 17354.2 17989.0 27378.7 27415.2 27420.6 27429.5 27481.0 10860.9 10967.8 11087.1 11113.7 11174.9 9583.8 9753.3 9844.6 9890.9 9986.9 9866.7 10127.5 10188.7 10319.6 10642.0 2796.7 2844.9 2848.3 3052.1 3060.2 1032.3 1038.2 1051.6 1065.4 1074.5 22078.6 22358.6 22642.7 22734.4 22912.0 1097.7 1125.2 1129.9 1138.4 1152.9 12176.8 12246.6 12288.8 12439.8 12644.4 572209.0 573279.0 582658.0 587384.0 596540.0 127249.0 129128.0 130115.3 130801.0 133046.3 1091.3 1221.3 1242.4 1245.1 1251.2 22841.5 23228.3 23314.9 23565.3 23666.5 62713.4 63517.7 64766.4 65577.3 66689.3 82430.2 82738.2 83008.0 83530.6 84369.2 16490.8 16930.5 17041.0 17153.7 17226.4 24630.6 24772.6 24905.1 24947.6 25000.7 19430.7 20129.8 20181.5 20390.4 20399.6 17396.7 17721.0 17946.5 18056.4 18370.8 19708.9 20462.6 20660.7 20847.4 20932.2 16598.1 16610.6 16653.1 16666.5 16845.7 19832.8 19855.7 20173.0 20270.9 20380.1 12:25:50 INFO - PID 6476 | 12:25:50 INFO - PID 6476 | [#3] mootools.html Cycles:180 Average:10645.18 Median:26348.28 stddev:7875.99 (29.9%) stddev-sans-first:7867.61 12:25:50 INFO - PID 6476 | Values: 1424.0 1461.0 1481.3 1484.5 1498.7 16451.7 17269.1 17292.0 17406.7 17434.5 16776.6 16889.7 16949.8 17078.0 17147.1 2904.1 2945.0 2945.9 2949.9 2950.8 2858.7 2895.3 2941.3 2951.4 2952.6 2916.7 2945.4 2981.4 2982.1 2983.3 2816.3 2830.7 2860.2 2871.5 2927.0 2877.6 2904.1 2907.1 2911.2 2911.7 16902.3 17021.4 17025.1 17026.7 17040.2 8421.5 8424.6 8800.0 8824.1 8835.7 5755.8 5955.4 6064.7 6167.7 6184.7 2117.0 2161.4 2161.4 2167.5 2198.4 30939.7 31098.4 31268.0 31324.2 32110.7 7528.4 7598.0 7675.3 7724.5 7830.4 20365.0 20415.2 20426.2 20483.8 20551.4 8709.7 8899.7 8900.3 8906.0 8930.2 7519.9 7685.7 7758.7 7790.5 7896.1 5781.4 5891.6 5989.8 6013.2 6017.2 1688.8 1745.5 1756.1 1764.3 1767.2 1000.0 1007.8 1013.9 1017.5 1040.4 9036.5 9118.7 9138.2 9201.1 9242.1 785.5 801.9 811.1 822.6 831.3 5426.9 5455.6 5469.2 5910.5 6289.7 25118.0 25509.9 25657.5 25829.1 25843.6 24235.6 26284.6 26309.5 26329.3 26367.2 11044.6 11077.7 12472.6 12662.9 12805.3 9551.5 9927.5 10064.6 10241.0 10299.9 21418.3 21425.0 21475.4 21480.8 22085.8 21948.5 22052.6 22065.3 22170.7 22403.4 12634.7 12855.4 12860.8 12877.5 12878.2 15539.6 15684.3 15815.3 15900.2 15961.5 11785.8 11800.5 11812.1 12084.2 12259.5 12090.9 12333.3 12352.4 12531.2 12565.2 10880.6 10953.4 11036.1 11127.5 11144.7 8442.2 8704.7 8736.4 8808.6 8848.6 8695.6 8865.6 8893.9 8896.0 8925.0 12:25:50 INFO - PID 6476 | 12:25:50 INFO - PID 6476 | [#4] prototype.html Cycles:180 Average:5669.82 Median:6214.41 stddev:1567.11 (25.2%) stddev-sans-first:1523.68 12:25:50 INFO - PID 6476 | Values: 551.0 569.0 581.3 588.6 589.0 6179.2 6204.5 6339.4 6346.2 6393.0 6224.3 6242.6 6275.6 6280.1 6324.1 5183.2 5185.1 5194.7 5237.5 5248.4 4865.6 5026.4 5182.7 5188.6 5213.5 4988.9 4998.9 5005.1 5023.5 5037.8 4946.0 4996.5 5005.3 5015.8 5024.9 4508.1 4584.2 4586.0 4586.9 4599.5 6078.8 6081.9 6108.8 6153.0 6193.8 5916.2 5918.9 5920.9 5934.3 5962.3 6645.0 6671.0 6690.6 6714.9 6743.8 5163.0 5197.5 5199.4 5214.3 5225.7 6697.0 6749.7 6844.8 6850.7 6973.3 5229.9 5265.9 5270.2 5274.5 5332.7 5346.8 5349.3 5349.8 5361.3 5417.9 5914.3 5956.5 5970.6 5978.1 5995.9 6623.4 6634.4 6699.6 6770.4 6778.5 1829.0 1832.3 1858.3 1858.9 1873.7 1292.6 1333.5 1335.3 1336.9 1341.9 5969.7 6029.8 6068.3 6072.4 6126.2 6617.9 6750.9 6784.4 6795.8 6838.6 6028.3 6153.8 6165.2 6194.5 6273.4 3527.5 3559.7 3576.3 3610.3 3618.8 7062.8 7083.4 7106.8 7139.7 7140.7 6946.7 6985.9 7033.5 7104.0 7107.4 7042.2 7047.9 7054.6 7092.9 7097.9 6762.3 6781.5 6790.4 6803.6 6813.3 6621.0 6698.2 6721.6 6728.4 6747.3 6930.6 6943.3 6964.0 7066.0 7080.5 5225.2 5287.7 5306.7 5306.8 5324.7 6638.7 6654.0 6735.2 6749.5 6810.3 6500.0 6534.6 6542.9 6600.5 6656.1 6423.3 6453.4 6499.7 6629.1 6648.8 6324.0 6372.5 6382.3 6391.2 6460.5 6600.6 6662.2 6662.5 6701.6 6713.3 6335.6 6391.4 6412.9 6464.9 6521.9 12:25:50 INFO - PID 6476 | 12:25:50 INFO - PID 6476 | [#5] yui.html Cycles:180 Average:28786.23 Median:17739.88 stddev:43566.87 (245.6%) stddev-sans-first:43639.08 12:25:50 INFO - PID 6476 | Values: 986.7 1005.4 1009.2 1015.7 1034.1 20201.7 20381.0 20555.2 20620.4 20649.5 18137.0 18137.0 18302.3 19180.0 19412.5 1051.5 1052.5 1052.6 1058.6 1062.1 1048.8 1057.6 1066.6 1067.9 1082.1 1124.7 1128.7 1129.6 1133.6 1136.0 1126.3 1130.2 1132.2 1132.6 1135.6 836.1 836.1 836.6 838.7 839.0 19949.4 20044.6 20074.7 20190.3 20232.4 23150.5 23545.6 23859.9 23897.0 23903.9 18268.1 18277.4 18347.1 18421.7 18465.4 3962.0 4038.8 4072.6 4072.6 4075.7 119608.0 139333.0 153015.2 166966.0 169428.2 16694.1 17032.6 17042.4 17058.3 17940.2 34548.1 36007.5 36135.0 36137.6 36188.8 9966.3 10144.3 10200.8 10208.3 10288.3 4758.2 4774.0 4819.9 4826.4 4832.9 5882.3 5905.2 5911.3 5936.9 5937.6 1149.8 1186.4 1194.5 1202.1 1202.2 739.9 752.9 771.2 774.4 776.0 13276.9 13459.7 13539.9 13686.5 13819.5 733.9 738.3 753.1 755.4 758.5 6071.3 6237.2 6248.4 6271.4 6272.6 156455.0 158011.0 158142.2 158391.0 160627.0 134377.0 140233.0 141556.6 142660.0 145251.5 120514.0 124085.4 124514.0 125975.0 127365.0 11546.6 11619.3 11748.1 11795.5 11990.8 54182.7 56372.0 56626.0 57479.7 58029.7 71355.9 71874.0 73381.6 74038.0 74747.6 16506.9 16593.8 16684.1 16724.2 16996.3 18294.9 18363.7 18374.0 18461.4 18480.4 17536.2 17542.3 17586.9 17645.3 17747.6 18204.5 18390.5 18491.1 18619.6 18696.4 17395.7 17472.9 17496.5 17689.6 17732.2 11772.2 11952.3 12133.9 12287.3 12421.9 12806.3 12918.5 12930.0 13014.1 13138.6 12:25:50 INFO - PID 6476 | -------- Summary: end -------- 12:25:50 INFO - PID 6476 | 12:25:51 INFO - TEST-INFO | 6476: exit 0 12:25:51 INFO - TEST-OK | dromaeo_css | took 1108081ms 12:25:51 INFO - TEST-START | kraken 12:25:51 INFO - Initialising browser for kraken test... 12:25:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33324/getInfo.html -profile /tmp/tmpXNPtXQ/profile 12:25:51 INFO - TEST-INFO | started process 6874 (/builds/slave/test/build/application/firefox/firefox http://localhost:33324/getInfo.html) 12:25:56 INFO - TEST-INFO | 6874: exit 0 12:25:56 INFO - Browser initialized. 12:25:56 INFO - Running cycle 1/1 for kraken test... 12:25:56 INFO - Using env: {'DISPLAY': ':0', 12:25:56 INFO - 'HOME': '/home/cltbld', 12:25:56 INFO - 'JSGC_DISABLE_POISONING': '1', 12:25:56 INFO - 'LANG': 'en_US.UTF-8', 12:25:56 INFO - 'LANGUAGE': 'en_US:en', 12:25:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:25:56 INFO - 'LOGNAME': 'cltbld', 12:25:56 INFO - 'MAIL': '/var/mail/cltbld', 12:25:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:25:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:25:56 INFO - 'MOZ_CRASHREPORTER': '1', 12:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:25:56 INFO - 'MOZ_NO_REMOTE': '1', 12:25:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:56 INFO - 'NO_EM_RESTART': '1', 12:25:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:56 INFO - 'PWD': '/builds/slave/test', 12:25:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:25:56 INFO - 'RUST_BACKTRACE': 'full', 12:25:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:25:56 INFO - 'SHELL': '/bin/bash', 12:25:56 INFO - 'SHLVL': '1', 12:25:56 INFO - 'STYLO_FORCE_DISABLED': '1', 12:25:56 INFO - 'TERM': 'linux', 12:25:56 INFO - 'TMOUT': '86400', 12:25:56 INFO - 'USER': 'cltbld', 12:25:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1507057582.425595-871374012', 12:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:56 INFO - '_': '/tools/buildbot/bin/python'} 12:25:56 INFO - TEST-INFO | started process 7151 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXNPtXQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:25:57 INFO - PID 7151 | 12:25:57 INFO - PID 7151 | (/builds/slave/test/build/application/firefox/firefox:7200): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:25:57 INFO - PID 7151 | 12:26:08 INFO - PID 7151 | RSS: Main: 146714624 12:26:08 INFO - PID 7151 | 12:26:10 INFO - PID 7151 | Cycle 1(1): loaded http://localhost:33324/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33324/tests/kraken/driver.html?testName=audio-beat-detection) 12:26:11 INFO - PID 7151 | RSS: Main: 152190976 12:26:11 INFO - PID 7151 | 12:26:14 INFO - PID 7151 | Cycle 1(1): loaded http://localhost:33324/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33324/tests/kraken/driver.html?testName=audio-dft) 12:26:14 INFO - PID 7151 | RSS: Main: 152412160 12:26:14 INFO - PID 7151 | 12:26:17 INFO - PID 7151 | Cycle 1(1): loaded http://localhost:33324/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33324/tests/kraken/driver.html?testName=audio-fft) 12:26:18 INFO - PID 7151 | RSS: Main: 148602880 12:26:18 INFO - PID 7151 | 12:26:20 INFO - PID 7151 | Cycle 1(1): loaded http://localhost:33324/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33324/tests/kraken/driver.html?testName=audio-oscillator) 12:26:20 INFO - PID 7151 | RSS: Main: 150175744 12:26:20 INFO - PID 7151 | 12:26:22 INFO - PID 7151 | Cycle 1(1): loaded http://localhost:33324/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33324/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:26:23 INFO - PID 7151 | RSS: Main: 150171648 12:26:23 INFO - PID 7151 | 12:26:26 INFO - PID 7151 | Cycle 1(1): loaded http://localhost:33324/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33324/tests/kraken/driver.html?testName=imaging-darkroom) 12:26:27 INFO - PID 7151 | RSS: Main: 149876736 12:26:27 INFO - PID 7151 | 12:26:30 INFO - PID 7151 | Cycle 1(1): loaded http://localhost:33324/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33324/tests/kraken/driver.html?testName=imaging-desaturate) 12:26:31 INFO - PID 7151 | RSS: Main: 150814720 12:26:31 INFO - PID 7151 | 12:26:34 INFO - PID 7151 | Cycle 1(1): loaded http://localhost:33324/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33324/tests/kraken/driver.html?testName=json-parse-financial) 12:26:34 INFO - PID 7151 | RSS: Main: 152416256 12:26:34 INFO - PID 7151 | 12:26:36 INFO - PID 7151 | Cycle 1(1): loaded http://localhost:33324/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33324/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:26:36 INFO - PID 7151 | RSS: Main: 152305664 12:26:36 INFO - PID 7151 | 12:26:38 INFO - PID 7151 | Cycle 1(1): loaded http://localhost:33324/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33324/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:26:39 INFO - PID 7151 | RSS: Main: 152915968 12:26:39 INFO - PID 7151 | 12:26:40 INFO - PID 7151 | Cycle 1(1): loaded http://localhost:33324/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33324/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:26:41 INFO - PID 7151 | RSS: Main: 149823488 12:26:41 INFO - PID 7151 | 12:26:44 INFO - PID 7151 | Cycle 1(1): loaded http://localhost:33324/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:26:44 INFO - PID 7151 | RSS: Main: 149528576 12:26:44 INFO - PID 7151 | 12:26:47 INFO - PID 7151 | Cycle 1(1): loaded http://localhost:33324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:26:47 INFO - PID 7151 | RSS: Main: 149905408 12:26:47 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | Cycle 1(1): loaded http://localhost:33324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33324/tests/kraken/driver.html?testName=ai-astar) 12:26:49 INFO - PID 7151 | RSS: Main: 151740416 12:26:49 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | __start_tp_report 12:26:49 INFO - PID 7151 | _x_x_mozilla_page_load 12:26:49 INFO - PID 7151 | _x_x_mozilla_page_load_details 12:26:49 INFO - PID 7151 | |i|pagename|runs| 12:26:49 INFO - PID 7151 | |0;ai-astar;105;105;105;105;108;107;106;112;105;104 12:26:49 INFO - PID 7151 | |1;audio-beat-detection;112;124;116;110;112;111;113;113;120;111 12:26:49 INFO - PID 7151 | |2;audio-dft;163;164;163;162;169;163;166;162;164;169 12:26:49 INFO - PID 7151 | |3;audio-fft;73;76;80;76;74;83;73;72;74;74 12:26:49 INFO - PID 7151 | |4;audio-oscillator;79;78;80;77;77;77;78;78;77;78 12:26:49 INFO - PID 7151 | |5;imaging-gaussian-blur;110;113;114;113;109;114;114;114;114;110 12:26:49 INFO - PID 7151 | |6;imaging-darkroom;150;150;149;158;150;150;152;150;149;150 12:26:49 INFO - PID 7151 | |7;imaging-desaturate;101;94;94;95;94;94;93;95;95;95 12:26:49 INFO - PID 7151 | |8;json-parse-financial;48;45;46;45;45;46;45;44;43;43 12:26:49 INFO - PID 7151 | |9;json-stringify-tinderbox;36;35;36;36;35;35;36;35;35;37 12:26:49 INFO - PID 7151 | |10;stanford-crypto-aes;72;71;70;69;71;69;67;71;76;70 12:26:49 INFO - PID 7151 | |11;stanford-crypto-ccm;111;112;116;106;107;106;105;101;106;101 12:26:49 INFO - PID 7151 | |12;stanford-crypto-pbkdf2;145;147;150;148;146;153;153;152;149;145 12:26:49 INFO - PID 7151 | |13;stanford-crypto-sha256-iterative;59;66;58;57;58;60;57;58;60;59 12:26:49 INFO - PID 7151 | __end_tp_report 12:26:49 INFO - PID 7151 | __start_cc_report 12:26:49 INFO - PID 7151 | _x_x_mozilla_cycle_collect,714 12:26:49 INFO - PID 7151 | __end_cc_report 12:26:49 INFO - PID 7151 | __startTimestamp1507058809873__endTimestamp 12:26:49 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | ------- Summary: start ------- 12:26:49 INFO - PID 7151 | Number of tests: 14 12:26:49 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | [#0] ai-astar Cycles:10 Average:106.20 Median:105.50 stddev:2.35 (2.2%) stddev-sans-first:2.45 12:26:49 INFO - PID 7151 | Values: 105.0 105.0 105.0 105.0 108.0 107.0 106.0 112.0 105.0 104.0 12:26:49 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | [#1] audio-beat-detection Cycles:10 Average:114.20 Median:113.00 stddev:4.52 (4.0%) stddev-sans-first:4.72 12:26:49 INFO - PID 7151 | Values: 112.0 124.0 116.0 110.0 112.0 111.0 113.0 113.0 120.0 111.0 12:26:49 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.64 (1.6%) stddev-sans-first:2.74 12:26:49 INFO - PID 7151 | Values: 163.0 164.0 163.0 162.0 169.0 163.0 166.0 162.0 164.0 169.0 12:26:49 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | [#3] audio-fft Cycles:10 Average:75.50 Median:75.00 stddev:3.47 (4.6%) stddev-sans-first:3.56 12:26:49 INFO - PID 7151 | Values: 73.0 76.0 80.0 76.0 74.0 83.0 73.0 72.0 74.0 74.0 12:26:49 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:78.00 stddev:0.99 (1.3%) stddev-sans-first:0.97 12:26:49 INFO - PID 7151 | Values: 79.0 78.0 80.0 77.0 77.0 77.0 78.0 78.0 77.0 78.0 12:26:49 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | [#5] imaging-gaussian-blur Cycles:10 Average:112.50 Median:114.00 stddev:2.01 (1.8%) stddev-sans-first:1.92 12:26:49 INFO - PID 7151 | Values: 110.0 113.0 114.0 113.0 109.0 114.0 114.0 114.0 114.0 110.0 12:26:49 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:150.00 stddev:2.66 (1.8%) stddev-sans-first:2.80 12:26:49 INFO - PID 7151 | Values: 150.0 150.0 149.0 158.0 150.0 150.0 152.0 150.0 149.0 150.0 12:26:49 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.50 stddev:2.21 (2.3%) stddev-sans-first:0.71 12:26:49 INFO - PID 7151 | Values: 101.0 94.0 94.0 95.0 94.0 94.0 93.0 95.0 95.0 95.0 12:26:49 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | [#8] json-parse-financial Cycles:10 Average:45.00 Median:45.00 stddev:1.49 (3.3%) stddev-sans-first:1.12 12:26:49 INFO - PID 7151 | Values: 48.0 45.0 46.0 45.0 45.0 46.0 45.0 44.0 43.0 43.0 12:26:49 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | [#9] json-stringify-tinderbox Cycles:10 Average:35.60 Median:36.00 stddev:0.70 (1.9%) stddev-sans-first:0.73 12:26:49 INFO - PID 7151 | Values: 36.0 35.0 36.0 36.0 35.0 35.0 36.0 35.0 35.0 37.0 12:26:49 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | [#10] stanford-crypto-aes Cycles:10 Average:70.60 Median:71.00 stddev:2.37 (3.3%) stddev-sans-first:2.46 12:26:49 INFO - PID 7151 | Values: 72.0 71.0 70.0 69.0 71.0 69.0 67.0 71.0 76.0 70.0 12:26:49 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | [#11] stanford-crypto-ccm Cycles:10 Average:107.10 Median:106.50 stddev:4.72 (4.4%) stddev-sans-first:4.80 12:26:49 INFO - PID 7151 | Values: 111.0 112.0 116.0 106.0 107.0 106.0 105.0 101.0 106.0 101.0 12:26:49 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:149.50 stddev:3.12 (2.1%) stddev-sans-first:2.99 12:26:49 INFO - PID 7151 | Values: 145.0 147.0 150.0 148.0 146.0 153.0 153.0 152.0 149.0 145.0 12:26:49 INFO - PID 7151 | 12:26:49 INFO - PID 7151 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.20 Median:59.00 stddev:2.62 (4.4%) stddev-sans-first:2.77 12:26:49 INFO - PID 7151 | Values: 59.0 66.0 58.0 57.0 58.0 60.0 57.0 58.0 60.0 59.0 12:26:49 INFO - PID 7151 | -------- Summary: end -------- 12:26:49 INFO - PID 7151 | 12:26:50 INFO - PID 7151 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:26:50 INFO - TEST-INFO | 7151: exit 0 12:26:50 INFO - TEST-OK | kraken | took 59287ms 12:26:50 INFO - SUITE-END | took 1167s 12:26:50 INFO - Completed test suite (00:19:27) 12:26:50 INFO - javascript benchmark 12:26:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9188.961540887201, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3838.0788610733425, 3909.6872250219985, 3913.608639136087, 3930.331843586591, 3941.86203482878, 6218.968905155479, 6299.843666514951, 6316.905246421307, 6472.8381790455205, 6473.02904564315, 6352.491800655948, 6368.108464814918, 6373.776917807878, 6378.107065010902, 6397.8400539986405, 5662.292213473316, 5668.43315668434, 5686.630369026021, 5705.030144875361, 5745.482906538432, 5719.799807006755, 5726.455986681259, 5744.6840423776675, 5783.566232532556, 5791.276090488689, 5726.226959360475, 5777.480026797587, 5787.971060144693, 5832.533397328203, 5848.912266316009, 546.1119081779053, 5271.710055946922, 5687.203791469197, 5703.942960570383, 5808.041673123972, 5676.744546495376, 5703.914441283384, 5711.200431939532, 5759.942400575983, 5763.596548241583, 6305.779297724557, 6360.968195159041, 6363.236411630634, 6426.775062872824, 6426.907425737636, 6898.1377327834025, 6911.205211400653, 6926.341997510229, 6986.61573613451, 7021.719131234796, 6951.08054617062, 6975.755848545327, 7038.6128762918015, 7041.964790176016, 7044.506884518086, 6313.431791138773, 6368.458681012119, 6426.036094585803, 6430.774922877724, 6436.195475565554, 7102.928970710227, 7174.3184397482155, 7189.245129261457, 7201.459890508233, 7218.711251549879, 6812.080369150101, 6815.182178138556, 6868.965655171693, 6901.068355772007, 6912.239653638096, 6821.317868213238, 6913.654317284116, 6926.722931082801, 6934.029235906977, 6944.791656250321, 6834.794956151323, 6849.2465828758795, 6852.6916288767125, 6882.965585172142, 6956.060931774247, 6861.416779573692, 6946.548474349152, 6948.096747422803, 6952.270011648805, 6961.860762784716, 4950.232713929347, 4958.380202474691, 5054.317667114892, 5056.721880296619, 5056.924146137811, 4473.485549161823, 4493.73037617744, 4503.797329120198, 4514.32285157229, 4516.141933032779, 6367.840803979845, 6370.522210834206, 6409.487241020707, 6414.326495717975, 6417.229932408048, 6863.725450981905, 6864.931350686529, 6867.83246848037, 6943.72225111, 6979.162500499972, 6301.936980630227, 6304.085907543381, 6307.779227727099, 6379.553431259767, 6426.3573642635365, 5542.445755424425, 5555.50000499957, 5556.583256255797, 5558.583106267046, 5562.554995600342, 7014.754483593049, 7059.470539709542, 7067.363937245673, 7170.6056166910275, 7179.964100179465, 6859.451243900576, 6876.896846547305, 6884.449244060564, 6895.620740859301, 6904.482163837632, 7108.324709152622, 7116.466265030247, 7132.0, 7153.964230179024, 7157.713691452492, 6765.661716914036, 6769.424598909148, 6806.659667016728, 6819.488538359742, 6827.863442731217, 6888.931110689029, 6892.310768923067, 6954.3393377629045, 6971.755988540377, 7022.262662420372, 6674.599524028574, 6680.4989625779235, 6687.899681504684, 6775.254721980677, 6781.694823732845, 6565.868682626417, 6653.534252602271, 6679.398854103154, 6762.357576030269, 6768.492363072888, 6654.83362915931, 6678.365555272241, 6678.465722742072, 6683.732650693918, 6691.364320389555, 6755.3244675534015, 6761.729530818909, 6832.521723479309, 6834.0, 6854.0, 6519.478441724746, 6520.250171230179, 6601.636909969998, 6612.801615951529, 6618.702158402787], "value": 6264.221870464519, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [947.6493697331988, 961.8028304197641, 976.9120779129879, 1018.6994836523224, 1025.0979138358243, 43937.34093988593, 45010.32484512731, 45118.77440612792, 45199.322010169875, 45340.54659453413, 40946.18107637853, 41134.58865411345, 41187.79406102965, 41395.58604413955, 41432.378514322234, 7437.888431673529, 7542.547447153188, 7545.584992825392, 7550.0939887213335, 7568.205338439468, 7568.09182898053, 7576.469647124703, 7637.045369328834, 7649.273319034711, 7666.616669166548, 7685.346745526609, 8341.332693384546, 8510.1915318045, 8540.103289154642, 8555.10171432, 8435.662573497053, 8508.74473765788, 8514.829703405929, 8516.78708032298, 8517.44636598619, 8271.255586997138, 8393.958030209871, 8441.915580844236, 8494.78763030923, 8503.022152452486, 41411.37882931758, 41769.582304176874, 41922.37116443256, 41924.37113443301, 42039.36940945888, 3694.2796154749835, 3743.7005039596766, 3743.794091324976, 3748.231612519427, 3750.7374483786148, 33496.33007339839, 33626.1593460163, 33852.32295354079, 34012.319753605036, 34014.659853401645, 5404.891902161974, 5463.9180412293845, 5488.874780669953, 5500.834974950758, 5505.0, 242628.0, 244967.0, 245821.0, 246098.0, 247129.0, 54249.72875135599, 54307.72846135744, 54321.0, 54401.0, 54544.0, 57459.71270143623, 57468.42531574715, 57476.0, 57488.712556437786, 57508.0, 16591.170441477876, 16860.0, 16862.83137168637, 16872.83127168737, 16873.39702728239, 13579.45682172702, 13643.0, 13647.931760341135, 13664.111832730841, 13711.245881476614, 15288.235588220545, 15407.229638518253, 15523.357481888583, 15549.378024878879, 15664.843351566566, 6090.9390906090375, 6097.908531372033, 6233.0, 6267.800573615688, 6330.873382532415, 1104.7845670094255, 1105.8783533811275, 1109.367660433545, 1113.33200079953, 1126.6113190949109, 25520.872395637904, 25522.48955020889, 25527.61708574373, 25623.231303060937, 25822.74177258241, 1194.924567888907, 1220.5117952818944, 1221.4625564751482, 1222.7248869004402, 1223.424990254579, 13241.470341186438, 13304.800427993589, 13383.063185577112, 13532.661683457993, 13609.0, 292735.0, 294932.0, 294935.0, 295572.0, 296125.0, 51471.74264128655, 52321.0, 57431.0, 58210.4178958205, 58839.70580147072, 1540.2991638804317, 1552.8136623605014, 1555.2146166186003, 1558.516859773474, 1568.8588027077617, 30507.847460762554, 30773.384532309676, 31211.68364619308, 31637.20906977344, 31689.36621267608, 41201.38197926973, 41273.587264128175, 41360.0, 41393.79303103465, 41419.0, 240436.0, 241555.0, 242190.0, 243389.0, 243610.0, 35633.28733425369, 35820.820895895355, 35913.10217244485, 35932.0, 35983.28033439369, 44971.32543011923, 45344.31983520184, 45354.319685204086, 45564.31653525266, 45924.0, 34280.48579271263, 34585.0, 34758.65241347655, 34930.301393972484, 34935.30129397449, 33932.49101263434, 34303.82848085744, 34398.0, 34427.4835877457, 35096.29807403889, 39680.80159599299, 39902.80048599738, 40339.3949090758, 40363.3945490812, 40431.0, 33627.66372336343, 33926.491102633976, 33950.66049339475, 34363.0, 34569.65430345664, 25871.223863284133, 25926.35184120412, 26079.0, 26179.214623561325, 26943.191704248904], "value": 18833.384313879684, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.4463138543925, 624.3226099681845, 630.6032138812529, 634.7968650031991, 647.7311915555043, 22350.88824555877, 23274.88362558189, 23563.29310120695, 23574.29277121689, 23582.646260306065, 24053.0, 25411.237662870142, 25437.491250174986, 25460.872695636543, 25464.36339091519, 6628.038934354528, 6740.191177058735, 6810.931890681104, 6812.727490900358, 6815.454763618898, 6583.2429270633775, 6758.695858686371, 6808.523403361766, 6855.040294358794, 6872.106626138595, 6780.186377634691, 6837.1795384553925, 6860.72557097718, 6864.382205601495, 6875.931240687604, 6668.599884006975, 6966.268541803139, 6966.5820050796865, 6994.265602111806, 6994.685239164199, 6513.348665133496, 6534.411902928711, 6551.344865513458, 6553.836154096138, 6563.54055216135, 29303.413931721247, 29844.55233171504, 30037.098887033422, 30112.84943575268, 30191.547126793117, 2270.738865030526, 2307.3424074138957, 2329.1847853251397, 2334.579775640384, 2353.576356255873, 19915.0, 20605.072771725307, 20675.5864882703, 20678.793212067987, 20687.172513099456, 2419.8669073200967, 2444.4744379958215, 2496.6504689343506, 2512.648229247907, 2534.9873250633814, 148134.0, 155449.0, 165781.0, 171900.0, 172186.0, 16449.25978330978, 17105.914470427568, 17140.0, 17354.219060142324, 17989.0, 27378.726212737616, 27415.17754467369, 27420.588691169647, 27429.45141097207, 27481.0, 10860.891391086147, 10967.780644387067, 11087.113030957504, 11113.666590002313, 11174.944125279322, 9583.808323833484, 9753.317267791328, 9844.556994935245, 9890.851637225447, 9986.900130998742, 9866.703998880044, 10127.544260508295, 10188.745281367877, 10319.587216511256, 10642.0, 2796.6504186976626, 2844.9146525604265, 2848.273690209025, 3052.084374687585, 3060.173753086654, 1032.2980373346047, 1038.2420832792104, 1051.6109039655375, 1065.3767545985686, 1074.505727365405, 22078.558428831333, 22358.55282894333, 22642.66036009461, 22734.431639209153, 22912.0, 1097.6981330134277, 1125.189863298424, 1129.88701129888, 1138.430784607696, 1152.9077673786078, 12176.81734773979, 12246.571370002008, 12288.815667764991, 12439.813402798965, 12644.43100060481, 572209.0, 573279.0, 582658.0, 587384.0, 596540.0, 127249.0, 129128.0, 130115.34942325228, 130801.0, 133046.33476832553, 1091.3015669971226, 1221.3099598726692, 1242.3912282981455, 1245.1346314311465, 1251.167973297765, 22841.543169136858, 23228.3031509055, 23314.883425582764, 23565.29304120879, 23666.526669466857, 62713.37286627075, 63517.682411587644, 64766.35233647603, 65577.34422655712, 66689.33310667025, 82430.17569824465, 82738.17261827545, 83008.0, 83530.58234709031, 84369.15630843613, 16490.83509164893, 16930.492085237463, 17041.0, 17153.742693859353, 17226.397076102276, 24630.630540541548, 24772.628410574216, 24905.128320508695, 24947.62578561287, 25000.74999249984, 19430.708539372205, 20129.79870201279, 20181.49546261355, 20390.388288351372, 20399.59200816005, 17396.739048914023, 17721.0, 17946.461606151835, 18056.368027118988, 18370.81629183691, 19708.901455493204, 20462.590748185252, 20660.690089648968, 20847.37457876266, 20932.16271349129, 16598.087105209328, 16610.58473538171, 16653.084080375695, 16666.50000499987, 16845.747313790056, 19832.801671983096, 19855.702164467257, 20173.0, 20270.898645506677, 20380.08289627], "value": 13134.403729135194, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.9644008899777, 1460.9780853287202, 1481.3259966715132, 1484.487851691167, 1498.7152441036205, 16451.670966580677, 17269.136543172837, 17292.048937308427, 17406.738898916494, 17434.476965691018, 16776.580585485368, 16889.662206755856, 16949.83050169501, 17078.0, 17147.142642867868, 2904.1287613715854, 2944.9852750736322, 2945.896893608724, 2949.911502654924, 2950.7934444588886, 2858.6855445900933, 2895.2617082644, 2941.279386550298, 2951.439226546949, 2952.6013988111654, 2916.6937471565498, 2945.39619378027, 2981.3590078133197, 2982.060650894972, 2983.3436643938408, 2816.3381605322734, 2830.745232929036, 2860.199144239616, 2871.483133036042, 2926.9853650731825, 2877.5539791332167, 2904.099729083991, 2907.0552070577146, 2911.213972227487, 2911.708829117071, 16902.323907043705, 17021.404250851283, 17025.148742562822, 17026.659466810717, 17040.233189506504, 8421.536815475147, 8424.620892059873, 8800.0, 8824.117588241188, 8835.734927952108, 5755.827325180251, 5955.434233747787, 6064.696765161724, 6167.722452489649, 6184.690765461709, 2116.9576608467896, 2161.384005558424, 2161.4164175672636, 2167.53398019425, 2198.41658097302, 30939.690603093906, 31098.378032439225, 31268.0, 31324.21689457759, 32110.678893211003, 7528.397728181732, 7598.0, 7675.347595454449, 7724.536527808349, 7830.373570114377, 20365.0, 20415.183392664425, 20426.182952681727, 20483.795162048486, 20551.383458496268, 8709.738707838775, 8899.688510902088, 8900.287976961827, 8905.955470222738, 8930.19628233462, 7519.924800752032, 7685.692572297157, 7758.68965241384, 7790.5325680459355, 7896.131425543185, 5781.392953739797, 5891.587588868738, 5989.8203053908455, 6013.218281623361, 6017.217761690952, 1688.814230434651, 1745.4850819008423, 1756.0956107604593, 1764.2854643869252, 1767.169430367725, 999.9900100898145, 1007.8236308645958, 1013.8834034086175, 1017.5370206555999, 1040.4433628008978, 9036.457812531138, 9118.72031992002, 9138.223251023737, 9201.125893040151, 9242.12199841014, 785.53653344527, 801.8997625296838, 811.1158836867843, 822.551709318411, 831.339085427087, 5426.8914621707345, 5455.645383050089, 5469.15228139631, 5910.527157827363, 6289.685515724195, 25118.0, 25509.872450637627, 25657.48685026289, 25829.095981640552, 25843.61234581483, 24235.636465453033, 26284.605730914052, 26309.473810523683, 26329.341766455993, 26367.208983730518, 11044.558217671363, 11077.667669969915, 12472.563460279029, 12662.873371266169, 12805.295708736108, 9551.474668893277, 9927.503624818875, 10064.597416103274, 10241.0, 10299.948500257451, 21418.250361237282, 21425.0, 21475.355739327846, 21480.78519214788, 22085.779142208372, 21948.451288717908, 22052.558948821254, 22065.33803985883, 22170.667439988734, 22403.43991400163, 12634.747305054032, 12855.421506032064, 12860.807087893501, 12877.484900603871, 12878.227306361649, 15539.611509712347, 15684.294206760494, 15815.288312025756, 15900.204989750697, 15961.521154365388, 11785.823212651989, 11800.52797888075, 11812.055035597303, 12084.154109212272, 12259.509619615115, 12090.879091209326, 12333.260004399765, 12352.444140013542, 12531.18547294423, 12565.246085234916, 10880.619178328721, 10953.397563134104, 11036.11711063129, 11127.499262533367, 11144.665660030212, 8442.197991190827, 8704.738857834274, 8736.432131911406, 8808.647654093764, 8848.64605415802, 8695.60869760875, 8865.64537418496, 8893.866592001255, 8895.955520222358, 8924.955375223082], "value": 7452.719161194253, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.9752061157247, 568.9745053744751, 581.3111462916444, 588.596811184339, 589.0457458916555, 6179.196704428424, 6204.503639708818, 6339.429451349378, 6346.238451385841, 6392.968035159824, 6224.315325314223, 6242.563020588561, 6275.623462592248, 6280.120783090371, 6324.1462402575635, 5183.222516622518, 5185.092608793446, 5194.688318700881, 5237.47625237477, 5248.396434410053, 4865.562099411052, 5026.396832380119, 5182.714950677711, 5188.584913206934, 5213.478652134775, 4988.875278118058, 4998.925016124761, 5005.124103281929, 5023.472535383768, 5037.798488060474, 4945.975270123627, 4996.500349964975, 5005.299258103868, 5015.774290156952, 5024.874378140521, 4508.120916421299, 4584.174848527264, 4585.987261146497, 4586.862394128181, 4599.471060827981, 6078.756849726005, 6081.908771368388, 6108.847278818021, 6153.015787343135, 6193.783217587363, 5916.230889984317, 5918.881622367571, 5920.911186332209, 5934.287885453773, 5962.34414214436, 6644.966775166142, 6670.966000269966, 6690.63201523916, 6714.899276510856, 6743.831404214885, 5163.0, 5197.532222100029, 5199.376074871002, 5214.270002199695, 5225.712585807779, 6697.03963472505, 6749.7300107995625, 6844.828879278008, 6850.725970961155, 6973.302669733037, 5229.869253268699, 5265.893123057414, 5270.151460656206, 5274.525292723597, 5332.7067011313975, 5346.7861285548925, 5349.277847490617, 5349.759260833272, 5361.31118697609, 5417.918731219035, 5914.349421563625, 5956.493698035629, 5970.552208584373, 5978.103284507359, 5995.880082398327, 6623.443490779663, 6634.369734875179, 6699.564528305645, 6770.424513916274, 6778.4916131289365, 1828.9725654115198, 1832.3037245846492, 1858.293848337623, 1858.87917285376, 1873.7095750158746, 1292.5734507612465, 1333.513267657298, 1335.3256605414203, 1336.8663133686553, 1341.9194848309132, 5969.671668058211, 6029.8191054268445, 6068.33248342682, 6072.423119803611, 6126.203593532812, 6617.933820661732, 6750.886103792819, 6784.423324017415, 6795.791367805483, 6838.555493892881, 6028.306744724325, 6153.753849845956, 6165.242905771834, 6194.5044396448175, 6273.404026617464, 3527.5061491391225, 3559.6796288334176, 3576.302620988882, 3610.2779444111284, 3618.800965946898, 7062.752803651848, 7083.397911177504, 7106.786796396116, 7139.714411423485, 7140.714371425085, 6946.722131114699, 6985.89521157183, 7033.507654464139, 7103.964480177566, 7107.395871350993, 7042.190148133031, 7047.929520704727, 7054.6472676365975, 7092.943046516659, 7097.899825527052, 6762.289959554373, 6781.457483401415, 6790.388865002174, 6803.625800581016, 6813.318668133147, 6620.966895165493, 6698.229703583956, 6721.563098398588, 6728.428083612947, 6747.325267473213, 6930.618815964968, 6943.340382663639, 6963.9651801740665, 7065.964670176616, 7080.539764915264, 5225.216217567396, 5287.709175995357, 5306.681599104066, 5306.789392417686, 5324.680519168863, 6638.734450622114, 6654.0, 6735.191776986793, 6749.49378796602, 6810.31896810315, 6500.0, 6534.640594767334, 6542.934570654233, 6600.471962243105, 6656.068150458843, 6423.29343772194, 6453.354394629528, 6499.707513162014, 6629.138212032405, 6648.767293144717, 6324.0, 6372.458341040878, 6382.329855365306, 6391.2330520337855, 6460.547761656639, 6600.636964966973, 6662.200535935525, 6662.500312476487, 6701.564398314094, 6713.261541230559, 6335.556511044367, 6391.360863913572, 6412.871742565029, 6464.935350646433, 6521.934780652323], "value": 5223.347293019212, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [986.7089208683437, 1005.3716427232978, 1009.2481101579325, 1015.7460634841285, 1034.059006304263, 20201.696974545375, 20381.0, 20555.177792888284, 20620.381388558366, 20649.483762905937, 18137.0, 18137.0, 18302.26790928361, 19180.0, 19412.51468713283, 1051.532068229638, 1052.5263631365879, 1052.557925671218, 1058.5871510111062, 1062.1237479079753, 1048.8426735989585, 1057.5505410200672, 1066.632011955874, 1067.9038886500214, 1082.112667612558, 1124.6569796212152, 1128.6783266768973, 1129.6385156749843, 1133.5692436873976, 1136.0343707848303, 1126.2960649594004, 1130.203206739251, 1132.2074547816521, 1132.5809450503325, 1135.6422726841101, 836.0719601242616, 836.1053672570353, 836.6193382011231, 838.7357982235576, 839.030919288217, 19949.401517954484, 20044.59910801776, 20074.698879516818, 20190.293339733038, 20232.39302820903, 23150.53698926012, 23545.646815297783, 23859.88070059656, 23897.0, 23903.880480597487, 18268.086595670295, 18277.3602923897, 18347.082645867653, 18421.723674144898, 18465.44603661879, 3962.0491082140366, 4038.7778672173017, 4072.5723799000975, 4072.5927407259037, 4075.735077219971, 119608.0, 139333.0, 153015.23492382467, 166966.0, 169428.15285923614, 16694.081825499714, 17032.57418564521, 17042.403515876886, 17058.317667293417, 17940.19269132892, 34548.13629659228, 36007.4598881017, 36135.0, 36137.63862361343, 36188.819055904554, 9966.302358834811, 10144.340617859816, 10200.846987295197, 10208.285420020677, 10288.331258468175, 4758.2386818108935, 4773.9761301193275, 4819.855404337875, 4826.420829500483, 4832.9275060874115, 5882.323532793698, 5905.173275741399, 5911.261092363455, 5936.851578710567, 5937.554683398763, 1149.8102813035755, 1186.424584076722, 1194.4923407551755, 1202.104432198018, 1202.1584890576632, 739.8853177757456, 752.8720117579915, 771.248033167657, 774.3727580659684, 775.9612019399008, 13276.933615331862, 13459.663508412368, 13539.932300338436, 13686.452541898412, 13819.516316928859, 733.886247631618, 738.3059923671732, 753.0549160803266, 755.4107795919192, 758.4766511107318, 6071.2714474263375, 6237.1891654084675, 6248.375162483806, 6271.404216599416, 6272.560920735505, 156455.0, 158011.0, 158142.2092889551, 158391.0, 160627.0, 134377.0, 140233.0, 141556.5844341564, 142660.0, 145251.5474845238, 120514.0, 124085.37957310336, 124514.0, 125975.0, 127365.0, 11546.59586914454, 11619.30284182918, 11748.118891083031, 11795.52817887275, 11990.760184796081, 54182.72908635432, 56372.0, 56626.0, 57479.712601436724, 58029.709851452164, 71355.92966105409, 71874.0, 73381.63309183634, 74038.0, 74747.62626186834, 16506.917465412596, 16593.83406165923, 16684.082375469465, 16724.16379181012, 16996.320147194467, 18294.90852545729, 18363.724544131583, 18374.0, 18461.353852615095, 18480.353187638368, 17536.210870510604, 17542.298308067533, 17586.912065439592, 17645.29418823233, 17747.556311092325, 18204.544886377946, 18390.540236494195, 18491.075446227904, 18619.627607448045, 18696.439106826816, 17395.739063914305, 17472.91263543674, 17496.47510574685, 17689.557761055563, 17732.202050908, 11772.234804737665, 11952.34262115592, 12133.878661213275, 12287.262764233818, 12421.93789031049, 12806.295653739135, 12918.547850825176, 12930.030247731269, 13014.089013768946, 13138.605841824761], "value": 9979.350409905204, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1362.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 105.0, 105.0, 108.0, 107.0, 106.0, 112.0, 105.0, 104.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 124.0, 116.0, 110.0, 112.0, 111.0, 113.0, 113.0, 120.0, 111.0], "value": 114.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 162.0, 169.0, 163.0, 166.0, 162.0, 164.0, 169.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 80.0, 76.0, 74.0, 83.0, 73.0, 72.0, 74.0, 74.0], "value": 75.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 80.0, 77.0, 77.0, 77.0, 78.0, 78.0, 77.0, 78.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 114.0, 113.0, 109.0, 114.0, 114.0, 114.0, 114.0, 110.0], "value": 112.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 158.0, 150.0, 150.0, 152.0, 150.0, 149.0, 150.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 94.0, 94.0, 95.0, 94.0, 94.0, 93.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 45.0, 46.0, 45.0, 45.0, 46.0, 45.0, 44.0, 43.0, 43.0], "value": 45.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 35.0, 36.0, 36.0, 35.0, 35.0, 36.0, 35.0, 35.0, 37.0], "value": 35.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 70.0, 69.0, 71.0, 69.0, 67.0, 71.0, 76.0, 70.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 116.0, 106.0, 107.0, 106.0, 105.0, 101.0, 106.0, 101.0], "value": 107.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 150.0, 148.0, 146.0, 153.0, 153.0, 152.0, 149.0, 145.0], "value": 148.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 66.0, 58.0, 57.0, 58.0, 60.0, 57.0, 58.0, 60.0, 59.0], "value": 59.2, "unit": "score"}]}]} 12:26:50 INFO - Return code: 0 12:26:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:26:50 INFO - # TBPL SUCCESS # 12:26:50 INFO - Running post-action listener: _package_coverage_data 12:26:50 INFO - Running post-action listener: _resource_record_post_action 12:26:50 INFO - [mozharness: 2017-10-03 19:26:50.666752Z] Finished run-tests step (success) 12:26:50 INFO - Running post-run listener: _resource_record_post_run 12:26:50 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 81920; Write bytes: 323411968; Read time: 80; Write time: 239184 12:26:50 INFO - TinderboxPrint: CPU usage
13.1% 12:26:50 INFO - TinderboxPrint: I/O read bytes / time
81,920 / 80 12:26:50 INFO - TinderboxPrint: I/O write bytes / time
323,411,968 / 239,184 12:26:50 INFO - TinderboxPrint: CPU idle
8,210.4 (86.9%) 12:26:50 INFO - TinderboxPrint: CPU user
1,187.0 (12.6%) 12:26:50 INFO - TinderboxPrint: Swap in / out
0 / 0 12:26:50 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13172736; Read time: 0; Write time: 2308 12:26:50 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:26:50 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 81920; Write bytes: 310239232; Read time: 80; Write time: 236876 12:26:51 INFO - Running post-run listener: _upload_blobber_files 12:26:51 INFO - Blob upload gear active. 12:26:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:26:51 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 12:26:51 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'] 12:26:51 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 12:26:51 INFO - (blobuploader) - INFO - Open directory for files ... 12:26:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:26:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:26:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:26:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:26:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:26:52 INFO - (blobuploader) - INFO - Done attempting. 12:26:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:26:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:26:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:27:00 INFO - (blobuploader) - INFO - Done attempting. 12:27:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 12:27:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:27:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:27:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 12:27:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:27:01 INFO - (blobuploader) - INFO - Done attempting. 12:27:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 12:27:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:27:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:27:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 12:27:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:27:02 INFO - (blobuploader) - INFO - Done attempting. 12:27:02 INFO - (blobuploader) - INFO - Iteration through files over. 12:27:02 INFO - Return code: 0 12:27:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:27:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:27:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18fe88ef1a0c7ea67a717b838f4bc9f825a0a214658420011735155109e92eb19142495bf4fce14f27e6561303e5001ab53763152b0f61930c0752835b51f5ea", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dff078f1f50ac59d48fc1d1d0605369a215d4a7247113db3339bde7664fdc2b70f451085c8231893f9bd4359f25a7dd6ed9c7f0639eca4fb111ac7521b8de2da", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2baf011b97fd23cc7026bb460ab13ca74a6a5378710dbf521e2c47142ff5ecfe7ac45ad92069bce47aee68243e383524056a94919a086d5d5a369d869c17504a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96fc00111e73091ef0c16d41a0dde5013eacb4625bfdce061cfe83580f0655a483ccb999bce669a1c96a13d3d9ed5c83ce91bff534c4c6636507171cf45d81da"} 12:27:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:27:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:27:02 INFO - Contents: 12:27:02 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18fe88ef1a0c7ea67a717b838f4bc9f825a0a214658420011735155109e92eb19142495bf4fce14f27e6561303e5001ab53763152b0f61930c0752835b51f5ea", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dff078f1f50ac59d48fc1d1d0605369a215d4a7247113db3339bde7664fdc2b70f451085c8231893f9bd4359f25a7dd6ed9c7f0639eca4fb111ac7521b8de2da", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2baf011b97fd23cc7026bb460ab13ca74a6a5378710dbf521e2c47142ff5ecfe7ac45ad92069bce47aee68243e383524056a94919a086d5d5a369d869c17504a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96fc00111e73091ef0c16d41a0dde5013eacb4625bfdce061cfe83580f0655a483ccb999bce669a1c96a13d3d9ed5c83ce91bff534c4c6636507171cf45d81da"} 12:27:02 INFO - Running post-run listener: copy_logs_to_upload_dir 12:27:02 INFO - Copying logs to upload dir... 12:27:02 INFO - mkdir: /builds/slave/test/build/upload/logs 12:27:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.403147 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-10-03 12:27:02.179051) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-03 12:27:02.182277) ========= 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=745a4373a2a16df560f216e000000264-1507057582.425595-871374012 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/18fe88ef1a0c7ea67a717b838f4bc9f825a0a214658420011735155109e92eb19142495bf4fce14f27e6561303e5001ab53763152b0f61930c0752835b51f5ea", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dff078f1f50ac59d48fc1d1d0605369a215d4a7247113db3339bde7664fdc2b70f451085c8231893f9bd4359f25a7dd6ed9c7f0639eca4fb111ac7521b8de2da", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2baf011b97fd23cc7026bb460ab13ca74a6a5378710dbf521e2c47142ff5ecfe7ac45ad92069bce47aee68243e383524056a94919a086d5d5a369d869c17504a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96fc00111e73091ef0c16d41a0dde5013eacb4625bfdce061cfe83580f0655a483ccb999bce669a1c96a13d3d9ed5c83ce91bff534c4c6636507171cf45d81da"} build_url:https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/Ff5cRZkeTlSpMEK3fGAQkw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18fe88ef1a0c7ea67a717b838f4bc9f825a0a214658420011735155109e92eb19142495bf4fce14f27e6561303e5001ab53763152b0f61930c0752835b51f5ea", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dff078f1f50ac59d48fc1d1d0605369a215d4a7247113db3339bde7664fdc2b70f451085c8231893f9bd4359f25a7dd6ed9c7f0639eca4fb111ac7521b8de2da", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2baf011b97fd23cc7026bb460ab13ca74a6a5378710dbf521e2c47142ff5ecfe7ac45ad92069bce47aee68243e383524056a94919a086d5d5a369d869c17504a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96fc00111e73091ef0c16d41a0dde5013eacb4625bfdce061cfe83580f0655a483ccb999bce669a1c96a13d3d9ed5c83ce91bff534c4c6636507171cf45d81da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-03 12:27:02.211086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 12:27:02.211402) ========= 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=745a4373a2a16df560f216e000000264-1507057582.425595-871374012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 12:27:02.298327) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-03 12:27:02.298628) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-03 12:27:02.299024) ========= ========= Total master_lag: 0.18 =========