builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-056 starttime: 1505081422.9 results: success (0) revision: a5f163da8a9be5d2e86138c57d59be69723b5457 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-10 15:10:22.903068) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-10 15:10:22.903532) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-10 15:10:22.903891) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-10 15:10:22.967173) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 15:10:22.967535) ========= 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=52faae308a556c440401f8e5000001e8-1505080420.940871-177585425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-10 15:10:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.5M=0s 2017-09-10 15:10:23 (36.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113534 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 15:10:23.118906) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 15:10:23.119183) ========= 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=52faae308a556c440401f8e5000001e8-1505080420.940871-177585425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021796 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 15:10:23.209168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 15:10:23.209473) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a5f163da8a9be5d2e86138c57d59be69723b5457 --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 a5f163da8a9be5d2e86138c57d59be69723b5457 --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=52faae308a556c440401f8e5000001e8-1505080420.940871-177585425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-10 15:10:23,263 truncating revision to first 12 chars 2017-09-10 15:10:23,263 Setting DEBUG logging. 2017-09-10 15:10:23,263 attempt 1/10 2017-09-10 15:10:23,263 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a5f163da8a9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-10 15:10:23,640 unpacking tar archive at: mozilla-central-a5f163da8a9b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.672098 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 15:10:23.895501) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-10 15:10:23.895810) ========= script_repo_revision: a5f163da8a9be5d2e86138c57d59be69723b5457 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-10 15:10:23.896182) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-10 15:10:23.896461) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-10 15:10:23.907311) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-10 15:10:23.907666) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1505080420.940871-177585425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:10:24 INFO - MultiFileLogger online at 20170910 15:10:24 in /builds/slave/test 15:10:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:10:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:10:24 INFO - {'append_to_log': False, 15:10:24 INFO - 'base_work_dir': '/builds/slave/test', 15:10:24 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:10:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:10:24 INFO - 'branch': 'Firefox-Non-PGO', 15:10:24 INFO - 'buildbot_json_path': 'buildprops.json', 15:10:24 INFO - 'code_coverage': False, 15:10:24 INFO - 'config_files': ('talos/linux_config.py',), 15:10:24 INFO - 'default_actions': ('clobber', 15:10:24 INFO - 'read-buildbot-config', 15:10:24 INFO - 'download-and-extract', 15:10:24 INFO - 'populate-webroot', 15:10:24 INFO - 'create-virtualenv', 15:10:24 INFO - 'install', 15:10:24 INFO - 'setup-mitmproxy', 15:10:24 INFO - 'run-tests'), 15:10:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:10:24 INFO - 'disable_ccov_upload': False, 15:10:24 INFO - 'disable_stylo': False, 15:10:24 INFO - 'download_minidump_stackwalk': True, 15:10:24 INFO - 'download_symbols': 'ondemand', 15:10:24 INFO - 'enable_stylo': False, 15:10:24 INFO - 'enable_webrender': False, 15:10:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:10:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:10:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:10:24 INFO - 'gecko_profile': False, 15:10:24 INFO - 'gecko_profile_interval': 0, 15:10:24 INFO - 'installer_path': 'installer.exe', 15:10:24 INFO - 'log_level': 'info', 15:10:24 INFO - 'log_name': 'talos', 15:10:24 INFO - 'log_to_console': True, 15:10:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:10:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:10:24 INFO - 'opt_config_files': (), 15:10:24 INFO - 'pip_index': False, 15:10:24 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:10:24 INFO - 'system_bits': '32', 15:10:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:10:24 INFO - 'title': 'talos-linux64-ix-056', 15:10:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:10:24 INFO - 'use_talos_json': True, 15:10:24 INFO - 'verify': 'False', 15:10:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:10:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:10:24 INFO - 'work_dir': 'build'} 15:10:24 INFO - [mozharness: 2017-09-10 22:10:24.099882Z] Running clobber step. 15:10:24 INFO - Running pre-action listener: _resource_record_pre_action 15:10:24 INFO - Running main action method: clobber 15:10:24 INFO - rmtree: /builds/slave/test/build 15:10:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:10:25 INFO - Running post-action listener: _resource_record_post_action 15:10:25 INFO - [mozharness: 2017-09-10 22:10:25.630722Z] Finished clobber step (success) 15:10:25 INFO - [mozharness: 2017-09-10 22:10:25.630819Z] Running read-buildbot-config step. 15:10:25 INFO - Running pre-action listener: _resource_record_pre_action 15:10:25 INFO - Running main action method: read_buildbot_config 15:10:25 INFO - Using buildbot properties: 15:10:25 INFO - { 15:10:25 INFO - "project": "", 15:10:25 INFO - "product": "firefox", 15:10:25 INFO - "who": "archaeopteryx@coole-files.de", 15:10:25 INFO - "installer_path": "public/build/target.tar.bz2", 15:10:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:10:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:10:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 15:10:25 INFO - "stage_platform": "linux64", 15:10:25 INFO - "basedir": "/builds/slave/test", 15:10:25 INFO - "buildnumber": 8, 15:10:25 INFO - "platform": "ubuntu64_hw", 15:10:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:10:25 INFO - "slavebuilddir": "test", 15:10:25 INFO - "taskId": "W7Q6TVY3RuiVLqvKXA5ixA", 15:10:25 INFO - "branch": "mozilla-central", 15:10:25 INFO - "script_repo_revision": "production", 15:10:25 INFO - "revision": "a5f163da8a9be5d2e86138c57d59be69723b5457", 15:10:25 INFO - "slavename": "talos-linux64-ix-056", 15:10:25 INFO - "repo_path": "mozilla-central" 15:10:25 INFO - } 15:10:25 INFO - Finding installer, test and symbols from parent task. 15:10:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W7Q6TVY3RuiVLqvKXA5ixA'}, attempt #1 15:10:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W7Q6TVY3RuiVLqvKXA5ixA'}, attempt #1 15:10:26 INFO - Task dependencies: a9nroRyvTkaMibioQYD-ow 15:10:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow'}, attempt #1 15:10:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.tar.bz2 15:10:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.test_packages.json 15:10:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.crashreporter-symbols.zip 15:10:27 INFO - Running post-action listener: _resource_record_post_action 15:10:27 INFO - [mozharness: 2017-09-10 22:10:27.016391Z] Finished read-buildbot-config step (success) 15:10:27 INFO - [mozharness: 2017-09-10 22:10:27.016608Z] Running download-and-extract step. 15:10:27 INFO - Running pre-action listener: _resource_record_pre_action 15:10:27 INFO - Running main action method: download_and_extract 15:10:27 INFO - mkdir: /builds/slave/test/build/tests 15:10: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')]} 15:10:27 INFO - trying https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.test_packages.json 15:10:27 INFO - Downloading https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:10:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:10:27 INFO - Downloaded 989 bytes. 15:10:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:10:27 INFO - Using the following test package requirements: 15:10:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:10:27 INFO - u'common': [u'target.common.tests.zip'], 15:10:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:10:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:10:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:10:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:10:27 INFO - u'mozbase': [u'target.common.tests.zip'], 15:10:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:10:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:10:27 INFO - u'web-platform': [u'target.common.tests.zip', 15:10:27 INFO - u'target.web-platform.tests.tar.gz'], 15:10:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:10:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:10:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.common.tests.zip 15:10:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:10:27 INFO - Fetch https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.common.tests.zip into memory 15:10:29 INFO - Content-Length response header: 55028468 15:10:29 INFO - Bytes received: 55028468 15:10:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.talos.tests.zip 15:10:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:10:39 INFO - Fetch https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.talos.tests.zip into memory 15:10:40 INFO - Content-Length response header: 14497963 15:10:40 INFO - Bytes received: 14497963 15:10:40 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')]} 15:10:40 INFO - trying https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.tar.bz2 15:10:40 INFO - Downloading https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:10:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:10:42 INFO - Downloaded 62878907 bytes. 15:10:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.tar.bz2 15:10:42 INFO - mkdir: /builds/slave/test/properties 15:10:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:10:42 INFO - Writing to file /builds/slave/test/properties/build_url 15:10:42 INFO - Contents: 15:10:42 INFO - build_url:https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.tar.bz2 15:10:42 INFO - Running post-action listener: _resource_record_post_action 15:10:42 INFO - Running post-action listener: find_tests_for_verification 15:10:42 INFO - Running post-action listener: set_extra_try_arguments 15:10:42 INFO - [mozharness: 2017-09-10 22:10:42.494525Z] Finished download-and-extract step (success) 15:10:42 INFO - [mozharness: 2017-09-10 22:10:42.494623Z] Running populate-webroot step. 15:10:42 INFO - Running pre-action listener: _resource_record_pre_action 15:10:42 INFO - Running main action method: populate_webroot 15:10:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:10:42 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:10:42 INFO - 'tests': ['tresize', 15:10:42 INFO - 'tcanvasmark']}, 15:10:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:10:42 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:10:42 INFO - 'tests': ['dromaeo_css', 15:10:42 INFO - 'kraken']}, 15:10:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:10:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:42 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:10:42 INFO - 'talos_options': ['--disable-stylo'], 15:10:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:10:42 INFO - 'tests': ['damp', 'tps']}, 15:10:42 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:10:42 INFO - 'talos_options': ['--disable-stylo'], 15:10:42 INFO - 'tests': ['damp', 'tps']}, 15:10:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:10:42 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:10:42 INFO - 'tests': ['dromaeo_dom']}, 15:10:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:10:42 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:10:42 INFO - 'tests': ['basic_compositor_video', 15:10:42 INFO - 'glvideo']}, 15:10:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:10:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:10:42 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:10:42 INFO - 'talos_options': ['--disable-stylo'], 15:10:42 INFO - 'tests': ['ts_paint_webext', 15:10:42 INFO - 'tp5o_webext']}, 15:10:42 INFO - 'other-e10s': {'tests': ['a11yr', 15:10:42 INFO - 'ts_paint', 15:10:42 INFO - 'tpaint', 15:10:42 INFO - 'sessionrestore', 15:10:42 INFO - 'sessionrestore_many_windows', 15:10:42 INFO - 'sessionrestore_no_auto_restore', 15:10:42 INFO - 'tabpaint']}, 15:10:42 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:10:42 INFO - 'tests': ['a11yr', 15:10:42 INFO - 'ts_paint', 15:10:42 INFO - 'tpaint', 15:10:42 INFO - 'sessionrestore', 15:10:42 INFO - 'sessionrestore_many_windows', 15:10:42 INFO - 'sessionrestore_no_auto_restore', 15:10:42 INFO - 'tabpaint']}, 15:10:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:10:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:10:42 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:10:42 INFO - 'tests': ['bloom_basic_singleton']}, 15:10:42 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:10:42 INFO - 'tests': ['bloom_basic']}, 15:10:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:10:42 INFO - 'tsvgr_opacity', 15:10:42 INFO - 'tart', 15:10:42 INFO - 'tscrollx', 15:10:42 INFO - 'tsvg_static']}, 15:10:42 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:10:42 INFO - 'tests': ['tsvgx', 15:10:42 INFO - 'tsvgr_opacity', 15:10:42 INFO - 'tart', 15:10:42 INFO - 'tscrollx', 15:10:42 INFO - 'tsvg_static']}, 15:10:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:10:42 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:10:42 INFO - 'talos_options': ['--disable-stylo'], 15:10:42 INFO - 'tests': ['tp5o']}, 15:10:42 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:10:42 INFO - 'talos_options': ['--mitmproxy', 15:10:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:10:42 INFO - '--firstNonBlankPaint'], 15:10:42 INFO - 'tests': ['tp6_google', 15:10:42 INFO - 'tp6_youtube', 15:10:42 INFO - 'tp6_amazon', 15:10:42 INFO - 'tp6_facebook']}, 15:10:42 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:10:42 INFO - 'talos_options': ['--disable-stylo', 15:10:42 INFO - '--mitmproxy', 15:10:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:10:42 INFO - '--firstNonBlankPaint'], 15:10:42 INFO - 'tests': ['tp6_google', 15:10:42 INFO - 'tp6_youtube', 15:10:42 INFO - 'tp6_amazon', 15:10:42 INFO - 'tp6_facebook']}, 15:10:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:10:42 INFO - 'talos_options': ['--stylo-threads=1', 15:10:42 INFO - '--mitmproxy', 15:10:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:10:42 INFO - '--firstNonBlankPaint'], 15:10:42 INFO - 'tests': ['tp6_google', 15:10:42 INFO - 'tp6_youtube', 15:10:42 INFO - 'tp6_amazon', 15:10:42 INFO - 'tp6_facebook']}, 15:10:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:10:42 INFO - 'talos_options': ['--xperf_path', 15:10:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:42 INFO - 'tests': ['tp5n']}, 15:10:42 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:10:42 INFO - 'talos_options': ['--disable-stylo', 15:10:42 INFO - '--xperf_path', 15:10:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:42 INFO - 'tests': ['tp5n']}}} 15:10:42 INFO - Running post-action listener: _resource_record_post_action 15:10:42 INFO - [mozharness: 2017-09-10 22:10:42.517404Z] Finished populate-webroot step (success) 15:10:42 INFO - [mozharness: 2017-09-10 22:10:42.517495Z] Running create-virtualenv step. 15:10:42 INFO - Running pre-action listener: _resource_record_pre_action 15:10:42 INFO - Running main action method: create_virtualenv 15:10:42 INFO - Creating virtualenv /builds/slave/test/build/venv 15:10:42 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:10:42 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:10:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:10:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:10:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:10:43 INFO - Installing distribute.............................................................................................................................................................................................done. 15:10:43 INFO - Installing pip...............done. 15:10:43 INFO - Return code: 0 15:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:10:43 INFO - Reading from file tmpfile_stdout 15:10:43 INFO - Output received: 15:10:43 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:10:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:10:43 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')]} 15:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:43 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')]} 15:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:43 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 0x11c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1531090>, '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 0x1531d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bf90>, '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': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', '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 15:10:43 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 15:10:43 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 15:10:43 INFO - Using env: {'DISPLAY': ':0', 15:10:43 INFO - 'HOME': '/home/cltbld', 15:10:43 INFO - 'LANG': 'en_US.UTF-8', 15:10:43 INFO - 'LANGUAGE': 'en_US:en', 15:10:43 INFO - 'LOGNAME': 'cltbld', 15:10:43 INFO - 'MAIL': '/var/mail/cltbld', 15:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:43 INFO - 'MOZ_NO_REMOTE': '1', 15:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:43 INFO - 'NO_EM_RESTART': '1', 15:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:43 INFO - 'PWD': '/builds/slave/test', 15:10:43 INFO - 'SHELL': '/bin/bash', 15:10:43 INFO - 'SHLVL': '1', 15:10:43 INFO - 'TERM': 'linux', 15:10:43 INFO - 'TMOUT': '86400', 15:10:43 INFO - 'USER': 'cltbld', 15:10:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', 15:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:43 INFO - '_': '/tools/buildbot/bin/python'} 15:10:44 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:10:44 INFO - Downloading/unpacking pip>=1.5 15:10:44 INFO - Running setup.py egg_info for package pip 15:10:44 INFO - warning: no files found matching 'pip/cacert.pem' 15:10:44 INFO - warning: no files found matching '*.html' under directory 'docs' 15:10:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:10:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:10:44 INFO - Installing collected packages: pip 15:10:44 INFO - Found existing installation: pip 1.1 15:10:44 INFO - Uninstalling pip: 15:10:44 INFO - Successfully uninstalled pip 15:10:44 INFO - Running setup.py install for pip 15:10:44 INFO - warning: no files found matching 'pip/cacert.pem' 15:10:44 INFO - warning: no files found matching '*.html' under directory 'docs' 15:10:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:10:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:10:44 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:10:44 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:10:44 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:10:44 INFO - Successfully installed pip 15:10:44 INFO - Cleaning up... 15:10:44 INFO - Return code: 0 15:10:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:44 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 0x11c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1531090>, '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 0x1531d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bf90>, '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': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', '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 15:10:44 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 15:10:44 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 15:10:44 INFO - Using env: {'DISPLAY': ':0', 15:10:44 INFO - 'HOME': '/home/cltbld', 15:10:44 INFO - 'LANG': 'en_US.UTF-8', 15:10:44 INFO - 'LANGUAGE': 'en_US:en', 15:10:44 INFO - 'LOGNAME': 'cltbld', 15:10:44 INFO - 'MAIL': '/var/mail/cltbld', 15:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:44 INFO - 'MOZ_NO_REMOTE': '1', 15:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:44 INFO - 'NO_EM_RESTART': '1', 15:10:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:44 INFO - 'PWD': '/builds/slave/test', 15:10:44 INFO - 'SHELL': '/bin/bash', 15:10:44 INFO - 'SHLVL': '1', 15:10:44 INFO - 'TERM': 'linux', 15:10:44 INFO - 'TMOUT': '86400', 15:10:44 INFO - 'USER': 'cltbld', 15:10:44 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', 15:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:44 INFO - '_': '/tools/buildbot/bin/python'} 15:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:44 INFO - Downloading/unpacking psutil>=3.1.1 15:10:44 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 15:10:44 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 15:10:44 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 15:10:44 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 15:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:10:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:46 INFO - Installing collected packages: psutil 15:10:46 INFO - Running setup.py install for psutil 15:10:46 INFO - building 'psutil._psutil_linux' extension 15:10:46 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 15:10:46 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 15:10:46 INFO - building 'psutil._psutil_posix' extension 15:10:46 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 15:10:46 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 15:10:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:46 INFO - Successfully installed psutil 15:10:46 INFO - Cleaning up... 15:10:46 INFO - Return code: 0 15:10:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:10: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')]} 15:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10: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')]} 15:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1531090>, '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 0x1531d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bf90>, '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': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', '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 15:10: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:10: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 mozsystemmonitor==0.3 15:10:46 INFO - Using env: {'DISPLAY': ':0', 15:10:46 INFO - 'HOME': '/home/cltbld', 15:10:46 INFO - 'LANG': 'en_US.UTF-8', 15:10:46 INFO - 'LANGUAGE': 'en_US:en', 15:10:46 INFO - 'LOGNAME': 'cltbld', 15:10:46 INFO - 'MAIL': '/var/mail/cltbld', 15:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:46 INFO - 'MOZ_NO_REMOTE': '1', 15:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:46 INFO - 'NO_EM_RESTART': '1', 15:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:46 INFO - 'PWD': '/builds/slave/test', 15:10:46 INFO - 'SHELL': '/bin/bash', 15:10:46 INFO - 'SHLVL': '1', 15:10:46 INFO - 'TERM': 'linux', 15:10:46 INFO - 'TMOUT': '86400', 15:10:46 INFO - 'USER': 'cltbld', 15:10:46 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', 15:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:46 INFO - '_': '/tools/buildbot/bin/python'} 15:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:10: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 15:10: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 15:10: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 15:10: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 15:10:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:10:48 INFO - Installing collected packages: mozsystemmonitor 15:10:48 INFO - Running setup.py install for mozsystemmonitor 15:10:48 INFO - Successfully installed mozsystemmonitor 15:10:48 INFO - Cleaning up... 15:10:50 INFO - Return code: 0 15:10:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1531090>, '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 0x1531d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bf90>, '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': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', '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 15:10:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:10:50 INFO - Using env: {'DISPLAY': ':0', 15:10:50 INFO - 'HOME': '/home/cltbld', 15:10:50 INFO - 'LANG': 'en_US.UTF-8', 15:10:50 INFO - 'LANGUAGE': 'en_US:en', 15:10:50 INFO - 'LOGNAME': 'cltbld', 15:10:50 INFO - 'MAIL': '/var/mail/cltbld', 15:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:50 INFO - 'MOZ_NO_REMOTE': '1', 15:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:50 INFO - 'NO_EM_RESTART': '1', 15:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:50 INFO - 'PWD': '/builds/slave/test', 15:10:50 INFO - 'SHELL': '/bin/bash', 15:10:50 INFO - 'SHLVL': '1', 15:10:50 INFO - 'TERM': 'linux', 15:10:50 INFO - 'TMOUT': '86400', 15:10:50 INFO - 'USER': 'cltbld', 15:10:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', 15:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:50 INFO - '_': '/tools/buildbot/bin/python'} 15:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:50 INFO - Downloading/unpacking jsonschema==2.5.1 15:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:10:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:10: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 15:10: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 15:10: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 15:10: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 15:10:51 INFO - Downloading functools32-3.2.3-2.tar.gz 15:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:10:51 INFO - warning: no files found matching '*.txt' 15:10:51 INFO - no previously-included directories found matching 'build' 15:10:51 INFO - no previously-included directories found matching 'dist' 15:10:51 INFO - no previously-included directories found matching '.git*' 15:10:51 INFO - Installing collected packages: jsonschema, functools32 15:10:52 INFO - Running setup.py install for functools32 15:10:52 INFO - warning: no files found matching '*.txt' 15:10:52 INFO - no previously-included directories found matching 'build' 15:10:52 INFO - no previously-included directories found matching 'dist' 15:10:52 INFO - no previously-included directories found matching '.git*' 15:10:52 INFO - Successfully installed jsonschema functools32 15:10:52 INFO - Cleaning up... 15:10:52 INFO - Return code: 0 15:10:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1531090>, '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 0x1531d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bf90>, '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': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', '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 15:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:10:52 INFO - Using env: {'DISPLAY': ':0', 15:10:52 INFO - 'HOME': '/home/cltbld', 15:10:52 INFO - 'LANG': 'en_US.UTF-8', 15:10:52 INFO - 'LANGUAGE': 'en_US:en', 15:10:52 INFO - 'LOGNAME': 'cltbld', 15:10:52 INFO - 'MAIL': '/var/mail/cltbld', 15:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:52 INFO - 'MOZ_NO_REMOTE': '1', 15:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:52 INFO - 'NO_EM_RESTART': '1', 15:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:52 INFO - 'PWD': '/builds/slave/test', 15:10:52 INFO - 'SHELL': '/bin/bash', 15:10:52 INFO - 'SHLVL': '1', 15:10:52 INFO - 'TERM': 'linux', 15:10:52 INFO - 'TMOUT': '86400', 15:10:52 INFO - 'USER': 'cltbld', 15:10:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', 15:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:52 INFO - '_': '/tools/buildbot/bin/python'} 15:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:10:52 INFO - Cleaning up... 15:10:52 INFO - Return code: 0 15:10:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1531090>, '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 0x1531d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bf90>, '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': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', '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 15:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:10:52 INFO - Using env: {'DISPLAY': ':0', 15:10:52 INFO - 'HOME': '/home/cltbld', 15:10:52 INFO - 'LANG': 'en_US.UTF-8', 15:10:52 INFO - 'LANGUAGE': 'en_US:en', 15:10:52 INFO - 'LOGNAME': 'cltbld', 15:10:52 INFO - 'MAIL': '/var/mail/cltbld', 15:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:52 INFO - 'MOZ_NO_REMOTE': '1', 15:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:52 INFO - 'NO_EM_RESTART': '1', 15:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:52 INFO - 'PWD': '/builds/slave/test', 15:10:52 INFO - 'SHELL': '/bin/bash', 15:10:52 INFO - 'SHLVL': '1', 15:10:52 INFO - 'TERM': 'linux', 15:10:52 INFO - 'TMOUT': '86400', 15:10:52 INFO - 'USER': 'cltbld', 15:10:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', 15:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:52 INFO - '_': '/tools/buildbot/bin/python'} 15:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:53 INFO - Downloading/unpacking blobuploader==1.2.4 15:10: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 15:10: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 15:10: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 15:10: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 15:10:54 INFO - Downloading blobuploader-1.2.4.tar.gz 15:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:10:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:10: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 15:10: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 15:10: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 15:10: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 15:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:10:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:10: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 15:10: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 15:10: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 15:10: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 15:10:54 INFO - Downloading docopt-0.6.1.tar.gz 15:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:10:54 INFO - Installing collected packages: blobuploader, requests, docopt 15:10:54 INFO - Running setup.py install for blobuploader 15:10:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:10:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:10:54 INFO - Running setup.py install for requests 15:10:55 INFO - Running setup.py install for docopt 15:10:55 INFO - Successfully installed blobuploader requests docopt 15:10:55 INFO - Cleaning up... 15:10:55 INFO - Return code: 0 15:10:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10: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')]} 15:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10: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')]} 15:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10: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 0x11c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1531090>, '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 0x1531d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bf90>, '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': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', '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 15:10: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 15:10: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 15:10:55 INFO - Using env: {'DISPLAY': ':0', 15:10:55 INFO - 'HOME': '/home/cltbld', 15:10:55 INFO - 'LANG': 'en_US.UTF-8', 15:10:55 INFO - 'LANGUAGE': 'en_US:en', 15:10:55 INFO - 'LOGNAME': 'cltbld', 15:10:55 INFO - 'MAIL': '/var/mail/cltbld', 15:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:55 INFO - 'MOZ_NO_REMOTE': '1', 15:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:55 INFO - 'NO_EM_RESTART': '1', 15:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:55 INFO - 'PWD': '/builds/slave/test', 15:10:55 INFO - 'SHELL': '/bin/bash', 15:10:55 INFO - 'SHLVL': '1', 15:10:55 INFO - 'TERM': 'linux', 15:10:55 INFO - 'TMOUT': '86400', 15:10:55 INFO - 'USER': 'cltbld', 15:10:55 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', 15:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:55 INFO - '_': '/tools/buildbot/bin/python'} 15:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:55 INFO - Running setup.py (path:/tmp/pip-R_Rzmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:55 INFO - Running setup.py (path:/tmp/pip-nIeoKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:55 INFO - Running setup.py (path:/tmp/pip-63omIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:55 INFO - Running setup.py (path:/tmp/pip-vXeXnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:55 INFO - Running setup.py (path:/tmp/pip-9qsvso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:56 INFO - Running setup.py (path:/tmp/pip-cavx7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:56 INFO - Running setup.py (path:/tmp/pip-93Xke6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:56 INFO - Running setup.py (path:/tmp/pip-UIsBg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:56 INFO - Running setup.py (path:/tmp/pip-uLenfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:56 INFO - Running setup.py (path:/tmp/pip-MDhpg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:56 INFO - Running setup.py (path:/tmp/pip-Lj6TVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:56 INFO - Running setup.py (path:/tmp/pip-61lNY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:56 INFO - Running setup.py (path:/tmp/pip-OMEYQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:56 INFO - Running setup.py (path:/tmp/pip-2neq8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:56 INFO - Running setup.py (path:/tmp/pip-6HtTEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:56 INFO - Running setup.py (path:/tmp/pip-NuZOza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:10:56 INFO - Running setup.py (path:/tmp/pip-M2QNlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:10:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:10:56 INFO - Running setup.py install for manifestparser 15:10:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:10:56 INFO - Running setup.py install for mozcrash 15:10:57 INFO - Running setup.py install for mozdebug 15:10:57 INFO - Running setup.py install for mozdevice 15:10:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:10:57 INFO - Running setup.py install for mozfile 15:10:57 INFO - Running setup.py install for mozhttpd 15:10:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:10:57 INFO - Running setup.py install for mozinfo 15:10:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:10:57 INFO - Running setup.py install for mozInstall 15:10:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:10:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:10:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:10:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:10:57 INFO - Running setup.py install for mozleak 15:10:57 INFO - Running setup.py install for mozlog 15:10:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:10:57 INFO - Running setup.py install for moznetwork 15:10:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:10:57 INFO - Running setup.py install for mozprocess 15:10:58 INFO - Running setup.py install for mozprofile 15:10:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:10:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:10:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:10:58 INFO - Running setup.py install for mozrunner 15:10:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:10:58 INFO - Running setup.py install for mozscreenshot 15:10:58 INFO - Running setup.py install for moztest 15:10:58 INFO - Running setup.py install for mozversion 15:10:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:10:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:10:58 INFO - Cleaning up... 15:10:58 INFO - Return code: 0 15:10:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:58 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 0x11c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1531090>, '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 0x1531d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bf90>, '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': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', '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 15:10:58 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 15:10:58 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 15:10:58 INFO - Using env: {'DISPLAY': ':0', 15:10:58 INFO - 'HOME': '/home/cltbld', 15:10:58 INFO - 'LANG': 'en_US.UTF-8', 15:10:58 INFO - 'LANGUAGE': 'en_US:en', 15:10:58 INFO - 'LOGNAME': 'cltbld', 15:10:58 INFO - 'MAIL': '/var/mail/cltbld', 15:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:58 INFO - 'MOZ_NO_REMOTE': '1', 15:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:58 INFO - 'NO_EM_RESTART': '1', 15:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:58 INFO - 'PWD': '/builds/slave/test', 15:10:58 INFO - 'SHELL': '/bin/bash', 15:10:58 INFO - 'SHLVL': '1', 15:10:58 INFO - 'TERM': 'linux', 15:10:58 INFO - 'TMOUT': '86400', 15:10:58 INFO - 'USER': 'cltbld', 15:10:58 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', 15:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:58 INFO - '_': '/tools/buildbot/bin/python'} 15:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:58 INFO - Running setup.py (path:/tmp/pip-xm_a_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:58 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)) 15:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:58 INFO - Running setup.py (path:/tmp/pip-IAAPco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10: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)) 15:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:59 INFO - Running setup.py (path:/tmp/pip-2zpJmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10: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)) 15:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:59 INFO - Running setup.py (path:/tmp/pip-ripakO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10: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)) 15:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:59 INFO - Running setup.py (path:/tmp/pip-JZSbRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10: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)) 15:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:59 INFO - Running setup.py (path:/tmp/pip-gjO4V1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10: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)) 15:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:59 INFO - Running setup.py (path:/tmp/pip-A89Ige-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10: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)) 15:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:59 INFO - Running setup.py (path:/tmp/pip-zjIls9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10: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)) 15:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:59 INFO - Running setup.py (path:/tmp/pip-GJizKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10: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)) 15:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:59 INFO - Running setup.py (path:/tmp/pip-z8w_e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:59 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)) 15:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:59 INFO - Running setup.py (path:/tmp/pip-ihCour-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:59 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)) 15:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:59 INFO - Running setup.py (path:/tmp/pip-bPLaqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:59 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)) 15:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:59 INFO - Running setup.py (path:/tmp/pip-jiTmmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:59 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)) 15:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:59 INFO - Running setup.py (path:/tmp/pip-jaZGQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:59 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)) 15:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:59 INFO - Running setup.py (path:/tmp/pip-mZuRiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:59 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)) 15:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:59 INFO - Running setup.py (path:/tmp/pip-xrXngc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:11: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)) 15:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:11:00 INFO - Running setup.py (path:/tmp/pip-y7SLC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:11: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)) 15:11: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)) 15:11: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)) 15:11: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)) 15:11: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)) 15:11: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)) 15:11: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)) 15:11:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:11: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 15:11: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 15:11: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 15:11: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 15:11:01 INFO - Downloading blessings-1.6.tar.gz 15:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:11:01 INFO - Installing collected packages: blessings 15:11:01 INFO - Running setup.py install for blessings 15:11:01 INFO - Successfully installed blessings 15:11:01 INFO - Cleaning up... 15:11:01 INFO - Return code: 0 15:11:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:11:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:11:01 INFO - Reading from file tmpfile_stdout 15:11:01 INFO - Current package versions: 15:11:01 INFO - argparse == 1.2.1 15:11:01 INFO - blessings == 1.6 15:11:01 INFO - blobuploader == 1.2.4 15:11:01 INFO - docopt == 0.6.1 15:11:01 INFO - functools32 == 3.2.3-2 15:11:01 INFO - jsonschema == 2.5.1 15:11:01 INFO - manifestparser == 1.1 15:11:01 INFO - mozInstall == 1.13 15:11:01 INFO - mozcrash == 1.0 15:11:01 INFO - mozdebug == 0.1 15:11:01 INFO - mozdevice == 0.51 15:11:01 INFO - mozfile == 1.2 15:11:01 INFO - mozhttpd == 0.7 15:11:01 INFO - mozinfo == 0.10 15:11:01 INFO - mozleak == 0.1 15:11:01 INFO - mozlog == 3.5 15:11:01 INFO - moznetwork == 0.27 15:11:01 INFO - mozprocess == 0.25 15:11:01 INFO - mozprofile == 0.28 15:11:01 INFO - mozrunner == 6.13 15:11:01 INFO - mozscreenshot == 0.1 15:11:01 INFO - mozsystemmonitor == 0.3 15:11:01 INFO - moztest == 0.8 15:11:01 INFO - mozversion == 1.4 15:11:01 INFO - psutil == 3.1.1 15:11:01 INFO - requests == 1.2.3 15:11:01 INFO - wsgiref == 0.1.2 15:11:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:01 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 0x11c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1531090>, '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 0x1531d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bf90>, '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': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', '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 15:11:01 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 15:11:01 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 15:11:01 INFO - Using env: {'DISPLAY': ':0', 15:11:01 INFO - 'HOME': '/home/cltbld', 15:11:01 INFO - 'LANG': 'en_US.UTF-8', 15:11:01 INFO - 'LANGUAGE': 'en_US:en', 15:11:01 INFO - 'LOGNAME': 'cltbld', 15:11:01 INFO - 'MAIL': '/var/mail/cltbld', 15:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:01 INFO - 'MOZ_NO_REMOTE': '1', 15:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:01 INFO - 'NO_EM_RESTART': '1', 15:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:01 INFO - 'PWD': '/builds/slave/test', 15:11:01 INFO - 'SHELL': '/bin/bash', 15:11:01 INFO - 'SHLVL': '1', 15:11:01 INFO - 'TERM': 'linux', 15:11:01 INFO - 'TMOUT': '86400', 15:11:01 INFO - 'USER': 'cltbld', 15:11:01 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', 15:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:01 INFO - '_': '/tools/buildbot/bin/python'} 15:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:01 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)) 15:11:01 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)) 15:11:01 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)) 15:11:01 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)) 15:11:01 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)) 15:11:01 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)) 15:11:01 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)) 15:11:01 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)) 15:11:01 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)) 15:11:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:11: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)) 15:11: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)) 15:11:03 INFO - Installing collected packages: simplejson 15:11:03 INFO - Running setup.py install for simplejson 15:11:03 INFO - building 'simplejson._speedups' extension 15:11: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 15:11:03 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 15:11:04 INFO - Successfully installed simplejson 15:11:04 INFO - Cleaning up... 15:11:04 INFO - Return code: 0 15:11:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:11: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')]} 15:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11: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')]} 15:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11: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 0x11c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1531090>, '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 0x1531d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bf90>, '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': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', '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 15:11: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 15:11: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 15:11:04 INFO - Using env: {'DISPLAY': ':0', 15:11:04 INFO - 'HOME': '/home/cltbld', 15:11:04 INFO - 'LANG': 'en_US.UTF-8', 15:11:04 INFO - 'LANGUAGE': 'en_US:en', 15:11:04 INFO - 'LOGNAME': 'cltbld', 15:11:04 INFO - 'MAIL': '/var/mail/cltbld', 15:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:04 INFO - 'MOZ_NO_REMOTE': '1', 15:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:04 INFO - 'NO_EM_RESTART': '1', 15:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:04 INFO - 'PWD': '/builds/slave/test', 15:11:04 INFO - 'SHELL': '/bin/bash', 15:11:04 INFO - 'SHLVL': '1', 15:11:04 INFO - 'TERM': 'linux', 15:11:04 INFO - 'TMOUT': '86400', 15:11:04 INFO - 'USER': 'cltbld', 15:11:04 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', 15:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:04 INFO - '_': '/tools/buildbot/bin/python'} 15:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:11:04 INFO - Cleaning up... 15:11:04 INFO - Return code: 0 15:11:04 INFO - Running post-action listener: _resource_record_post_action 15:11:04 INFO - Running post-action listener: _start_resource_monitoring 15:11:04 INFO - Starting resource monitoring. 15:11:04 INFO - [mozharness: 2017-09-10 22:11:04.378503Z] Finished create-virtualenv step (success) 15:11:04 INFO - [mozharness: 2017-09-10 22:11:04.379091Z] Running install step. 15:11:04 INFO - Running pre-action listener: _resource_record_pre_action 15:11:04 INFO - Running main action method: install 15:11:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:11:04 INFO - Reading from file tmpfile_stdout 15:11:04 INFO - Detecting whether we're running mozinstall >=1.0... 15:11:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:11:04 INFO - Reading from file tmpfile_stdout 15:11:04 INFO - Output received: 15:11:04 INFO - Usage: mozinstall [options] installer 15:11:04 INFO - Options: 15:11:04 INFO - -h, --help show this help message and exit 15:11:04 INFO - -d DEST, --destination=DEST 15:11:04 INFO - Directory to install application into. [default: 15:11:04 INFO - "/builds/slave/test"] 15:11:04 INFO - --app=APP Application being installed. [default: firefox] 15:11:04 INFO - mkdir: /builds/slave/test/build/application 15:11:04 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'] 15:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:11:21 INFO - Reading from file tmpfile_stdout 15:11:21 INFO - Output received: 15:11:21 INFO - /builds/slave/test/build/application/firefox/firefox 15:11:21 INFO - Running post-action listener: _resource_record_post_action 15:11:21 INFO - [mozharness: 2017-09-10 22:11:21.371476Z] Finished install step (success) 15:11:21 INFO - [mozharness: 2017-09-10 22:11:21.371815Z] Running setup-mitmproxy step. 15:11:21 INFO - Running pre-action listener: _resource_record_pre_action 15:11:21 INFO - Running main action method: setup_mitmproxy 15:11:21 INFO - Skipping: mitmproxy is not required 15:11:21 INFO - Running post-action listener: _resource_record_post_action 15:11:21 INFO - [mozharness: 2017-09-10 22:11:21.373565Z] Finished setup-mitmproxy step (success) 15:11:21 INFO - [mozharness: 2017-09-10 22:11:21.373874Z] Running run-tests step. 15:11:21 INFO - Running pre-action listener: _resource_record_pre_action 15:11:21 INFO - Running pre-action listener: _set_gcov_prefix 15:11:21 INFO - Running main action method: run_tests 15:11:21 WARNING - Try message not found. 15:11:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:11:21 INFO - Python 2.7.3 15:11:21 INFO - Return code: 0 15:11:21 INFO - grabbing minidump binary from tooltool 15:11:21 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')]} 15:11:21 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 0x1531090>, '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 0x1531d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:11:21 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 15:11:21 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 15:11:21 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 15:11:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:11:21 INFO - Return code: 0 15:11:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:11:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:11:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:11:21 INFO - ENV: RUST_BACKTRACE is now full 15:11:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:11:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:11:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 15:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 15:11:21 INFO - Using env: {'DISPLAY': ':0', 15:11:21 INFO - 'HOME': '/home/cltbld', 15:11:21 INFO - 'LANG': 'en_US.UTF-8', 15:11:21 INFO - 'LANGUAGE': 'en_US:en', 15:11:21 INFO - 'LOGNAME': 'cltbld', 15:11:21 INFO - 'MAIL': '/var/mail/cltbld', 15:11:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:11:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:21 INFO - 'MOZ_NO_REMOTE': '1', 15:11:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:21 INFO - 'NO_EM_RESTART': '1', 15:11:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:21 INFO - 'PWD': '/builds/slave/test', 15:11:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:11:21 INFO - 'RUST_BACKTRACE': 'full', 15:11:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:11:21 INFO - 'SHELL': '/bin/bash', 15:11:21 INFO - 'SHLVL': '1', 15:11:21 INFO - 'TERM': 'linux', 15:11:21 INFO - 'TMOUT': '86400', 15:11:21 INFO - 'USER': 'cltbld', 15:11:21 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', 15:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:21 INFO - '_': '/tools/buildbot/bin/python'} 15:11:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 15:11:21 INFO - mozversion application_buildid: 20170910211652 15:11:21 INFO - mozversion application_changeset: a5f163da8a9be5d2e86138c57d59be69723b5457 15:11:21 INFO - mozversion application_display_name: Nightly 15:11:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:11:21 INFO - mozversion application_name: Firefox 15:11:21 INFO - mozversion application_remotingname: firefox 15:11:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:11:21 INFO - mozversion application_vendor: Mozilla 15:11:21 INFO - mozversion application_version: 57.0a1 15:11:21 INFO - mozversion platform_buildid: 20170910211652 15:11:21 INFO - mozversion platform_changeset: a5f163da8a9be5d2e86138c57d59be69723b5457 15:11:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:11:21 INFO - mozversion platform_version: 57.0a1 15:11:21 INFO - using testdate: 1505081481 15:11:21 INFO - actual date: 1505081481 15:11:21 INFO - starting webserver on 'localhost:43230' 15:11:21 INFO - SUITE-START | Running 2 tests 15:11:21 INFO - TEST-START | dromaeo_css 15:11:21 INFO - Initialising browser for dromaeo_css test... 15:11:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43230/getInfo.html -profile /tmp/tmpxCp53C/profile 15:11:21 INFO - TEST-INFO | started process 19483 (/builds/slave/test/build/application/firefox/firefox http://localhost:43230/getInfo.html) 15:11:27 INFO - TEST-INFO | 19483: exit 0 15:11:27 INFO - Browser initialized. 15:11:27 INFO - Running cycle 1/1 for dromaeo_css test... 15:11:27 INFO - Using env: {'DISPLAY': ':0', 15:11:27 INFO - 'HOME': '/home/cltbld', 15:11:27 INFO - 'JSGC_DISABLE_POISONING': '1', 15:11:27 INFO - 'LANG': 'en_US.UTF-8', 15:11:27 INFO - 'LANGUAGE': 'en_US:en', 15:11:27 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:11:27 INFO - 'LOGNAME': 'cltbld', 15:11:27 INFO - 'MAIL': '/var/mail/cltbld', 15:11:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:11:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:11:27 INFO - 'MOZ_CRASHREPORTER': '1', 15:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:27 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:11:27 INFO - 'MOZ_NO_REMOTE': '1', 15:11:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:27 INFO - 'NO_EM_RESTART': '1', 15:11:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:27 INFO - 'PWD': '/builds/slave/test', 15:11:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:11:27 INFO - 'RUST_BACKTRACE': 'full', 15:11:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:11:27 INFO - 'SHELL': '/bin/bash', 15:11:27 INFO - 'SHLVL': '1', 15:11:27 INFO - 'STYLO_FORCE_DISABLED': '1', 15:11:27 INFO - 'TERM': 'linux', 15:11:27 INFO - 'TMOUT': '86400', 15:11:27 INFO - 'USER': 'cltbld', 15:11:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', 15:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:27 INFO - '_': '/tools/buildbot/bin/python'} 15:11:27 INFO - TEST-INFO | started process 19679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxCp53C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:28 INFO - PID 19679 | 15:11:28 INFO - PID 19679 | (/builds/slave/test/build/application/firefox/firefox:19730): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:11:28 INFO - PID 19679 | 15:11:39 INFO - PID 19679 | RSS: Main: 170811392 15:11:39 INFO - PID 19679 | 15:14:36 INFO - PID 19679 | Cycle 1(1): loaded http://localhost:43230/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43230/tests/dromaeo/cssquery-ext.html) 15:14:38 INFO - PID 19679 | RSS: Main: 172257280 15:14:38 INFO - PID 19679 | 15:17:39 INFO - PID 19679 | Cycle 1(1): loaded http://localhost:43230/tests/dromaeo/cssquery-ext.html (next: http://localhost:43230/tests/dromaeo/cssquery-jquery.html) 15:17:40 INFO - PID 19679 | RSS: Main: 169336832 15:17:40 INFO - PID 19679 | 15:20:42 INFO - PID 19679 | Cycle 1(1): loaded http://localhost:43230/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43230/tests/dromaeo/cssquery-mootools.html) 15:20:42 INFO - PID 19679 | RSS: Main: 171352064 15:20:42 INFO - PID 19679 | 15:23:44 INFO - PID 19679 | Cycle 1(1): loaded http://localhost:43230/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43230/tests/dromaeo/cssquery-prototype.html) 15:23:45 INFO - PID 19679 | RSS: Main: 169877504 15:23:45 INFO - PID 19679 | 15:26:48 INFO - PID 19679 | Cycle 1(1): loaded http://localhost:43230/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43230/tests/dromaeo/cssquery-yui.html) 15:26:48 INFO - PID 19679 | RSS: Main: 171237376 15:26:48 INFO - PID 19679 | 15:29:50 INFO - PID 19679 | Cycle 1(1): loaded http://localhost:43230/tests/dromaeo/cssquery-yui.html (next: http://localhost:43230/tests/dromaeo/cssquery-dojo.html) 15:29:50 INFO - PID 19679 | RSS: Main: 172134400 15:29:50 INFO - PID 19679 | 15:29:50 INFO - PID 19679 | __start_tp_report 15:29:50 INFO - PID 19679 | _x_x_mozilla_page_load 15:29:50 INFO - PID 19679 | _x_x_mozilla_page_load_details 15:29:50 INFO - PID 19679 | |i|pagename|runs| 15:29:50 INFO - PID 19679 | |0;dojo.html;3089.1813669377616;3119.1110533497945;3126.31221131351;3144.7955882867614;3167.4773662345715;6286.46565041972;6370.394812492817;6377.489800815935;6397.520185986053;6438.613683179013;6192.690365481731;6338.873222535558;6340.4927605791545;6350.396712312335;6478.671872266174;5803;5869.9727547679195;5893.823185304448;5904.291485021803;5923.407659234063;5686.346070201917;5800.709964501779;5886.617369870966;5925.911111333334;5944.613600116;5816.360200377976;5823.229416784074;5884.735186916599;5934.228550288478;5941.613795103304;5711.314642242916;5837.09525023622;5916.881662366772;5945.286565612111;5955.583109182359;5762.222100016486;5824.796132135355;5850.06398976166;5856.590038697293;5870.794522191745;6341.270753863272;6356.110144579762;6373.6175829450385;6436.195475565554;6438.549301548894;6803.863922721567;6823.28355522668;6826.180858297036;6917.308269173092;6949.826254343631;6748.662566871637;6843.07618471505;6922.342377474132;6974.721011159548;6998.650067496605;6258.655773932432;6308.842278943017;6326.2092238470195;6326.841828954267;6334.493240540745;6887.965560172267;6919.861602767916;6986.860262794716;7052.435805135577;7129.857402852018;6732.461403087741;6814.829629259309;6833.350831670983;6834.350736680008;6836.863262734718;6865.725370985205;6881.965590172017;6885.208201056842;6979.6859141337745;6986.371226589631;6649.468042556584;6786.898196527056;6795.320467953264;6797.422219111431;6815.522913396015;6785.355391237923;6820.761273355409;6836.589804611739;6839.2818754031105;6850.0752398426575;5351.785928562892;5401.729913504388;5430.70131142791;5446.2647542582035;5447.182922561568;4667.113248482778;4670.6497012724185;4673.112108699336;4702.130105930414;4735.905281894343;5740;5801.564882633819;5811.3316968548315;5880.382559831241;5884.705764711747;6707.899381509281;6867.896981545281;6907.240203577602;6931.306869313028;6936.514443988974;5784.219130417424;5824.184614154022;5859.677717725481;5875;5967.850803729942;5838.941610583925;5840.8247752567495;5914.0241860093465;5951.285845698544;5952.166696662471;6345.809625711236;6442.516811239176;6600.73597056122;6667.299933506912;6700.597964122168;6809.114815074008;6905.1713794345;6925.238223795278;6926.168859736864;6933.445324373937;6588.6046837188005;6594.868102638016;6648.5678430901835;6694.631795251308;6704.765333213314;6754.459643228628;6789.15135608049;6841.794746157623;6850.109485766819;6859.142607174103;6748;6841.17905851301;6888.104546408935;6905.516613836983;6985.336393042653;6559.836004099936;6564.671766411756;6570.737170513126;6578.407943284936;6579.80260592183;6549.705263263069;6572.079908812674;6732.360425759545;6733.865322693617;6735.191776986793;6594.307597702364;6605.306442823435;6609.735610575523;6611.768588099393;6658.500612454182;6659;6749.4600431964345;6815.045893575003;6816.284290149463;6833.3166683331265;6301.464375528131;6320.115183874169;6329.240491141092;6403.743850246125;6430.1319321892815 15:29:50 INFO - PID 19679 | |1;ext.html;757.7726681995401;766.390719378095;773.8026803165192;775.4533054196792;777.5490215674907;36605;40030;40066.799666001665;40173;40528.594714052924;37212.627873721256;37515.81242093786;37520.812395938054;37573.24853502935;37613.62386376136;6962.268961759019;7040.788776336718;7049.647517624124;7057.611831349273;7064.894026589605;6896.655167241643;6991.89512157318;6995.370416662499;6996.510244282902;7003.614801185933;6978.651067446633;7016.122984626922;7016.543924644907;7610.657520411595;7747.341475974549;7699.230076992284;7699.461037727361;7712;7761.146273909865;7788.337991270749;7595.4683172177965;7609.6575654095695;7670.424718146106;7710.537367757953;7772.183920688303;38023.809880950415;38180.42729359062;38193.42709859354;38543;38546;3501.77238479498;3549.503069570262;3552.236269202108;3572.83922223498;3578.481120237577;30807.38385232283;30990.690093099005;31054.689453105406;31123.84438077795;31263.531047034314;5082.771275292621;5115.795368185305;5147.481492959586;5154.871128221787;5161.612879034087;179575;180725;181829;182215.99999999866;182239;39750.20499589992;40226.79886600548;46035.53964460379;46582.534174658496;47906;49525.257121143215;49577;49717;49848.75075624599;49956;14938.850611493963;15044.172570508508;15050.096994180385;15055.322510487054;15061.397544098332;12126.575569855013;12134.453949572291;12294.323812190236;12318.81521777174;12366;13777.517786877612;13797.24115173655;13819.516316928859;13904.304784760721;13913.58259252224;5526.917096243559;5677.829665110054;5815;5862.12068189775;5864.589478736533;979.7893452907659;986.3490096536252;992.503748125937;1008.7730260691433;1013.6756238003768;22357.888210558842;22526.774732252794;22713.886430568073;22806.543869122856;23162.1893233736;1066.594694016269;1079.1906070447164;1085.4898197846999;1095.1129585036147;1099.428297285407;11947.636654341995;12069.437872033144;12080;12087;12104.910558049818;212607;213895;214078;215379;216706;50129.49870501321;50354.74822625937;50493.49506504962;50560;50759;1394.1565352961516;1431.5991522373752;1441.502681574855;1443.141330908108;1448.8478709735537;22063.448413789785;22225.77774222237;22326;22593.322200334016;22708.318750437513;35680.64319356877;35707.28585428329;36002;36053.27893442169;36095.27809443849;187905;188332;189695;190650;191494;29936;30495.237619059702;32456.403487721396;32668.346633067682;32682.83658581692;41312.586874132074;41325.586744133376;41596.37605435981;41619.37570936499;41721.37417938672;30538.847305763327;30851;30864.228394290323;31051.844740777055;31064.378712426078;30233.546496803006;30697.232569185948;30797.538036929014;30805.22986925345;30955.845220773754;33663.495047573815;33774.49338259977;33836.830815845766;34087.31825363528;34398.484022739176;29506;29760.702392975792;29825.403491929606;29884;29926.551101733057;22456.32631021072;22610.208642697427;22625.547489050456;22884.31347059591;22941.426464338525 15:29:50 INFO - PID 19679 | |2;jquery.html;543.2313276713451;559.9244102046227;569.4903061759725;572.8424683212116;582.6766144789643;21236.57526849462;22328.218512352072;22343.553128937412;22461.77538224617;22502.212422565215;23177.536449271047;23993.280201593938;24097.518049639;24141.396465088383;24356.269311920627;6350.650714210705;6489.610623362613;6496.187976502937;6521.47828173745;6541.149650545422;6379.298277189506;6393.200849893763;6430.421262086411;6432.967835160817;6441.484681225515;6230.719617617218;6441.1304473896125;6492.15601971743;6500.4799616030605;6509.544331896769;6390.137331460263;6440.388163124542;6443.743470023347;6449.709763060673;6461.901476748964;5800.941990580082;6003.699815009232;6004.639721616717;6017.458428741435;6021;27142.32144196391;27588.17235482939;27598.862005690044;27619.03333383342;27672.03147889834;2005.027561632607;2008.4075197816678;2010.6179825833044;2010.939671809848;2010.9497262568407;18390.54023649406;18893.527661808428;19189.61620767577;19196.61606767857;19242.230310787552;2406.542756876188;2452.1785201957364;2455.34933242689;2475.752424757528;2489.352768280242;110943.44528277387;116591;132316;132865;137477.999999999;14145.646358840906;14385.136891786526;14515;14604.12375257488;14609.415623374945;21943;21949.561008779736;21958.23146189876;21964.341069767932;21973.67039494409;9506.524673766284;9701.272404569685;9727.513624318897;9754.804903901882;9844.50777461124;8945.329100317373;8968.686095986739;9023.278137748965;9023.684171053981;9115.772105697411;8619.6983105591;8633.179847914438;8640.019193378275;8808.77978050541;8847.955760221286;2593.4683389905026;2597.8960841566504;2663.187727743057;2689.367998520346;2692.9461410771673;943.5470973932551;944.1549812917538;951.2912879904516;952.9190018848337;975.1272611013104;18539.536511587317;18838.246470141316;18995.24019039223;19024.048797560066;19285.4214373569;1015.2132097624252;1015.9542820573092;1020.974475638115;1028.28534168752;1029.624187171692;10182.505286204927;10247.333923294962;10410.427426491615;10607.257491975643;10674.466276686135;388732;400188;412272;416601;422032;105788;107036;107092;108439;112111.43944280226;999.6201443451442;1042.6507120114848;1102.3496137279044;1123.2867129372908;1159.0553698735503;19375.97379249692;19548.60902781908;19646.901765491082;19659.508512287306;19962.401127966183;50919.236211457595;52026;53211.73394133004;54542.72728636331;54607.180892285854;65747.6712616453;66283;66689.33310666832;66795.66408671897;67334.32665673281;13719.657008574866;13783.862161378658;13833.446662133401;13860.514881979485;14017.719645607234;21823;21940;22012.779872201074;22416.551668966204;22424;17447.56381090483;17570.297188112843;17802.732959005367;17841.553961151076;17923.73114403259;15758.921205393899;16122.758158627395;16312.51062468128;16679;16806.411775587796;17790.644187115926;17916.55208619743;18022;18023.819761802213;18172.636547268718;13572.796408054084;13714.17714937107;13776.173429594257;13887.097338672955;13889.722205556034;17578.472645820646;17764.378246761302;17900.91049544744;18014.2794288227;18058 15:29:50 INFO - PID 19679 | |3;mootools.html;1289.5422125145574;1325.595693313539;1335.1188215777588;1354.4920654754474;1357.1856885868485;14765.409383624656;15282.69434611307;15357.692846143085;15383.153926534036;15413.460528881491;15009.849901500982;15028.248587570604;15053.774193387108;15092.094474331549;15211.391544338241;2691.2676639067654;2757.8345299282005;2778.2915356584044;2780.7497325240724;2783.4433113377304;2692.394211302461;2705.553583658694;2723.360010397555;2724.209979106057;2725.8773355199064;2624.763771260586;2770.48745981993;2775.5004099262123;2784.49879021776;2813.6342275504157;2776.847273399962;2778.458200650874;2782;2794.580812878064;2814.3245621051005;2675.38466152784;2734.1934129431866;2734.7128551502005;2746.6978632350424;2767.571026490897;14882.925585372112;14935.850641493664;14956.775648365283;14958.925205374013;14986.925065374713;7588.658510367047;7849.254320839511;7851.725189618393;7916.525008499509;7927;5104.846854594368;5238.371395432572;5252.159654455307;5307.575393968474;5361.463853614647;1888.3013285084608;1903.9524011899675;1904.8952307623076;1910.169076451734;1939.5442071113278;24568;24630.876845615836;24872.875635621887;24893.62659560108;24935;6226.875462490725;6233.594816336924;6293;6370.394812492806;6432.2281326241155;17179.31282748701;17212.913935430493;17219.913900430416;17232.913835430743;17234.482965511055;7608.619569021526;7735.49719268257;7749.108852481924;7751.844963100706;7778.0666320041955;6942.583444993316;7083.89374159388;7087.1849737279845;7133.785986420416;7161.176464706521;4752.691075080109;4927.556519913225;4956.4547899731;4989.975050124799;4995.850124496271;1322.7552902713028;1326.1247576599399;1349.3590544491485;1352.8985326100583;1368.7057282684073;856.8886044814259;884.1070518775954;888.6178943054549;893.008760276093;895.3329769321897;7666.731664391719;7739.419543534144;7785.80535486606;7804.609769511501;7854.175311592315;679.6092246958019;702.6908160409404;710.793869777769;719.3957076056033;725.1262229014026;5083.923741143886;5258.92111618326;5273.683578985273;5360.571154307646;5441.863953401196;20148.597028059357;20752.48118797042;21687.783122168577;21755.67366489504;21759.12963481443;20863.8956805215;20981;21502;21502.462438439165;21642.350729477825;10245.795084098276;10346.741331466774;10419.010194031554;10509.842352364567;11072.280301780358;8429.915700843158;8518.105598912025;8553.272971797218;8588.65645374203;8614.44006139599;17827;18427;18731.063446827877;18797;18854.057297134816;18893.433197004113;18966.905165474083;19041.333553325567;19179.424617261506;19327;10149.89850101519;10561.894381056398;10595.788084238426;10634.30876992993;10659.09397701204;13814.792778108136;13964.441422342992;13987;13987.930060349634;13998.44006239739;11285.322880627189;11321.264117832314;11427.428628568705;11433.656990290305;11722.413879306172;11202;11253.324800511995;11276.436178191221;11379;11406.486708098322;9459.10138536838;9647.662331818352;9652.613895444103;9658.468784216935;9677.467739274407;7371.668274927749;7434.8884766729625;7457.142428620561;7474.065741782278;7484.214157513383;7416.25837416254;7509.586972716553;7597.544147351176;7599.658015389431;7603.46775725716 15:29:50 INFO - PID 19679 | |4;prototype.html;499.13649386561224;505.6536272653233;517.2164171280513;527.4172039895915;535.6250624562807;6262.342454042328;6314.905276420857;6323.841903952403;6326.905096423551;6340.682965851701;6145.60053596517;6175.135481032659;6196.194494715692;6215.782447614334;6223.688815559227;4880.292357608145;5073.137566613685;5123.692578445296;5139;5190.558802501791;5023.196288593826;5041.395032596093;5044.974775126119;5050.671706339094;5092.618053645972;4921.8277360292395;4941.654084214107;4962.6774259673;4969.304297398349;5017.37282839645;4995.900081998376;5006.2740902569285;5007.574356179729;5014.598832093442;5020.673656212334;4483.439570053743;4506;4532.161550113239;4539.415190657427;4549.363089167519;6173.135760993465;6196.349383314777;6196.535259855529;6228.719707613168;6231.594946328474;5620.325560932673;5700.657960522382;5734.713264336809;5759.5968282220265;5766.308043034863;6541.574797638138;6607.933920660828;6650.800475985729;6651.201855777338;6677.93322066778;4860.1251774680895;4899.363082799249;4912.820922978495;4914.262860570943;4928.778204980785;6869.484788640872;6980.452134970699;7030.910208917626;7040.084788977451;7065.646717664096;5015.548600625888;5045.770706747684;5064;5070.442251352349;5072.365954255718;5070.416902056237;5096.847094587169;5124.436312005751;5125.69245845243;5188.481151884781;5720.2849643794525;5729.197912292282;5749.051406517878;5772.191893134965;5778.3354914184565;6279.843003924939;6441.710123044474;6576.76981305652;6604.735810567524;6688.598684078971;1745.3367720266217;1762.770839790819;1780.7685000949793;1783.965300125924;1784.2506147418117;1067.7490789664423;1214.3867346989714;1231.9137660363688;1235.1539195651008;1236.5857437758273;5629.183768353566;5775.913361299584;5793.391693872167;5807.593468457252;5815.79644712433;6846.554973926679;6850.965745171242;6858.759943401957;6864.828379290558;6866.382025617719;5833.533317334688;5837.883242335214;5856.795012174553;5862.794802181903;5869.530437564985;3639.8544058237903;3643.7813731176216;3662.61542538035;3662.7436079474714;3683.7421380503642;6599.637019963948;6607.933920660828;6622.437092847162;6625.503087268474;6630.53586248958;6999.860002800017;7022.403095736818;7022.859542809115;7061.717531298793;7083.92916070843;6539.50953678476;6564.277929427759;6588.341165883469;6595.868082638416;6616.702248398929;6836.111305530249;6846;6858.6570671467225;6864.906203607948;6888.690008949709;6723.899141512783;6800.31996800316;6841.657917104224;6847.863042739217;6899.137607799025;6569.605823650596;6578;6591.143151390289;6603.966980165068;6608.801735947929;4981.227909674007;5026.924596131134;5031.03169130215;5034.421041580119;5041.218611115283;6775.322467753383;6837.145356830396;6848.897266541106;6856.725730970706;6893.724251029903;6586.934130658632;6641.402273795382;6642.667866606747;6647.202335719745;6660.866782664417;6527.2167339919515;6561.4410379952815;6561.96719016421;6578.276389597045;6631.734730610721;6472.320406357453;6505.31694172124;6521.673916304071;6541.247756508063;6541.803745887631;6300.621962682254;6628.304028077176;6692.6988285526295;6697.564658297195;6724.697388617426;6364.395382438661;6380.712867921047;6393.456556192776;6423.807285781434;6443.6455994920725 15:29:50 INFO - PID 19679 | |5;yui.html;916.8533034714447;918.5177781664626;928.7213835849244;929.7907970706592;943.7876477792497;18983.905080474597;19868.801311986877;19957.50106247341;19964.301249456254;19987.100580473878;17060.14699265038;17117.40089096882;17134.657306853856;17152.313907443688;17166.742498862528;912.5665308978215;923.8937522184967;927.9164875161234;928.3223247029672;928.9581968811386;972.5040229482979;972.7324985628974;975.1954637424118;976.4531862157214;976.9853452198223;999.170688328689;1002.2332915319786;1027.2603725317758;1033.2767063055853;1036.9481525923711;1018.801333739921;1020.2042406922612;1021.0453226233421;1021.5198856537453;1021.5403068619114;715.8425146467769;743.379278302618;753.9472236943416;754.6377738685406;755.3466251692247;20000.899995500076;20255.39233822973;20269.898650506802;20276.493087672778;20279.898600506902;19633.214671413127;20156.69764953527;20257.594848103105;20382.184712611477;20396.082176301952;16443.83556164435;16904.408345707965;17015;17306.22122004513;17421.128943552772;3752.6434988676306;3760.0599850037493;3761.586225515191;3765.416360464105;3777.660010599059;106300.46849765778;133419.33290333487;139728;140066.29966850203;142167;16196.67606647884;16666;16755.41356052532;16761.664766704598;16800.74798878018;26093.608595871076;26151.476970460484;26421;26590.867045664647;26805.731942680715;8276.8344633107;8296.709615163561;8316.750497485085;8317.542535160625;8327.66689332432;4226.809793559297;4251.5748425157235;4295.226859165317;4337.934930976038;4339.262325404688;5031.77357018935;5117.8720531986255;5139.897202055938;5156.484351564888;5164.380274367025;981.082687687015;993.4337427666305;995.9551820167965;1004.1565085328214;1004.1866088468364;656.6093174561129;670.2426258328155;681.7409384433884;691.0739608923966;691.6299779617981;11506.07951363889;11548.884511154949;11581.594644187413;11627.76744465106;12123.030157587373;652.0968458684661;656.1175219329994;661.9172603424572;671.4863129705778;681.4616453002172;5405.7567409466665;5464.23500709901;5516.089845175581;5530.198121272393;5540.972295138579;116231.41884290693;120026;121109;121693;124345.37827310806;105583;106050;106360.46819765851;110122;110473;92253.53873230725;93581;95519;97883.51058244663;100124;10049.346792458759;10175.592976280866;10197.337173084023;10255.384676919408;10420.947895260779;42726.78636606797;43353.3496997539;43781.78109109434;43877.56122438863;44434.11131777411;56650.716746416;57082.14376784269;57246.71376643257;57418.42581574298;57617.42382576121;14241.287935603386;14575.271236438348;14602.196879171748;14608.634784130481;14633.853661463248;15805.446809361618;15806.130662813655;15815.68368632644;15864.92067539655;15897.52307430779;14451.205183714997;14521.201333926736;14567.417303308173;14656;14728.263586820402;13901.930490347484;14019.088759230617;14071.366788494746;14263;14362.569122926328;14044.508442204882;14181.574552763434;14206.573802785933;14250.501232456814;14250.71498570002;9126.315526335418;9381.249500039843;9398.389104708172;9459.243260539279;9553.04469553039;9192.034836342087;9229.123233292827;9283.907160928575;9284.675036373694;9294 15:29:50 INFO - PID 19679 | __end_tp_report 15:29:50 INFO - PID 19679 | __start_cc_report 15:29:50 INFO - PID 19679 | _x_x_mozilla_cycle_collect,367 15:29:50 INFO - PID 19679 | __end_cc_report 15:29:50 INFO - PID 19679 | __startTimestamp1505082590720__endTimestamp 15:29:50 INFO - PID 19679 | 15:29:50 INFO - PID 19679 | ------- Summary: start ------- 15:29:50 INFO - PID 19679 | Number of tests: 6 15:29:50 INFO - PID 19679 | 15:29:50 INFO - PID 19679 | [#0] dojo.html Cycles:165 Average:6281.03 Median:6549.71 stddev:769.02 (11.7%) stddev-sans-first:729.48 15:29:50 INFO - PID 19679 | Values: 3089.2 3119.1 3126.3 3144.8 3167.5 6286.5 6370.4 6377.5 6397.5 6438.6 6192.7 6338.9 6340.5 6350.4 6478.7 5803.0 5870.0 5893.8 5904.3 5923.4 5686.3 5800.7 5886.6 5925.9 5944.6 5816.4 5823.2 5884.7 5934.2 5941.6 5711.3 5837.1 5916.9 5945.3 5955.6 5762.2 5824.8 5850.1 5856.6 5870.8 6341.3 6356.1 6373.6 6436.2 6438.5 6803.9 6823.3 6826.2 6917.3 6949.8 6748.7 6843.1 6922.3 6974.7 6998.7 6258.7 6308.8 6326.2 6326.8 6334.5 6888.0 6919.9 6986.9 7052.4 7129.9 6732.5 6814.8 6833.4 6834.4 6836.9 6865.7 6882.0 6885.2 6979.7 6986.4 6649.5 6786.9 6795.3 6797.4 6815.5 6785.4 6820.8 6836.6 6839.3 6850.1 5351.8 5401.7 5430.7 5446.3 5447.2 4667.1 4670.6 4673.1 4702.1 4735.9 5740.0 5801.6 5811.3 5880.4 5884.7 6707.9 6867.9 6907.2 6931.3 6936.5 5784.2 5824.2 5859.7 5875.0 5967.9 5838.9 5840.8 5914.0 5951.3 5952.2 6345.8 6442.5 6600.7 6667.3 6700.6 6809.1 6905.2 6925.2 6926.2 6933.4 6588.6 6594.9 6648.6 6694.6 6704.8 6754.5 6789.2 6841.8 6850.1 6859.1 6748.0 6841.2 6888.1 6905.5 6985.3 6559.8 6564.7 6570.7 6578.4 6579.8 6549.7 6572.1 6732.4 6733.9 6735.2 6594.3 6605.3 6609.7 6611.8 6658.5 6659.0 6749.5 6815.0 6816.3 6833.3 6301.5 6320.1 6329.2 6403.7 6430.1 15:29:50 INFO - PID 19679 | 15:29:50 INFO - PID 19679 | [#1] ext.html Cycles:180 Average:35745.05 Median:34242.90 stddev:50632.04 (147.9%) stddev-sans-first:50705.92 15:29:50 INFO - PID 19679 | Values: 757.8 766.4 773.8 775.5 777.5 36605.0 40030.0 40066.8 40173.0 40528.6 37212.6 37515.8 37520.8 37573.2 37613.6 6962.3 7040.8 7049.6 7057.6 7064.9 6896.7 6991.9 6995.4 6996.5 7003.6 6978.7 7016.1 7016.5 7610.7 7747.3 7699.2 7699.5 7712.0 7761.1 7788.3 7595.5 7609.7 7670.4 7710.5 7772.2 38023.8 38180.4 38193.4 38543.0 38546.0 3501.8 3549.5 3552.2 3572.8 3578.5 30807.4 30990.7 31054.7 31123.8 31263.5 5082.8 5115.8 5147.5 5154.9 5161.6 179575.0 180725.0 181829.0 182216.0 182239.0 39750.2 40226.8 46035.5 46582.5 47906.0 49525.3 49577.0 49717.0 49848.8 49956.0 14938.9 15044.2 15050.1 15055.3 15061.4 12126.6 12134.5 12294.3 12318.8 12366.0 13777.5 13797.2 13819.5 13904.3 13913.6 5526.9 5677.8 5815.0 5862.1 5864.6 979.8 986.3 992.5 1008.8 1013.7 22357.9 22526.8 22713.9 22806.5 23162.2 1066.6 1079.2 1085.5 1095.1 1099.4 11947.6 12069.4 12080.0 12087.0 12104.9 212607.0 213895.0 214078.0 215379.0 216706.0 50129.5 50354.7 50493.5 50560.0 50759.0 1394.2 1431.6 1441.5 1443.1 1448.8 22063.4 22225.8 22326.0 22593.3 22708.3 35680.6 35707.3 36002.0 36053.3 36095.3 187905.0 188332.0 189695.0 190650.0 191494.0 29936.0 30495.2 32456.4 32668.3 32682.8 41312.6 41325.6 41596.4 41619.4 41721.4 30538.8 30851.0 30864.2 31051.8 31064.4 30233.5 30697.2 30797.5 30805.2 30955.8 33663.5 33774.5 33836.8 34087.3 34398.5 29506.0 29760.7 29825.4 29884.0 29926.6 22456.3 22610.2 22625.5 22884.3 22941.4 15:29:50 INFO - PID 19679 | 15:29:50 INFO - PID 19679 | [#2] jquery.html Cycles:180 Average:31369.87 Median:22420.28 stddev:69390.79 (309.5%) stddev-sans-first:69546.85 15:29:50 INFO - PID 19679 | Values: 543.2 559.9 569.5 572.8 582.7 21236.6 22328.2 22343.6 22461.8 22502.2 23177.5 23993.3 24097.5 24141.4 24356.3 6350.7 6489.6 6496.2 6521.5 6541.1 6379.3 6393.2 6430.4 6433.0 6441.5 6230.7 6441.1 6492.2 6500.5 6509.5 6390.1 6440.4 6443.7 6449.7 6461.9 5800.9 6003.7 6004.6 6017.5 6021.0 27142.3 27588.2 27598.9 27619.0 27672.0 2005.0 2008.4 2010.6 2010.9 2010.9 18390.5 18893.5 19189.6 19196.6 19242.2 2406.5 2452.2 2455.3 2475.8 2489.4 110943.4 116591.0 132316.0 132865.0 137478.0 14145.6 14385.1 14515.0 14604.1 14609.4 21943.0 21949.6 21958.2 21964.3 21973.7 9506.5 9701.3 9727.5 9754.8 9844.5 8945.3 8968.7 9023.3 9023.7 9115.8 8619.7 8633.2 8640.0 8808.8 8848.0 2593.5 2597.9 2663.2 2689.4 2692.9 943.5 944.2 951.3 952.9 975.1 18539.5 18838.2 18995.2 19024.0 19285.4 1015.2 1016.0 1021.0 1028.3 1029.6 10182.5 10247.3 10410.4 10607.3 10674.5 388732.0 400188.0 412272.0 416601.0 422032.0 105788.0 107036.0 107092.0 108439.0 112111.4 999.6 1042.7 1102.3 1123.3 1159.1 19376.0 19548.6 19646.9 19659.5 19962.4 50919.2 52026.0 53211.7 54542.7 54607.2 65747.7 66283.0 66689.3 66795.7 67334.3 13719.7 13783.9 13833.4 13860.5 14017.7 21823.0 21940.0 22012.8 22416.6 22424.0 17447.6 17570.3 17802.7 17841.6 17923.7 15758.9 16122.8 16312.5 16679.0 16806.4 17790.6 17916.6 18022.0 18023.8 18172.6 13572.8 13714.2 13776.2 13887.1 13889.7 17578.5 17764.4 17900.9 18014.3 18058.0 15:29:50 INFO - PID 19679 | 15:29:50 INFO - PID 19679 | [#3] mootools.html Cycles:180 Average:9176.89 Median:2723.78 stddev:6523.95 (239.5%) stddev-sans-first:6515.34 15:29:50 INFO - PID 19679 | Values: 1289.5 1325.6 1335.1 1354.5 1357.2 14765.4 15282.7 15357.7 15383.2 15413.5 15009.8 15028.2 15053.8 15092.1 15211.4 2691.3 2757.8 2778.3 2780.7 2783.4 2692.4 2705.6 2723.4 2724.2 2725.9 2624.8 2770.5 2775.5 2784.5 2813.6 2776.8 2778.5 2782.0 2794.6 2814.3 2675.4 2734.2 2734.7 2746.7 2767.6 14882.9 14935.9 14956.8 14958.9 14986.9 7588.7 7849.3 7851.7 7916.5 7927.0 5104.8 5238.4 5252.2 5307.6 5361.5 1888.3 1904.0 1904.9 1910.2 1939.5 24568.0 24630.9 24872.9 24893.6 24935.0 6226.9 6233.6 6293.0 6370.4 6432.2 17179.3 17212.9 17219.9 17232.9 17234.5 7608.6 7735.5 7749.1 7751.8 7778.1 6942.6 7083.9 7087.2 7133.8 7161.2 4752.7 4927.6 4956.5 4990.0 4995.9 1322.8 1326.1 1349.4 1352.9 1368.7 856.9 884.1 888.6 893.0 895.3 7666.7 7739.4 7785.8 7804.6 7854.2 679.6 702.7 710.8 719.4 725.1 5083.9 5258.9 5273.7 5360.6 5441.9 20148.6 20752.5 21687.8 21755.7 21759.1 20863.9 20981.0 21502.0 21502.5 21642.4 10245.8 10346.7 10419.0 10509.8 11072.3 8429.9 8518.1 8553.3 8588.7 8614.4 17827.0 18427.0 18731.1 18797.0 18854.1 18893.4 18966.9 19041.3 19179.4 19327.0 10149.9 10561.9 10595.8 10634.3 10659.1 13814.8 13964.4 13987.0 13987.9 13998.4 11285.3 11321.3 11427.4 11433.7 11722.4 11202.0 11253.3 11276.4 11379.0 11406.5 9459.1 9647.7 9652.6 9658.5 9677.5 7371.7 7434.9 7457.1 7474.1 7484.2 7416.3 7509.6 7597.5 7599.7 7603.5 15:29:50 INFO - PID 19679 | 15:29:50 INFO - PID 19679 | [#4] prototype.html Cycles:180 Average:5576.31 Median:6206.16 stddev:1572.52 (25.3%) stddev-sans-first:1530.06 15:29:50 INFO - PID 19679 | Values: 499.1 505.7 517.2 527.4 535.6 6262.3 6314.9 6323.8 6326.9 6340.7 6145.6 6175.1 6196.2 6215.8 6223.7 4880.3 5073.1 5123.7 5139.0 5190.6 5023.2 5041.4 5045.0 5050.7 5092.6 4921.8 4941.7 4962.7 4969.3 5017.4 4995.9 5006.3 5007.6 5014.6 5020.7 4483.4 4506.0 4532.2 4539.4 4549.4 6173.1 6196.3 6196.5 6228.7 6231.6 5620.3 5700.7 5734.7 5759.6 5766.3 6541.6 6607.9 6650.8 6651.2 6677.9 4860.1 4899.4 4912.8 4914.3 4928.8 6869.5 6980.5 7030.9 7040.1 7065.6 5015.5 5045.8 5064.0 5070.4 5072.4 5070.4 5096.8 5124.4 5125.7 5188.5 5720.3 5729.2 5749.1 5772.2 5778.3 6279.8 6441.7 6576.8 6604.7 6688.6 1745.3 1762.8 1780.8 1784.0 1784.3 1067.7 1214.4 1231.9 1235.2 1236.6 5629.2 5775.9 5793.4 5807.6 5815.8 6846.6 6851.0 6858.8 6864.8 6866.4 5833.5 5837.9 5856.8 5862.8 5869.5 3639.9 3643.8 3662.6 3662.7 3683.7 6599.6 6607.9 6622.4 6625.5 6630.5 6999.9 7022.4 7022.9 7061.7 7083.9 6539.5 6564.3 6588.3 6595.9 6616.7 6836.1 6846.0 6858.7 6864.9 6888.7 6723.9 6800.3 6841.7 6847.9 6899.1 6569.6 6578.0 6591.1 6604.0 6608.8 4981.2 5026.9 5031.0 5034.4 5041.2 6775.3 6837.1 6848.9 6856.7 6893.7 6586.9 6641.4 6642.7 6647.2 6660.9 6527.2 6561.4 6562.0 6578.3 6631.7 6472.3 6505.3 6521.7 6541.2 6541.8 6300.6 6628.3 6692.7 6697.6 6724.7 6364.4 6380.7 6393.5 6423.8 6443.6 15:29:50 INFO - PID 19679 | 15:29:50 INFO - PID 19679 | [#5] yui.html Cycles:180 Average:23430.54 Median:20389.13 stddev:34617.05 (169.8%) stddev-sans-first:34672.88 15:29:50 INFO - PID 19679 | Values: 916.9 918.5 928.7 929.8 943.8 18983.9 19868.8 19957.5 19964.3 19987.1 17060.1 17117.4 17134.7 17152.3 17166.7 912.6 923.9 927.9 928.3 929.0 972.5 972.7 975.2 976.5 977.0 999.2 1002.2 1027.3 1033.3 1036.9 1018.8 1020.2 1021.0 1021.5 1021.5 715.8 743.4 753.9 754.6 755.3 20000.9 20255.4 20269.9 20276.5 20279.9 19633.2 20156.7 20257.6 20382.2 20396.1 16443.8 16904.4 17015.0 17306.2 17421.1 3752.6 3760.1 3761.6 3765.4 3777.7 106300.5 133419.3 139728.0 140066.3 142167.0 16196.7 16666.0 16755.4 16761.7 16800.7 26093.6 26151.5 26421.0 26590.9 26805.7 8276.8 8296.7 8316.8 8317.5 8327.7 4226.8 4251.6 4295.2 4337.9 4339.3 5031.8 5117.9 5139.9 5156.5 5164.4 981.1 993.4 996.0 1004.2 1004.2 656.6 670.2 681.7 691.1 691.6 11506.1 11548.9 11581.6 11627.8 12123.0 652.1 656.1 661.9 671.5 681.5 5405.8 5464.2 5516.1 5530.2 5541.0 116231.4 120026.0 121109.0 121693.0 124345.4 105583.0 106050.0 106360.5 110122.0 110473.0 92253.5 93581.0 95519.0 97883.5 100124.0 10049.3 10175.6 10197.3 10255.4 10420.9 42726.8 43353.3 43781.8 43877.6 44434.1 56650.7 57082.1 57246.7 57418.4 57617.4 14241.3 14575.3 14602.2 14608.6 14633.9 15805.4 15806.1 15815.7 15864.9 15897.5 14451.2 14521.2 14567.4 14656.0 14728.3 13901.9 14019.1 14071.4 14263.0 14362.6 14044.5 14181.6 14206.6 14250.5 14250.7 9126.3 9381.2 9398.4 9459.2 9553.0 9192.0 9229.1 9283.9 9284.7 9294.0 15:29:50 INFO - PID 19679 | -------- Summary: end -------- 15:29:50 INFO - PID 19679 | 15:29:51 INFO - TEST-INFO | 19679: exit 0 15:29:51 INFO - TEST-OK | dromaeo_css | took 1109707ms 15:29:51 INFO - TEST-START | kraken 15:29:51 INFO - Initialising browser for kraken test... 15:29:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43230/getInfo.html -profile /tmp/tmp_PEOnA/profile 15:29:51 INFO - TEST-INFO | started process 20053 (/builds/slave/test/build/application/firefox/firefox http://localhost:43230/getInfo.html) 15:29:57 INFO - TEST-INFO | 20053: exit 0 15:29:57 INFO - Browser initialized. 15:29:57 INFO - Running cycle 1/1 for kraken test... 15:29:57 INFO - Using env: {'DISPLAY': ':0', 15:29:57 INFO - 'HOME': '/home/cltbld', 15:29:57 INFO - 'JSGC_DISABLE_POISONING': '1', 15:29:57 INFO - 'LANG': 'en_US.UTF-8', 15:29:57 INFO - 'LANGUAGE': 'en_US:en', 15:29:57 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:29:57 INFO - 'LOGNAME': 'cltbld', 15:29:57 INFO - 'MAIL': '/var/mail/cltbld', 15:29:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:29:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:29:57 INFO - 'MOZ_CRASHREPORTER': '1', 15:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:57 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:29:57 INFO - 'MOZ_NO_REMOTE': '1', 15:29:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:29:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:57 INFO - 'NO_EM_RESTART': '1', 15:29:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:57 INFO - 'PWD': '/builds/slave/test', 15:29:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:29:57 INFO - 'RUST_BACKTRACE': 'full', 15:29:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:29:57 INFO - 'SHELL': '/bin/bash', 15:29:57 INFO - 'SHLVL': '1', 15:29:57 INFO - 'STYLO_FORCE_DISABLED': '1', 15:29:57 INFO - 'TERM': 'linux', 15:29:57 INFO - 'TMOUT': '86400', 15:29:57 INFO - 'USER': 'cltbld', 15:29:57 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505080420.940871-177585425', 15:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:57 INFO - '_': '/tools/buildbot/bin/python'} 15:29:57 INFO - TEST-INFO | started process 20252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_PEOnA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:29:58 INFO - PID 20252 | 15:29:58 INFO - PID 20252 | (/builds/slave/test/build/application/firefox/firefox:20304): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:29:58 INFO - PID 20252 | 15:30:09 INFO - PID 20252 | RSS: Main: 164950016 15:30:09 INFO - PID 20252 | 15:30:11 INFO - PID 20252 | Cycle 1(1): loaded http://localhost:43230/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43230/tests/kraken/driver.html?testName=audio-beat-detection) 15:30:12 INFO - PID 20252 | RSS: Main: 170143744 15:30:12 INFO - PID 20252 | 15:30:15 INFO - PID 20252 | Cycle 1(1): loaded http://localhost:43230/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43230/tests/kraken/driver.html?testName=audio-dft) 15:30:16 INFO - PID 20252 | RSS: Main: 170795008 15:30:16 INFO - PID 20252 | 15:30:19 INFO - PID 20252 | Cycle 1(1): loaded http://localhost:43230/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43230/tests/kraken/driver.html?testName=audio-fft) 15:30:19 INFO - PID 20252 | RSS: Main: 165965824 15:30:19 INFO - PID 20252 | 15:30:21 INFO - PID 20252 | Cycle 1(1): loaded http://localhost:43230/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43230/tests/kraken/driver.html?testName=audio-oscillator) 15:30:22 INFO - PID 20252 | RSS: Main: 167485440 15:30:22 INFO - PID 20252 | 15:30:24 INFO - PID 20252 | Cycle 1(1): loaded http://localhost:43230/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43230/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:30:25 INFO - PID 20252 | RSS: Main: 167780352 15:30:25 INFO - PID 20252 | 15:30:28 INFO - PID 20252 | Cycle 1(1): loaded http://localhost:43230/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43230/tests/kraken/driver.html?testName=imaging-darkroom) 15:30:29 INFO - PID 20252 | RSS: Main: 170323968 15:30:29 INFO - PID 20252 | 15:30:32 INFO - PID 20252 | Cycle 1(1): loaded http://localhost:43230/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43230/tests/kraken/driver.html?testName=imaging-desaturate) 15:30:33 INFO - PID 20252 | RSS: Main: 169689088 15:30:33 INFO - PID 20252 | 15:30:36 INFO - PID 20252 | Cycle 1(1): loaded http://localhost:43230/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43230/tests/kraken/driver.html?testName=json-parse-financial) 15:30:36 INFO - PID 20252 | RSS: Main: 170446848 15:30:36 INFO - PID 20252 | 15:30:38 INFO - PID 20252 | Cycle 1(1): loaded http://localhost:43230/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43230/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:30:39 INFO - PID 20252 | RSS: Main: 170283008 15:30:39 INFO - PID 20252 | 15:30:40 INFO - PID 20252 | Cycle 1(1): loaded http://localhost:43230/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43230/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:30:41 INFO - PID 20252 | RSS: Main: 170717184 15:30:41 INFO - PID 20252 | 15:30:43 INFO - PID 20252 | Cycle 1(1): loaded http://localhost:43230/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43230/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:30:44 INFO - PID 20252 | RSS: Main: 170819584 15:30:44 INFO - PID 20252 | 15:30:46 INFO - PID 20252 | Cycle 1(1): loaded http://localhost:43230/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:30:47 INFO - PID 20252 | RSS: Main: 171106304 15:30:47 INFO - PID 20252 | 15:30:50 INFO - PID 20252 | Cycle 1(1): loaded http://localhost:43230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:30:51 INFO - PID 20252 | RSS: Main: 171753472 15:30:51 INFO - PID 20252 | 15:30:52 INFO - PID 20252 | Cycle 1(1): loaded http://localhost:43230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43230/tests/kraken/driver.html?testName=ai-astar) 15:30:53 INFO - PID 20252 | RSS: Main: 172974080 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | __start_tp_report 15:30:53 INFO - PID 20252 | _x_x_mozilla_page_load 15:30:53 INFO - PID 20252 | _x_x_mozilla_page_load_details 15:30:53 INFO - PID 20252 | |i|pagename|runs| 15:30:53 INFO - PID 20252 | |0;ai-astar;108;109;106;107;109;109;106;106;108;107 15:30:53 INFO - PID 20252 | |1;audio-beat-detection;127;116;119;141;118;118;118;121;146;126 15:30:53 INFO - PID 20252 | |2;audio-dft;167;164;168;165;164;164;167;171;171;175 15:30:53 INFO - PID 20252 | |3;audio-fft;76;79;76;74;75;76;75;73;74;72 15:30:53 INFO - PID 20252 | |4;audio-oscillator;82;79;78;79;80;78;78;78;81;126 15:30:53 INFO - PID 20252 | |5;imaging-gaussian-blur;113;115;114;115;115;116;112;114;114;117 15:30:53 INFO - PID 20252 | |6;imaging-darkroom;148;148;148;149;148;148;148;151;152;148 15:30:53 INFO - PID 20252 | |7;imaging-desaturate;95;94;95;96;94;94;94;95;93;95 15:30:53 INFO - PID 20252 | |8;json-parse-financial;54;53;53;51;53;53;55;54;53;53 15:30:53 INFO - PID 20252 | |9;json-stringify-tinderbox;38;39;38;38;39;39;38;39;39;39 15:30:53 INFO - PID 20252 | |10;stanford-crypto-aes;75;75;75;76;77;78;74;74;76;75 15:30:53 INFO - PID 20252 | |11;stanford-crypto-ccm;125;123;118;114;125;121;122;124;125;123 15:30:53 INFO - PID 20252 | |12;stanford-crypto-pbkdf2;172;168;177;182;178;161;186;178;171;168 15:30:53 INFO - PID 20252 | |13;stanford-crypto-sha256-iterative;66;65;69;66;64;64;64;64;63;64 15:30:53 INFO - PID 20252 | __end_tp_report 15:30:53 INFO - PID 20252 | __start_cc_report 15:30:53 INFO - PID 20252 | _x_x_mozilla_cycle_collect,948 15:30:53 INFO - PID 20252 | __end_cc_report 15:30:53 INFO - PID 20252 | __startTimestamp1505082653050__endTimestamp 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | ------- Summary: start ------- 15:30:53 INFO - PID 20252 | Number of tests: 14 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | [#0] ai-astar Cycles:10 Average:107.50 Median:108.00 stddev:1.27 (1.2%) stddev-sans-first:1.33 15:30:53 INFO - PID 20252 | Values: 108.0 109.0 106.0 107.0 109.0 109.0 106.0 106.0 108.0 107.0 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:123.50 stddev:10.45 (8.5%) stddev-sans-first:11.05 15:30:53 INFO - PID 20252 | Values: 127.0 116.0 119.0 141.0 118.0 118.0 118.0 121.0 146.0 126.0 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | [#2] audio-dft Cycles:10 Average:167.60 Median:167.50 stddev:3.72 (2.2%) stddev-sans-first:3.94 15:30:53 INFO - PID 20252 | Values: 167.0 164.0 168.0 165.0 164.0 164.0 167.0 171.0 171.0 175.0 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | [#3] audio-fft Cycles:10 Average:75.00 Median:75.50 stddev:1.94 (2.6%) stddev-sans-first:2.03 15:30:53 INFO - PID 20252 | Values: 76.0 79.0 76.0 74.0 75.0 76.0 75.0 73.0 74.0 72.0 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | [#4] audio-oscillator Cycles:10 Average:83.90 Median:79.00 stddev:14.86 (18.8%) stddev-sans-first:15.74 15:30:53 INFO - PID 20252 | Values: 82.0 79.0 78.0 79.0 80.0 78.0 78.0 78.0 81.0 126.0 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:115.00 stddev:1.43 (1.2%) stddev-sans-first:1.41 15:30:53 INFO - PID 20252 | Values: 113.0 115.0 114.0 115.0 115.0 116.0 112.0 114.0 114.0 117.0 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:148.00 stddev:1.48 (1.0%) stddev-sans-first:1.54 15:30:53 INFO - PID 20252 | Values: 148.0 148.0 148.0 149.0 148.0 148.0 148.0 151.0 152.0 148.0 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 15:30:53 INFO - PID 20252 | Values: 95.0 94.0 95.0 96.0 94.0 94.0 94.0 95.0 93.0 95.0 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:1.03 (1.9%) stddev-sans-first:1.05 15:30:53 INFO - PID 20252 | Values: 54.0 53.0 53.0 51.0 53.0 53.0 55.0 54.0 53.0 53.0 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | [#9] json-stringify-tinderbox Cycles:10 Average:38.60 Median:39.00 stddev:0.52 (1.3%) stddev-sans-first:0.50 15:30:53 INFO - PID 20252 | Values: 38.0 39.0 38.0 38.0 39.0 39.0 38.0 39.0 39.0 39.0 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.50 stddev:1.27 (1.7%) stddev-sans-first:1.33 15:30:53 INFO - PID 20252 | Values: 75.0 75.0 75.0 76.0 77.0 78.0 74.0 74.0 76.0 75.0 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:123.50 stddev:3.56 (2.9%) stddev-sans-first:3.61 15:30:53 INFO - PID 20252 | Values: 125.0 123.0 118.0 114.0 125.0 121.0 122.0 124.0 125.0 123.0 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:177.50 stddev:7.48 (4.2%) stddev-sans-first:7.89 15:30:53 INFO - PID 20252 | Values: 172.0 168.0 177.0 182.0 178.0 161.0 186.0 178.0 171.0 168.0 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.50 stddev:1.73 (2.7%) stddev-sans-first:1.79 15:30:53 INFO - PID 20252 | Values: 66.0 65.0 69.0 66.0 64.0 64.0 64.0 64.0 63.0 64.0 15:30:53 INFO - PID 20252 | -------- Summary: end -------- 15:30:53 INFO - PID 20252 | 15:30:53 INFO - PID 20252 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:30:53 INFO - TEST-INFO | 20252: exit 0 15:30:53 INFO - TEST-OK | kraken | took 62255ms 15:30:53 INFO - SUITE-END | took 1171s 15:30:54 INFO - Completed test suite (00:19:32) 15:30:54 INFO - javascript benchmark 15:30:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8334.854674105134, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3089.1813669377616, 3119.1110533497945, 3126.31221131351, 3144.7955882867614, 3167.4773662345715, 6286.46565041972, 6370.394812492817, 6377.489800815935, 6397.520185986053, 6438.613683179013, 6192.690365481731, 6338.873222535558, 6340.4927605791545, 6350.396712312335, 6478.671872266174, 5803.0, 5869.9727547679195, 5893.823185304448, 5904.291485021803, 5923.407659234063, 5686.346070201917, 5800.709964501779, 5886.617369870966, 5925.911111333334, 5944.613600116, 5816.360200377976, 5823.229416784074, 5884.735186916599, 5934.228550288478, 5941.613795103304, 5711.314642242916, 5837.09525023622, 5916.881662366772, 5945.286565612111, 5955.583109182359, 5762.222100016486, 5824.796132135355, 5850.06398976166, 5856.590038697293, 5870.794522191745, 6341.270753863272, 6356.110144579762, 6373.6175829450385, 6436.195475565554, 6438.549301548894, 6803.863922721567, 6823.28355522668, 6826.180858297036, 6917.308269173092, 6949.826254343631, 6748.662566871637, 6843.07618471505, 6922.342377474132, 6974.721011159548, 6998.650067496605, 6258.655773932432, 6308.842278943017, 6326.2092238470195, 6326.841828954267, 6334.493240540745, 6887.965560172267, 6919.861602767916, 6986.860262794716, 7052.435805135577, 7129.857402852018, 6732.461403087741, 6814.829629259309, 6833.350831670983, 6834.350736680008, 6836.863262734718, 6865.725370985205, 6881.965590172017, 6885.208201056842, 6979.6859141337745, 6986.371226589631, 6649.468042556584, 6786.898196527056, 6795.320467953264, 6797.422219111431, 6815.522913396015, 6785.355391237923, 6820.761273355409, 6836.589804611739, 6839.2818754031105, 6850.0752398426575, 5351.785928562892, 5401.729913504388, 5430.70131142791, 5446.2647542582035, 5447.182922561568, 4667.113248482778, 4670.6497012724185, 4673.112108699336, 4702.130105930414, 4735.905281894343, 5740.0, 5801.564882633819, 5811.3316968548315, 5880.382559831241, 5884.705764711747, 6707.899381509281, 6867.896981545281, 6907.240203577602, 6931.306869313028, 6936.514443988974, 5784.219130417424, 5824.184614154022, 5859.677717725481, 5875.0, 5967.850803729942, 5838.941610583925, 5840.8247752567495, 5914.0241860093465, 5951.285845698544, 5952.166696662471, 6345.809625711236, 6442.516811239176, 6600.73597056122, 6667.299933506912, 6700.597964122168, 6809.114815074008, 6905.1713794345, 6925.238223795278, 6926.168859736864, 6933.445324373937, 6588.6046837188005, 6594.868102638016, 6648.5678430901835, 6694.631795251308, 6704.765333213314, 6754.459643228628, 6789.15135608049, 6841.794746157623, 6850.109485766819, 6859.142607174103, 6748.0, 6841.17905851301, 6888.104546408935, 6905.516613836983, 6985.336393042653, 6559.836004099936, 6564.671766411756, 6570.737170513126, 6578.407943284936, 6579.80260592183, 6549.705263263069, 6572.079908812674, 6732.360425759545, 6733.865322693617, 6735.191776986793, 6594.307597702364, 6605.306442823435, 6609.735610575523, 6611.768588099393, 6658.500612454182, 6659.0, 6749.4600431964345, 6815.045893575003, 6816.284290149463, 6833.3166683331265, 6301.464375528131, 6320.115183874169, 6329.240491141092, 6403.743850246125, 6430.1319321892815], "value": 6220.706722552014, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.7726681995401, 766.390719378095, 773.8026803165192, 775.4533054196792, 777.5490215674907, 36605.0, 40030.0, 40066.799666001665, 40173.0, 40528.594714052924, 37212.627873721256, 37515.81242093786, 37520.812395938054, 37573.24853502935, 37613.62386376136, 6962.268961759019, 7040.788776336718, 7049.647517624124, 7057.611831349273, 7064.894026589605, 6896.655167241643, 6991.89512157318, 6995.370416662499, 6996.510244282902, 7003.614801185933, 6978.651067446633, 7016.122984626922, 7016.543924644907, 7610.657520411595, 7747.341475974549, 7699.230076992284, 7699.461037727361, 7712.0, 7761.146273909865, 7788.337991270749, 7595.4683172177965, 7609.6575654095695, 7670.424718146106, 7710.537367757953, 7772.183920688303, 38023.809880950415, 38180.42729359062, 38193.42709859354, 38543.0, 38546.0, 3501.77238479498, 3549.503069570262, 3552.236269202108, 3572.83922223498, 3578.481120237577, 30807.38385232283, 30990.690093099005, 31054.689453105406, 31123.84438077795, 31263.531047034314, 5082.771275292621, 5115.795368185305, 5147.481492959586, 5154.871128221787, 5161.612879034087, 179575.0, 180725.0, 181829.0, 182215.99999999866, 182239.0, 39750.20499589992, 40226.79886600548, 46035.53964460379, 46582.534174658496, 47906.0, 49525.257121143215, 49577.0, 49717.0, 49848.75075624599, 49956.0, 14938.850611493963, 15044.172570508508, 15050.096994180385, 15055.322510487054, 15061.397544098332, 12126.575569855013, 12134.453949572291, 12294.323812190236, 12318.81521777174, 12366.0, 13777.517786877612, 13797.24115173655, 13819.516316928859, 13904.304784760721, 13913.58259252224, 5526.917096243559, 5677.829665110054, 5815.0, 5862.12068189775, 5864.589478736533, 979.7893452907659, 986.3490096536252, 992.503748125937, 1008.7730260691433, 1013.6756238003768, 22357.888210558842, 22526.774732252794, 22713.886430568073, 22806.543869122856, 23162.1893233736, 1066.594694016269, 1079.1906070447164, 1085.4898197846999, 1095.1129585036147, 1099.428297285407, 11947.636654341995, 12069.437872033144, 12080.0, 12087.0, 12104.910558049818, 212607.0, 213895.0, 214078.0, 215379.0, 216706.0, 50129.49870501321, 50354.74822625937, 50493.49506504962, 50560.0, 50759.0, 1394.1565352961516, 1431.5991522373752, 1441.502681574855, 1443.141330908108, 1448.8478709735537, 22063.448413789785, 22225.77774222237, 22326.0, 22593.322200334016, 22708.318750437513, 35680.64319356877, 35707.28585428329, 36002.0, 36053.27893442169, 36095.27809443849, 187905.0, 188332.0, 189695.0, 190650.0, 191494.0, 29936.0, 30495.237619059702, 32456.403487721396, 32668.346633067682, 32682.83658581692, 41312.586874132074, 41325.586744133376, 41596.37605435981, 41619.37570936499, 41721.37417938672, 30538.847305763327, 30851.0, 30864.228394290323, 31051.844740777055, 31064.378712426078, 30233.546496803006, 30697.232569185948, 30797.538036929014, 30805.22986925345, 30955.845220773754, 33663.495047573815, 33774.49338259977, 33836.830815845766, 34087.31825363528, 34398.484022739176, 29506.0, 29760.702392975792, 29825.403491929606, 29884.0, 29926.551101733057, 22456.32631021072, 22610.208642697427, 22625.547489050456, 22884.31347059591, 22941.426464338525], "value": 16454.742887286495, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.2313276713451, 559.9244102046227, 569.4903061759725, 572.8424683212116, 582.6766144789643, 21236.57526849462, 22328.218512352072, 22343.553128937412, 22461.77538224617, 22502.212422565215, 23177.536449271047, 23993.280201593938, 24097.518049639, 24141.396465088383, 24356.269311920627, 6350.650714210705, 6489.610623362613, 6496.187976502937, 6521.47828173745, 6541.149650545422, 6379.298277189506, 6393.200849893763, 6430.421262086411, 6432.967835160817, 6441.484681225515, 6230.719617617218, 6441.1304473896125, 6492.15601971743, 6500.4799616030605, 6509.544331896769, 6390.137331460263, 6440.388163124542, 6443.743470023347, 6449.709763060673, 6461.901476748964, 5800.941990580082, 6003.699815009232, 6004.639721616717, 6017.458428741435, 6021.0, 27142.32144196391, 27588.17235482939, 27598.862005690044, 27619.03333383342, 27672.03147889834, 2005.027561632607, 2008.4075197816678, 2010.6179825833044, 2010.939671809848, 2010.9497262568407, 18390.54023649406, 18893.527661808428, 19189.61620767577, 19196.61606767857, 19242.230310787552, 2406.542756876188, 2452.1785201957364, 2455.34933242689, 2475.752424757528, 2489.352768280242, 110943.44528277387, 116591.0, 132316.0, 132865.0, 137477.999999999, 14145.646358840906, 14385.136891786526, 14515.0, 14604.12375257488, 14609.415623374945, 21943.0, 21949.561008779736, 21958.23146189876, 21964.341069767932, 21973.67039494409, 9506.524673766284, 9701.272404569685, 9727.513624318897, 9754.804903901882, 9844.50777461124, 8945.329100317373, 8968.686095986739, 9023.278137748965, 9023.684171053981, 9115.772105697411, 8619.6983105591, 8633.179847914438, 8640.019193378275, 8808.77978050541, 8847.955760221286, 2593.4683389905026, 2597.8960841566504, 2663.187727743057, 2689.367998520346, 2692.9461410771673, 943.5470973932551, 944.1549812917538, 951.2912879904516, 952.9190018848337, 975.1272611013104, 18539.536511587317, 18838.246470141316, 18995.24019039223, 19024.048797560066, 19285.4214373569, 1015.2132097624252, 1015.9542820573092, 1020.974475638115, 1028.28534168752, 1029.624187171692, 10182.505286204927, 10247.333923294962, 10410.427426491615, 10607.257491975643, 10674.466276686135, 388732.0, 400188.0, 412272.0, 416601.0, 422032.0, 105788.0, 107036.0, 107092.0, 108439.0, 112111.43944280226, 999.6201443451442, 1042.6507120114848, 1102.3496137279044, 1123.2867129372908, 1159.0553698735503, 19375.97379249692, 19548.60902781908, 19646.901765491082, 19659.508512287306, 19962.401127966183, 50919.236211457595, 52026.0, 53211.73394133004, 54542.72728636331, 54607.180892285854, 65747.6712616453, 66283.0, 66689.33310666832, 66795.66408671897, 67334.32665673281, 13719.657008574866, 13783.862161378658, 13833.446662133401, 13860.514881979485, 14017.719645607234, 21823.0, 21940.0, 22012.779872201074, 22416.551668966204, 22424.0, 17447.56381090483, 17570.297188112843, 17802.732959005367, 17841.553961151076, 17923.73114403259, 15758.921205393899, 16122.758158627395, 16312.51062468128, 16679.0, 16806.411775587796, 17790.644187115926, 17916.55208619743, 18022.0, 18023.819761802213, 18172.636547268718, 13572.796408054084, 13714.17714937107, 13776.173429594257, 13887.097338672955, 13889.722205556034, 17578.472645820646, 17764.378246761302, 17900.91049544744, 18014.2794288227, 18058.0], "value": 11517.34552000523, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.5422125145574, 1325.595693313539, 1335.1188215777588, 1354.4920654754474, 1357.1856885868485, 14765.409383624656, 15282.69434611307, 15357.692846143085, 15383.153926534036, 15413.460528881491, 15009.849901500982, 15028.248587570604, 15053.774193387108, 15092.094474331549, 15211.391544338241, 2691.2676639067654, 2757.8345299282005, 2778.2915356584044, 2780.7497325240724, 2783.4433113377304, 2692.394211302461, 2705.553583658694, 2723.360010397555, 2724.209979106057, 2725.8773355199064, 2624.763771260586, 2770.48745981993, 2775.5004099262123, 2784.49879021776, 2813.6342275504157, 2776.847273399962, 2778.458200650874, 2782.0, 2794.580812878064, 2814.3245621051005, 2675.38466152784, 2734.1934129431866, 2734.7128551502005, 2746.6978632350424, 2767.571026490897, 14882.925585372112, 14935.850641493664, 14956.775648365283, 14958.925205374013, 14986.925065374713, 7588.658510367047, 7849.254320839511, 7851.725189618393, 7916.525008499509, 7927.0, 5104.846854594368, 5238.371395432572, 5252.159654455307, 5307.575393968474, 5361.463853614647, 1888.3013285084608, 1903.9524011899675, 1904.8952307623076, 1910.169076451734, 1939.5442071113278, 24568.0, 24630.876845615836, 24872.875635621887, 24893.62659560108, 24935.0, 6226.875462490725, 6233.594816336924, 6293.0, 6370.394812492806, 6432.2281326241155, 17179.31282748701, 17212.913935430493, 17219.913900430416, 17232.913835430743, 17234.482965511055, 7608.619569021526, 7735.49719268257, 7749.108852481924, 7751.844963100706, 7778.0666320041955, 6942.583444993316, 7083.89374159388, 7087.1849737279845, 7133.785986420416, 7161.176464706521, 4752.691075080109, 4927.556519913225, 4956.4547899731, 4989.975050124799, 4995.850124496271, 1322.7552902713028, 1326.1247576599399, 1349.3590544491485, 1352.8985326100583, 1368.7057282684073, 856.8886044814259, 884.1070518775954, 888.6178943054549, 893.008760276093, 895.3329769321897, 7666.731664391719, 7739.419543534144, 7785.80535486606, 7804.609769511501, 7854.175311592315, 679.6092246958019, 702.6908160409404, 710.793869777769, 719.3957076056033, 725.1262229014026, 5083.923741143886, 5258.92111618326, 5273.683578985273, 5360.571154307646, 5441.863953401196, 20148.597028059357, 20752.48118797042, 21687.783122168577, 21755.67366489504, 21759.12963481443, 20863.8956805215, 20981.0, 21502.0, 21502.462438439165, 21642.350729477825, 10245.795084098276, 10346.741331466774, 10419.010194031554, 10509.842352364567, 11072.280301780358, 8429.915700843158, 8518.105598912025, 8553.272971797218, 8588.65645374203, 8614.44006139599, 17827.0, 18427.0, 18731.063446827877, 18797.0, 18854.057297134816, 18893.433197004113, 18966.905165474083, 19041.333553325567, 19179.424617261506, 19327.0, 10149.89850101519, 10561.894381056398, 10595.788084238426, 10634.30876992993, 10659.09397701204, 13814.792778108136, 13964.441422342992, 13987.0, 13987.930060349634, 13998.44006239739, 11285.322880627189, 11321.264117832314, 11427.428628568705, 11433.656990290305, 11722.413879306172, 11202.0, 11253.324800511995, 11276.436178191221, 11379.0, 11406.486708098322, 9459.10138536838, 9647.662331818352, 9652.613895444103, 9658.468784216935, 9677.467739274407, 7371.668274927749, 7434.8884766729625, 7457.142428620561, 7474.065741782278, 7484.214157513383, 7416.25837416254, 7509.586972716553, 7597.544147351176, 7599.658015389431, 7603.46775725716], "value": 6522.5917937741415, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.13649386561224, 505.6536272653233, 517.2164171280513, 527.4172039895915, 535.6250624562807, 6262.342454042328, 6314.905276420857, 6323.841903952403, 6326.905096423551, 6340.682965851701, 6145.60053596517, 6175.135481032659, 6196.194494715692, 6215.782447614334, 6223.688815559227, 4880.292357608145, 5073.137566613685, 5123.692578445296, 5139.0, 5190.558802501791, 5023.196288593826, 5041.395032596093, 5044.974775126119, 5050.671706339094, 5092.618053645972, 4921.8277360292395, 4941.654084214107, 4962.6774259673, 4969.304297398349, 5017.37282839645, 4995.900081998376, 5006.2740902569285, 5007.574356179729, 5014.598832093442, 5020.673656212334, 4483.439570053743, 4506.0, 4532.161550113239, 4539.415190657427, 4549.363089167519, 6173.135760993465, 6196.349383314777, 6196.535259855529, 6228.719707613168, 6231.594946328474, 5620.325560932673, 5700.657960522382, 5734.713264336809, 5759.5968282220265, 5766.308043034863, 6541.574797638138, 6607.933920660828, 6650.800475985729, 6651.201855777338, 6677.93322066778, 4860.1251774680895, 4899.363082799249, 4912.820922978495, 4914.262860570943, 4928.778204980785, 6869.484788640872, 6980.452134970699, 7030.910208917626, 7040.084788977451, 7065.646717664096, 5015.548600625888, 5045.770706747684, 5064.0, 5070.442251352349, 5072.365954255718, 5070.416902056237, 5096.847094587169, 5124.436312005751, 5125.69245845243, 5188.481151884781, 5720.2849643794525, 5729.197912292282, 5749.051406517878, 5772.191893134965, 5778.3354914184565, 6279.843003924939, 6441.710123044474, 6576.76981305652, 6604.735810567524, 6688.598684078971, 1745.3367720266217, 1762.770839790819, 1780.7685000949793, 1783.965300125924, 1784.2506147418117, 1067.7490789664423, 1214.3867346989714, 1231.9137660363688, 1235.1539195651008, 1236.5857437758273, 5629.183768353566, 5775.913361299584, 5793.391693872167, 5807.593468457252, 5815.79644712433, 6846.554973926679, 6850.965745171242, 6858.759943401957, 6864.828379290558, 6866.382025617719, 5833.533317334688, 5837.883242335214, 5856.795012174553, 5862.794802181903, 5869.530437564985, 3639.8544058237903, 3643.7813731176216, 3662.61542538035, 3662.7436079474714, 3683.7421380503642, 6599.637019963948, 6607.933920660828, 6622.437092847162, 6625.503087268474, 6630.53586248958, 6999.860002800017, 7022.403095736818, 7022.859542809115, 7061.717531298793, 7083.92916070843, 6539.50953678476, 6564.277929427759, 6588.341165883469, 6595.868082638416, 6616.702248398929, 6836.111305530249, 6846.0, 6858.6570671467225, 6864.906203607948, 6888.690008949709, 6723.899141512783, 6800.31996800316, 6841.657917104224, 6847.863042739217, 6899.137607799025, 6569.605823650596, 6578.0, 6591.143151390289, 6603.966980165068, 6608.801735947929, 4981.227909674007, 5026.924596131134, 5031.03169130215, 5034.421041580119, 5041.218611115283, 6775.322467753383, 6837.145356830396, 6848.897266541106, 6856.725730970706, 6893.724251029903, 6586.934130658632, 6641.402273795382, 6642.667866606747, 6647.202335719745, 6660.866782664417, 6527.2167339919515, 6561.4410379952815, 6561.96719016421, 6578.276389597045, 6631.734730610721, 6472.320406357453, 6505.31694172124, 6521.673916304071, 6541.247756508063, 6541.803745887631, 6300.621962682254, 6628.304028077176, 6692.6988285526295, 6697.564658297195, 6724.697388617426, 6364.395382438661, 6380.712867921047, 6393.456556192776, 6423.807285781434, 6443.6455994920725], "value": 5110.769824666554, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [916.8533034714447, 918.5177781664626, 928.7213835849244, 929.7907970706592, 943.7876477792497, 18983.905080474597, 19868.801311986877, 19957.50106247341, 19964.301249456254, 19987.100580473878, 17060.14699265038, 17117.40089096882, 17134.657306853856, 17152.313907443688, 17166.742498862528, 912.5665308978215, 923.8937522184967, 927.9164875161234, 928.3223247029672, 928.9581968811386, 972.5040229482979, 972.7324985628974, 975.1954637424118, 976.4531862157214, 976.9853452198223, 999.170688328689, 1002.2332915319786, 1027.2603725317758, 1033.2767063055853, 1036.9481525923711, 1018.801333739921, 1020.2042406922612, 1021.0453226233421, 1021.5198856537453, 1021.5403068619114, 715.8425146467769, 743.379278302618, 753.9472236943416, 754.6377738685406, 755.3466251692247, 20000.899995500076, 20255.39233822973, 20269.898650506802, 20276.493087672778, 20279.898600506902, 19633.214671413127, 20156.69764953527, 20257.594848103105, 20382.184712611477, 20396.082176301952, 16443.83556164435, 16904.408345707965, 17015.0, 17306.22122004513, 17421.128943552772, 3752.6434988676306, 3760.0599850037493, 3761.586225515191, 3765.416360464105, 3777.660010599059, 106300.46849765778, 133419.33290333487, 139728.0, 140066.29966850203, 142167.0, 16196.67606647884, 16666.0, 16755.41356052532, 16761.664766704598, 16800.74798878018, 26093.608595871076, 26151.476970460484, 26421.0, 26590.867045664647, 26805.731942680715, 8276.8344633107, 8296.709615163561, 8316.750497485085, 8317.542535160625, 8327.66689332432, 4226.809793559297, 4251.5748425157235, 4295.226859165317, 4337.934930976038, 4339.262325404688, 5031.77357018935, 5117.8720531986255, 5139.897202055938, 5156.484351564888, 5164.380274367025, 981.082687687015, 993.4337427666305, 995.9551820167965, 1004.1565085328214, 1004.1866088468364, 656.6093174561129, 670.2426258328155, 681.7409384433884, 691.0739608923966, 691.6299779617981, 11506.07951363889, 11548.884511154949, 11581.594644187413, 11627.76744465106, 12123.030157587373, 652.0968458684661, 656.1175219329994, 661.9172603424572, 671.4863129705778, 681.4616453002172, 5405.7567409466665, 5464.23500709901, 5516.089845175581, 5530.198121272393, 5540.972295138579, 116231.41884290693, 120026.0, 121109.0, 121693.0, 124345.37827310806, 105583.0, 106050.0, 106360.46819765851, 110122.0, 110473.0, 92253.53873230725, 93581.0, 95519.0, 97883.51058244663, 100124.0, 10049.346792458759, 10175.592976280866, 10197.337173084023, 10255.384676919408, 10420.947895260779, 42726.78636606797, 43353.3496997539, 43781.78109109434, 43877.56122438863, 44434.11131777411, 56650.716746416, 57082.14376784269, 57246.71376643257, 57418.42581574298, 57617.42382576121, 14241.287935603386, 14575.271236438348, 14602.196879171748, 14608.634784130481, 14633.853661463248, 15805.446809361618, 15806.130662813655, 15815.68368632644, 15864.92067539655, 15897.52307430779, 14451.205183714997, 14521.201333926736, 14567.417303308173, 14656.0, 14728.263586820402, 13901.930490347484, 14019.088759230617, 14071.366788494746, 14263.0, 14362.569122926328, 14044.508442204882, 14181.574552763434, 14206.573802785933, 14250.501232456814, 14250.71498570002, 9126.315526335418, 9381.249500039843, 9398.389104708172, 9459.243260539279, 9553.04469553039, 9192.034836342087, 9229.123233292827, 9283.907160928575, 9284.675036373694, 9294.0], "value": 8530.504204829072, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1445.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 106.0, 107.0, 109.0, 109.0, 106.0, 106.0, 108.0, 107.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 116.0, 119.0, 141.0, 118.0, 118.0, 118.0, 121.0, 146.0, 126.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 168.0, 165.0, 164.0, 164.0, 167.0, 171.0, 171.0, 175.0], "value": 167.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 74.0, 75.0, 76.0, 75.0, 73.0, 74.0, 72.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 78.0, 79.0, 80.0, 78.0, 78.0, 78.0, 81.0, 126.0], "value": 83.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 115.0, 115.0, 116.0, 112.0, 114.0, 114.0, 117.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 151.0, 152.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 96.0, 94.0, 94.0, 94.0, 95.0, 93.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 51.0, 53.0, 53.0, 55.0, 54.0, 53.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 38.0, 39.0, 39.0, 38.0, 39.0, 39.0, 39.0], "value": 38.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 76.0, 77.0, 78.0, 74.0, 74.0, 76.0, 75.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 123.0, 118.0, 114.0, 125.0, 121.0, 122.0, 124.0, 125.0, 123.0], "value": 122.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 177.0, 182.0, 178.0, 161.0, 186.0, 178.0, 171.0, 168.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 69.0, 66.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0], "value": 64.9, "unit": "score"}]}]} 15:30:54 INFO - Return code: 0 15:30:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:30:54 INFO - # TBPL SUCCESS # 15:30:54 INFO - Running post-action listener: _package_coverage_data 15:30:54 INFO - Running post-action listener: _resource_record_post_action 15:30:54 INFO - [mozharness: 2017-09-10 22:30:54.326687Z] Finished run-tests step (success) 15:30:54 INFO - Running post-run listener: _resource_record_post_run 15:30:54 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 296206336; Read time: 332; Write time: 264808 15:30:54 INFO - TinderboxPrint: CPU usage
13.1% 15:30:54 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 332 15:30:54 INFO - TinderboxPrint: I/O write bytes / time
296,206,336 / 264,808 15:30:54 INFO - TinderboxPrint: CPU idle
8,231.2 (86.9%) 15:30:54 INFO - TinderboxPrint: CPU user
1,193.5 (12.6%) 15:30:54 INFO - TinderboxPrint: Swap in / out
0 / 0 15:30:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12865536; Read time: 0; Write time: 3076 15:30:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:30:54 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 283340800; Read time: 332; Write time: 261732 15:30:54 INFO - Running post-run listener: _upload_blobber_files 15:30:54 INFO - Blob upload gear active. 15:30:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:30:54 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 15:30:54 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:30:54 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:30:55 INFO - (blobuploader) - INFO - Open directory for files ... 15:30:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 15:30:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 15:30:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:56 INFO - (blobuploader) - INFO - Done attempting. 15:30:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 15:30:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 15:30:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:57 INFO - (blobuploader) - INFO - Done attempting. 15:30:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:30:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:31:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:31:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:31:04 INFO - (blobuploader) - INFO - Done attempting. 15:31:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:31:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:31:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:31:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:31:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:31:05 INFO - (blobuploader) - INFO - Done attempting. 15:31:05 INFO - (blobuploader) - INFO - Iteration through files over. 15:31:05 INFO - Return code: 0 15:31:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:31:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:31:05 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3ea3958832ad7a67fb79e8779155355d8deae01b2824163f8dcbebbec73ba2b44fabee15c1ebf6b62a6582957c0677a31cd91ab708c7789a336f4b97cafa293", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05e3ed40875c0b371e2741727ec7a42306268f9c2f4bfa0d04002be94de2240253f896f8401f26d8213bd507036633a52b53672a044bd8d950cbd84d594ebe50", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9510b94c653605f60d6320bcf3226fbbff6225d2465a50eaf692fc6e1444ad681c332aec4039b0dad0d233be988e16e6db5827d4de6d4c5345a5d5365d582a59", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99602a9805980c991b11f2bdc72af24aef26349309a70a59f3624de24edbdf0e341aee487ddeab1a636b8a0aed5544becb8acdf26573b888f29f3a8d274872a6"} 15:31:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:31:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:31:05 INFO - Contents: 15:31:05 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3ea3958832ad7a67fb79e8779155355d8deae01b2824163f8dcbebbec73ba2b44fabee15c1ebf6b62a6582957c0677a31cd91ab708c7789a336f4b97cafa293", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05e3ed40875c0b371e2741727ec7a42306268f9c2f4bfa0d04002be94de2240253f896f8401f26d8213bd507036633a52b53672a044bd8d950cbd84d594ebe50", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9510b94c653605f60d6320bcf3226fbbff6225d2465a50eaf692fc6e1444ad681c332aec4039b0dad0d233be988e16e6db5827d4de6d4c5345a5d5365d582a59", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99602a9805980c991b11f2bdc72af24aef26349309a70a59f3624de24edbdf0e341aee487ddeab1a636b8a0aed5544becb8acdf26573b888f29f3a8d274872a6"} 15:31:05 INFO - Running post-run listener: copy_logs_to_upload_dir 15:31:05 INFO - Copying logs to upload dir... 15:31:05 INFO - mkdir: /builds/slave/test/build/upload/logs 15:31:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.281338 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-10 15:31:05.229926) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-10 15:31:05.234207) ========= 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=52faae308a556c440401f8e5000001e8-1505080420.940871-177585425 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-Non-PGO/sha512/e3ea3958832ad7a67fb79e8779155355d8deae01b2824163f8dcbebbec73ba2b44fabee15c1ebf6b62a6582957c0677a31cd91ab708c7789a336f4b97cafa293", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05e3ed40875c0b371e2741727ec7a42306268f9c2f4bfa0d04002be94de2240253f896f8401f26d8213bd507036633a52b53672a044bd8d950cbd84d594ebe50", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9510b94c653605f60d6320bcf3226fbbff6225d2465a50eaf692fc6e1444ad681c332aec4039b0dad0d233be988e16e6db5827d4de6d4c5345a5d5365d582a59", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99602a9805980c991b11f2bdc72af24aef26349309a70a59f3624de24edbdf0e341aee487ddeab1a636b8a0aed5544becb8acdf26573b888f29f3a8d274872a6"} build_url:https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011540 build_url: 'https://queue.taskcluster.net/v1/task/a9nroRyvTkaMibioQYD-ow/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3ea3958832ad7a67fb79e8779155355d8deae01b2824163f8dcbebbec73ba2b44fabee15c1ebf6b62a6582957c0677a31cd91ab708c7789a336f4b97cafa293", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05e3ed40875c0b371e2741727ec7a42306268f9c2f4bfa0d04002be94de2240253f896f8401f26d8213bd507036633a52b53672a044bd8d950cbd84d594ebe50", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9510b94c653605f60d6320bcf3226fbbff6225d2465a50eaf692fc6e1444ad681c332aec4039b0dad0d233be988e16e6db5827d4de6d4c5345a5d5365d582a59", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99602a9805980c991b11f2bdc72af24aef26349309a70a59f3624de24edbdf0e341aee487ddeab1a636b8a0aed5544becb8acdf26573b888f29f3a8d274872a6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-10 15:31:05.263048) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 15:31:05.263414) ========= 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=52faae308a556c440401f8e5000001e8-1505080420.940871-177585425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 15:31:05.348799) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-10 15:31:05.349110) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-10 15:31:05.349401) ========= ========= Total master_lag: 0.26 =========