builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-021 starttime: 1505688625.54 results: success (0) revision: dd87b8587fc1d63e57ebdadcbabba89c6d172969 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.536935) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.537346) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.537615) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.801034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.804367) ========= 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=df17445c3590ff7897617a0e00000225-1505687473.552855-995033135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-17 15:50:25-- 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% 58.9K=0.2s 2017-09-17 15:50:26 (58.9 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.338020 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.230194) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.230527) ========= 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=df17445c3590ff7897617a0e00000225-1505687473.552855-995033135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016712 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.307560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.307898) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dd87b8587fc1d63e57ebdadcbabba89c6d172969 --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 dd87b8587fc1d63e57ebdadcbabba89c6d172969 --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=df17445c3590ff7897617a0e00000225-1505687473.552855-995033135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-17 15:50:26,342 truncating revision to first 12 chars 2017-09-17 15:50:26,342 Setting DEBUG logging. 2017-09-17 15:50:26,342 attempt 1/10 2017-09-17 15:50:26,342 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dd87b8587fc1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-17 15:50:26,592 unpacking tar archive at: mozilla-central-dd87b8587fc1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.582868 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.917419) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.917715) ========= script_repo_revision: dd87b8587fc1d63e57ebdadcbabba89c6d172969 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.918062) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.918335) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.947978) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-17 15:50:26.948376) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1505687473.552855-995033135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:50:27 INFO - MultiFileLogger online at 20170917 15:50:27 in /builds/slave/test 15:50:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:50:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:27 INFO - {'append_to_log': False, 15:50:27 INFO - 'base_work_dir': '/builds/slave/test', 15:50:27 INFO - 'blob_upload_branch': 'Firefox', 15:50:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:27 INFO - 'branch': 'Firefox', 15:50:27 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:27 INFO - 'code_coverage': False, 15:50:27 INFO - 'config_files': ('talos/linux_config.py',), 15:50:27 INFO - 'default_actions': ('clobber', 15:50:27 INFO - 'read-buildbot-config', 15:50:27 INFO - 'download-and-extract', 15:50:27 INFO - 'populate-webroot', 15:50:27 INFO - 'create-virtualenv', 15:50:27 INFO - 'install', 15:50:27 INFO - 'setup-mitmproxy', 15:50:27 INFO - 'run-tests'), 15:50:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:27 INFO - 'disable_ccov_upload': False, 15:50:27 INFO - 'disable_stylo': False, 15:50:27 INFO - 'download_minidump_stackwalk': True, 15:50:27 INFO - 'download_symbols': 'ondemand', 15:50:27 INFO - 'enable_stylo': False, 15:50:27 INFO - 'enable_webrender': False, 15:50:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:50:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:27 INFO - 'gecko_profile': False, 15:50:27 INFO - 'gecko_profile_interval': 0, 15:50:27 INFO - 'installer_path': 'installer.exe', 15:50:27 INFO - 'log_level': 'info', 15:50:27 INFO - 'log_name': 'talos', 15:50:27 INFO - 'log_to_console': True, 15:50:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:50:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:50:27 INFO - 'opt_config_files': (), 15:50:27 INFO - 'pip_index': False, 15:50:27 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:50:27 INFO - 'system_bits': '32', 15:50:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:27 INFO - 'title': 'talos-linux64-ix-021', 15:50:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:27 INFO - 'use_talos_json': True, 15:50:27 INFO - 'verify': 'False', 15:50:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:27 INFO - 'work_dir': 'build'} 15:50:27 INFO - [mozharness: 2017-09-17 22:50:27.123822Z] Running clobber step. 15:50:27 INFO - Running pre-action listener: _resource_record_pre_action 15:50:27 INFO - Running main action method: clobber 15:50:27 INFO - rmtree: /builds/slave/test/build 15:50:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:50:28 INFO - Running post-action listener: _resource_record_post_action 15:50:28 INFO - [mozharness: 2017-09-17 22:50:28.133128Z] Finished clobber step (success) 15:50:28 INFO - [mozharness: 2017-09-17 22:50:28.133225Z] Running read-buildbot-config step. 15:50:28 INFO - Running pre-action listener: _resource_record_pre_action 15:50:28 INFO - Running main action method: read_buildbot_config 15:50:28 INFO - Using buildbot properties: 15:50:28 INFO - { 15:50:28 INFO - "project": "", 15:50:28 INFO - "product": "firefox", 15:50:28 INFO - "who": "archaeopteryx@coole-files.de", 15:50:28 INFO - "installer_path": "public/build/target.tar.bz2", 15:50:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:50:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:50:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 15:50:28 INFO - "stage_platform": "linux64-pgo", 15:50:28 INFO - "basedir": "/builds/slave/test", 15:50:28 INFO - "buildnumber": 28, 15:50:28 INFO - "platform": "ubuntu64_hw", 15:50:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:50:28 INFO - "slavebuilddir": "test", 15:50:28 INFO - "taskId": "e_SCyX5HQdC_FjcYUu4__g", 15:50:28 INFO - "branch": "mozilla-central", 15:50:28 INFO - "script_repo_revision": "production", 15:50:28 INFO - "revision": "dd87b8587fc1d63e57ebdadcbabba89c6d172969", 15:50:28 INFO - "slavename": "talos-linux64-ix-021", 15:50:28 INFO - "repo_path": "mozilla-central" 15:50:28 INFO - } 15:50:28 INFO - Finding installer, test and symbols from parent task. 15:50:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e_SCyX5HQdC_FjcYUu4__g'}, attempt #1 15:50:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e_SCyX5HQdC_FjcYUu4__g'}, attempt #1 15:50:29 INFO - Task dependencies: YIKFqidGRWqiZ2H-El64-g 15:50:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g'}, attempt #1 15:50:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.tar.bz2 15:50:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.test_packages.json 15:50:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.crashreporter-symbols.zip 15:50:29 INFO - Running post-action listener: _resource_record_post_action 15:50:29 INFO - [mozharness: 2017-09-17 22:50:29.502082Z] Finished read-buildbot-config step (success) 15:50:29 INFO - [mozharness: 2017-09-17 22:50:29.502297Z] Running download-and-extract step. 15:50:29 INFO - Running pre-action listener: _resource_record_pre_action 15:50:29 INFO - Running main action method: download_and_extract 15:50:29 INFO - mkdir: /builds/slave/test/build/tests 15:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:29 INFO - trying https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.test_packages.json 15:50:29 INFO - Downloading https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:50:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:50:30 INFO - Downloaded 989 bytes. 15:50:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:50:30 INFO - Using the following test package requirements: 15:50:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:50:30 INFO - u'common': [u'target.common.tests.zip'], 15:50:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:50:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:50:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:50:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:50:30 INFO - u'mozbase': [u'target.common.tests.zip'], 15:50:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:50:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:50:30 INFO - u'web-platform': [u'target.common.tests.zip', 15:50:30 INFO - u'target.web-platform.tests.tar.gz'], 15:50:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:50:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:50:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.common.tests.zip 15:50:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:50:30 INFO - Fetch https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.common.tests.zip into memory 15:50:32 INFO - Content-Length response header: 55321145 15:50:32 INFO - Bytes received: 55321145 15:50:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.talos.tests.zip 15:50:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:50:43 INFO - Fetch https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.talos.tests.zip into memory 15:50:44 INFO - Content-Length response header: 14508748 15:50:44 INFO - Bytes received: 14508748 15:50: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:50:44 INFO - trying https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.tar.bz2 15:50:44 INFO - Downloading https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:50:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:50:47 INFO - Downloaded 62189680 bytes. 15:50:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.tar.bz2 15:50:47 INFO - mkdir: /builds/slave/test/properties 15:50:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:50:47 INFO - Writing to file /builds/slave/test/properties/build_url 15:50:47 INFO - Contents: 15:50:47 INFO - build_url:https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.tar.bz2 15:50:47 INFO - Running post-action listener: _resource_record_post_action 15:50:47 INFO - Running post-action listener: find_tests_for_verification 15:50:47 INFO - Running post-action listener: set_extra_try_arguments 15:50:47 INFO - [mozharness: 2017-09-17 22:50:47.839881Z] Finished download-and-extract step (success) 15:50:47 INFO - [mozharness: 2017-09-17 22:50:47.839976Z] Running populate-webroot step. 15:50:47 INFO - Running pre-action listener: _resource_record_pre_action 15:50:47 INFO - Running main action method: populate_webroot 15:50:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:50:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['tresize', 15:50:47 INFO - 'tcanvasmark']}, 15:50:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:50:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['dromaeo_css', 15:50:47 INFO - 'kraken']}, 15:50:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'tests': ['damp', 'tps']}, 15:50:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['damp', 'tps']}, 15:50:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:50:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['dromaeo_dom']}, 15:50:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:50:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['basic_compositor_video', 15:50:47 INFO - 'glvideo']}, 15:50:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:50:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['ts_paint_webext', 15:50:47 INFO - 'tp5o_webext']}, 15:50:47 INFO - 'other-e10s': {'tests': ['a11yr', 15:50:47 INFO - 'ts_paint', 15:50:47 INFO - 'tpaint', 15:50:47 INFO - 'sessionrestore', 15:50:47 INFO - 'sessionrestore_many_windows', 15:50:47 INFO - 'sessionrestore_no_auto_restore', 15:50:47 INFO - 'tabpaint']}, 15:50:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['a11yr', 15:50:47 INFO - 'ts_paint', 15:50:47 INFO - 'tpaint', 15:50:47 INFO - 'sessionrestore', 15:50:47 INFO - 'sessionrestore_many_windows', 15:50:47 INFO - 'sessionrestore_no_auto_restore', 15:50:47 INFO - 'tabpaint']}, 15:50:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:50:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:50:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['perf_reftest_singletons']}, 15:50:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['bloom_basic']}, 15:50:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:50:47 INFO - 'tsvgr_opacity', 15:50:47 INFO - 'tart', 15:50:47 INFO - 'tscrollx', 15:50:47 INFO - 'tsvg_static']}, 15:50:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['tsvgx', 15:50:47 INFO - 'tsvgr_opacity', 15:50:47 INFO - 'tart', 15:50:47 INFO - 'tscrollx', 15:50:47 INFO - 'tsvg_static']}, 15:50:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:50:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['tp5o']}, 15:50:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:50:47 INFO - 'talos_options': ['--mitmproxy', 15:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:50:47 INFO - '--firstNonBlankPaint'], 15:50:47 INFO - 'tests': ['tp6_google', 15:50:47 INFO - 'tp6_youtube', 15:50:47 INFO - 'tp6_amazon', 15:50:47 INFO - 'tp6_facebook']}, 15:50:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo', 15:50:47 INFO - '--mitmproxy', 15:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:50:47 INFO - '--firstNonBlankPaint'], 15:50:47 INFO - 'tests': ['tp6_google', 15:50:47 INFO - 'tp6_youtube', 15:50:47 INFO - 'tp6_amazon', 15:50:47 INFO - 'tp6_facebook']}, 15:50:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:50:47 INFO - 'talos_options': ['--stylo-threads=1', 15:50:47 INFO - '--mitmproxy', 15:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:50:47 INFO - '--firstNonBlankPaint'], 15:50:47 INFO - 'tests': ['tp6_google', 15:50:47 INFO - 'tp6_youtube', 15:50:47 INFO - 'tp6_amazon', 15:50:47 INFO - 'tp6_facebook']}, 15:50:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--xperf_path', 15:50:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:47 INFO - 'tests': ['tp5n']}, 15:50:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo', 15:50:47 INFO - '--xperf_path', 15:50:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:47 INFO - 'tests': ['tp5n']}}} 15:50:47 INFO - Running post-action listener: _resource_record_post_action 15:50:47 INFO - [mozharness: 2017-09-17 22:50:47.858762Z] Finished populate-webroot step (success) 15:50:47 INFO - [mozharness: 2017-09-17 22:50:47.858904Z] Running create-virtualenv step. 15:50:47 INFO - Running pre-action listener: _resource_record_pre_action 15:50:47 INFO - Running main action method: create_virtualenv 15:50:47 INFO - Creating virtualenv /builds/slave/test/build/venv 15:50:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:50:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:50:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:50:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:50:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:50:48 INFO - Installing distribute.............................................................................................................................................................................................done. 15:50:48 INFO - Installing pip...............done. 15:50:48 INFO - Return code: 0 15:50:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:50:48 INFO - Reading from file tmpfile_stdout 15:50:48 INFO - Output received: 15:50:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:50:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa6e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddaa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde090>, '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 0xdded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd8f90>, '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': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', '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:50:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:50:48 INFO - Using env: {'DISPLAY': ':0', 15:50:48 INFO - 'HOME': '/home/cltbld', 15:50:48 INFO - 'LANG': 'en_US.UTF-8', 15:50:48 INFO - 'LANGUAGE': 'en_US:en', 15:50:48 INFO - 'LOGNAME': 'cltbld', 15:50:48 INFO - 'MAIL': '/var/mail/cltbld', 15:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:48 INFO - 'MOZ_NO_REMOTE': '1', 15:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:48 INFO - 'NO_EM_RESTART': '1', 15:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:48 INFO - 'PWD': '/builds/slave/test', 15:50:48 INFO - 'SHELL': '/bin/bash', 15:50:48 INFO - 'SHLVL': '1', 15:50:48 INFO - 'TERM': 'linux', 15:50:48 INFO - 'TMOUT': '86400', 15:50:48 INFO - 'USER': 'cltbld', 15:50:48 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', 15:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:48 INFO - '_': '/tools/buildbot/bin/python'} 15:50:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:50:50 INFO - Downloading/unpacking pip>=1.5 15:50:50 INFO - Running setup.py egg_info for package pip 15:50:50 INFO - warning: no files found matching 'pip/cacert.pem' 15:50:50 INFO - warning: no files found matching '*.html' under directory 'docs' 15:50:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:50:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:50:50 INFO - Installing collected packages: pip 15:50:50 INFO - Found existing installation: pip 1.1 15:50:50 INFO - Uninstalling pip: 15:50:50 INFO - Successfully uninstalled pip 15:50:50 INFO - Running setup.py install for pip 15:50:50 INFO - warning: no files found matching 'pip/cacert.pem' 15:50:50 INFO - warning: no files found matching '*.html' under directory 'docs' 15:50:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:50:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:50:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:50:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:50:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:50:50 INFO - Successfully installed pip 15:50:50 INFO - Cleaning up... 15:50:50 INFO - Return code: 0 15:50:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:50: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:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50: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:50:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa6e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddaa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde090>, '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 0xdded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd8f90>, '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': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', '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:50:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:50:50 INFO - Using env: {'DISPLAY': ':0', 15:50:50 INFO - 'HOME': '/home/cltbld', 15:50:50 INFO - 'LANG': 'en_US.UTF-8', 15:50:50 INFO - 'LANGUAGE': 'en_US:en', 15:50:50 INFO - 'LOGNAME': 'cltbld', 15:50:50 INFO - 'MAIL': '/var/mail/cltbld', 15:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:50 INFO - 'MOZ_NO_REMOTE': '1', 15:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:50 INFO - 'NO_EM_RESTART': '1', 15:50:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:50 INFO - 'PWD': '/builds/slave/test', 15:50:50 INFO - 'SHELL': '/bin/bash', 15:50:50 INFO - 'SHLVL': '1', 15:50:50 INFO - 'TERM': 'linux', 15:50:50 INFO - 'TMOUT': '86400', 15:50:50 INFO - 'USER': 'cltbld', 15:50:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', 15:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:50 INFO - '_': '/tools/buildbot/bin/python'} 15:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:50 INFO - Downloading/unpacking psutil>=3.1.1 15:50: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:50: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:50: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:50: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:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:51 INFO - Installing collected packages: psutil 15:50:51 INFO - Running setup.py install for psutil 15:50:51 INFO - building 'psutil._psutil_linux' extension 15:50:51 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:50:51 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:50:51 INFO - building 'psutil._psutil_posix' extension 15:50:51 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:50:51 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:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:52 INFO - Successfully installed psutil 15:50:52 INFO - Cleaning up... 15:50:52 INFO - Return code: 0 15:50:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:50: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:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50: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:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa6e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddaa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde090>, '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 0xdded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd8f90>, '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': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', '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:50:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:50:52 INFO - Using env: {'DISPLAY': ':0', 15:50:52 INFO - 'HOME': '/home/cltbld', 15:50:52 INFO - 'LANG': 'en_US.UTF-8', 15:50:52 INFO - 'LANGUAGE': 'en_US:en', 15:50:52 INFO - 'LOGNAME': 'cltbld', 15:50:52 INFO - 'MAIL': '/var/mail/cltbld', 15:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:52 INFO - 'MOZ_NO_REMOTE': '1', 15:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:52 INFO - 'NO_EM_RESTART': '1', 15:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:52 INFO - 'PWD': '/builds/slave/test', 15:50:52 INFO - 'SHELL': '/bin/bash', 15:50:52 INFO - 'SHLVL': '1', 15:50:52 INFO - 'TERM': 'linux', 15:50:52 INFO - 'TMOUT': '86400', 15:50:52 INFO - 'USER': 'cltbld', 15:50:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', 15:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:52 INFO - '_': '/tools/buildbot/bin/python'} 15:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:50:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:50:53 INFO - Installing collected packages: mozsystemmonitor 15:50:53 INFO - Running setup.py install for mozsystemmonitor 15:50:53 INFO - Successfully installed mozsystemmonitor 15:50:53 INFO - Cleaning up... 15:50:53 INFO - Return code: 0 15:50:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa6e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddaa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde090>, '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 0xdded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd8f90>, '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': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', '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:50:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:50:53 INFO - Using env: {'DISPLAY': ':0', 15:50:53 INFO - 'HOME': '/home/cltbld', 15:50:53 INFO - 'LANG': 'en_US.UTF-8', 15:50:53 INFO - 'LANGUAGE': 'en_US:en', 15:50:53 INFO - 'LOGNAME': 'cltbld', 15:50:53 INFO - 'MAIL': '/var/mail/cltbld', 15:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:53 INFO - 'MOZ_NO_REMOTE': '1', 15:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:53 INFO - 'NO_EM_RESTART': '1', 15:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:53 INFO - 'PWD': '/builds/slave/test', 15:50:53 INFO - 'SHELL': '/bin/bash', 15:50:53 INFO - 'SHLVL': '1', 15:50:53 INFO - 'TERM': 'linux', 15:50:53 INFO - 'TMOUT': '86400', 15:50:53 INFO - 'USER': 'cltbld', 15:50:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', 15:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:53 INFO - '_': '/tools/buildbot/bin/python'} 15:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:53 INFO - Downloading/unpacking jsonschema==2.5.1 15:50: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:50: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:50: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:50: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:50:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:50:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:50: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:50: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:50: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:50: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:50:54 INFO - Downloading functools32-3.2.3-2.tar.gz 15:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:50:55 INFO - warning: no files found matching '*.txt' 15:50:55 INFO - no previously-included directories found matching 'build' 15:50:55 INFO - no previously-included directories found matching 'dist' 15:50:55 INFO - no previously-included directories found matching '.git*' 15:50:55 INFO - Installing collected packages: jsonschema, functools32 15:50:55 INFO - Running setup.py install for functools32 15:50:55 INFO - warning: no files found matching '*.txt' 15:50:55 INFO - no previously-included directories found matching 'build' 15:50:55 INFO - no previously-included directories found matching 'dist' 15:50:55 INFO - no previously-included directories found matching '.git*' 15:50:55 INFO - Successfully installed jsonschema functools32 15:50:55 INFO - Cleaning up... 15:50:55 INFO - Return code: 0 15:50:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:50: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:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50: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:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa6e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddaa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde090>, '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 0xdded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd8f90>, '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': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', '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:50:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:50:55 INFO - Using env: {'DISPLAY': ':0', 15:50:55 INFO - 'HOME': '/home/cltbld', 15:50:55 INFO - 'LANG': 'en_US.UTF-8', 15:50:55 INFO - 'LANGUAGE': 'en_US:en', 15:50:55 INFO - 'LOGNAME': 'cltbld', 15:50:55 INFO - 'MAIL': '/var/mail/cltbld', 15:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:55 INFO - 'MOZ_NO_REMOTE': '1', 15:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:55 INFO - 'NO_EM_RESTART': '1', 15:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:55 INFO - 'PWD': '/builds/slave/test', 15:50:55 INFO - 'SHELL': '/bin/bash', 15:50:55 INFO - 'SHLVL': '1', 15:50:55 INFO - 'TERM': 'linux', 15:50:55 INFO - 'TMOUT': '86400', 15:50:55 INFO - 'USER': 'cltbld', 15:50:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', 15:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:55 INFO - '_': '/tools/buildbot/bin/python'} 15:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:50:55 INFO - Cleaning up... 15:50:55 INFO - Return code: 0 15:50:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:50: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:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50: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:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa6e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddaa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde090>, '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 0xdded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd8f90>, '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': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', '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:50:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:50:55 INFO - Using env: {'DISPLAY': ':0', 15:50:55 INFO - 'HOME': '/home/cltbld', 15:50:55 INFO - 'LANG': 'en_US.UTF-8', 15:50:55 INFO - 'LANGUAGE': 'en_US:en', 15:50:55 INFO - 'LOGNAME': 'cltbld', 15:50:55 INFO - 'MAIL': '/var/mail/cltbld', 15:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:55 INFO - 'MOZ_NO_REMOTE': '1', 15:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:55 INFO - 'NO_EM_RESTART': '1', 15:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:55 INFO - 'PWD': '/builds/slave/test', 15:50:55 INFO - 'SHELL': '/bin/bash', 15:50:55 INFO - 'SHLVL': '1', 15:50:55 INFO - 'TERM': 'linux', 15:50:55 INFO - 'TMOUT': '86400', 15:50:55 INFO - 'USER': 'cltbld', 15:50:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', 15:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:55 INFO - '_': '/tools/buildbot/bin/python'} 15:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:55 INFO - Downloading/unpacking blobuploader==1.2.4 15:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:56 INFO - Downloading blobuploader-1.2.4.tar.gz 15:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:50:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:50:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:57 INFO - Downloading docopt-0.6.1.tar.gz 15:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:50:57 INFO - Installing collected packages: blobuploader, requests, docopt 15:50:57 INFO - Running setup.py install for blobuploader 15:50:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:50:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:50:57 INFO - Running setup.py install for requests 15:50:58 INFO - Running setup.py install for docopt 15:50:59 INFO - Successfully installed blobuploader requests docopt 15:50:59 INFO - Cleaning up... 15:51:01 INFO - Return code: 0 15:51:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51: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:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51: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:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:01 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 0xa6e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddaa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde090>, '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 0xdded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd8f90>, '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': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', '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:51:01 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:51:01 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:51:01 INFO - Using env: {'DISPLAY': ':0', 15:51:01 INFO - 'HOME': '/home/cltbld', 15:51:01 INFO - 'LANG': 'en_US.UTF-8', 15:51:01 INFO - 'LANGUAGE': 'en_US:en', 15:51:01 INFO - 'LOGNAME': 'cltbld', 15:51:01 INFO - 'MAIL': '/var/mail/cltbld', 15:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:01 INFO - 'MOZ_NO_REMOTE': '1', 15:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:01 INFO - 'NO_EM_RESTART': '1', 15:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:01 INFO - 'PWD': '/builds/slave/test', 15:51:01 INFO - 'SHELL': '/bin/bash', 15:51:01 INFO - 'SHLVL': '1', 15:51:01 INFO - 'TERM': 'linux', 15:51:01 INFO - 'TMOUT': '86400', 15:51:01 INFO - 'USER': 'cltbld', 15:51:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', 15:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:01 INFO - '_': '/tools/buildbot/bin/python'} 15:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:03 INFO - Running setup.py (path:/tmp/pip-eGyvPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:03 INFO - Running setup.py (path:/tmp/pip-w_i_Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:03 INFO - Running setup.py (path:/tmp/pip-1uqru4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:03 INFO - Running setup.py (path:/tmp/pip-vUBAkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:03 INFO - Running setup.py (path:/tmp/pip-ki7Loe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:03 INFO - Running setup.py (path:/tmp/pip-Gz6A8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:03 INFO - Running setup.py (path:/tmp/pip-U_zLpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:03 INFO - Running setup.py (path:/tmp/pip-3dJLed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:03 INFO - Running setup.py (path:/tmp/pip-0BaVOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:03 INFO - Running setup.py (path:/tmp/pip-8s7bFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:03 INFO - Running setup.py (path:/tmp/pip-16w8Gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:03 INFO - Running setup.py (path:/tmp/pip-GDb9fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:04 INFO - Running setup.py (path:/tmp/pip-T7UDQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:04 INFO - Running setup.py (path:/tmp/pip-6iG8xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:04 INFO - Running setup.py (path:/tmp/pip-Vxh0WQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:04 INFO - Running setup.py (path:/tmp/pip-uQAweI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:04 INFO - Running setup.py (path:/tmp/pip-fnvzw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:04 INFO - Running setup.py install for manifestparser 15:51:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:04 INFO - Running setup.py install for mozcrash 15:51:04 INFO - Running setup.py install for mozdebug 15:51:04 INFO - Running setup.py install for mozdevice 15:51:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:04 INFO - Running setup.py install for mozfile 15:51:04 INFO - Running setup.py install for mozhttpd 15:51:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:04 INFO - Running setup.py install for mozinfo 15:51:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Running setup.py install for mozInstall 15:51:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Running setup.py install for mozleak 15:51:05 INFO - Running setup.py install for mozlog 15:51:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Running setup.py install for moznetwork 15:51:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Running setup.py install for mozprocess 15:51:05 INFO - Running setup.py install for mozprofile 15:51:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Running setup.py install for mozrunner 15:51:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Running setup.py install for mozscreenshot 15:51:05 INFO - Running setup.py install for moztest 15:51:05 INFO - Running setup.py install for mozversion 15:51:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:06 INFO - Cleaning up... 15:51:06 INFO - Return code: 0 15:51:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:06 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:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:06 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:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:06 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 0xa6e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddaa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde090>, '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 0xdded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd8f90>, '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': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', '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:51:06 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:51:06 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:51:06 INFO - Using env: {'DISPLAY': ':0', 15:51:06 INFO - 'HOME': '/home/cltbld', 15:51:06 INFO - 'LANG': 'en_US.UTF-8', 15:51:06 INFO - 'LANGUAGE': 'en_US:en', 15:51:06 INFO - 'LOGNAME': 'cltbld', 15:51:06 INFO - 'MAIL': '/var/mail/cltbld', 15:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:06 INFO - 'MOZ_NO_REMOTE': '1', 15:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:06 INFO - 'NO_EM_RESTART': '1', 15:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:06 INFO - 'PWD': '/builds/slave/test', 15:51:06 INFO - 'SHELL': '/bin/bash', 15:51:06 INFO - 'SHLVL': '1', 15:51:06 INFO - 'TERM': 'linux', 15:51:06 INFO - 'TMOUT': '86400', 15:51:06 INFO - 'USER': 'cltbld', 15:51:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', 15:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:06 INFO - '_': '/tools/buildbot/bin/python'} 15:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:06 INFO - Running setup.py (path:/tmp/pip-Zlyb1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:06 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:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:06 INFO - Running setup.py (path:/tmp/pip-Era_dX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:06 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:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:06 INFO - Running setup.py (path:/tmp/pip-92RJly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:06 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:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:06 INFO - Running setup.py (path:/tmp/pip-hGUNC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:06 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:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:06 INFO - Running setup.py (path:/tmp/pip-FcIugp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:06 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:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:06 INFO - Running setup.py (path:/tmp/pip-GppcIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:06 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:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:06 INFO - Running setup.py (path:/tmp/pip-mwGsb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:06 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:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:06 INFO - Running setup.py (path:/tmp/pip-lSdMt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:06 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:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:06 INFO - Running setup.py (path:/tmp/pip-AjWW__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:06 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:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:06 INFO - Running setup.py (path:/tmp/pip-5qU5M_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:07 INFO - Running setup.py (path:/tmp/pip-f6_sTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:07 INFO - Running setup.py (path:/tmp/pip-ivv4wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:07 INFO - Running setup.py (path:/tmp/pip-3NDuwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:07 INFO - Running setup.py (path:/tmp/pip-_tZR5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:07 INFO - Running setup.py (path:/tmp/pip-s3ODhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:07 INFO - Running setup.py (path:/tmp/pip-ICImA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:07 INFO - Running setup.py (path:/tmp/pip-zT8FFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:07 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:51:07 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:51:07 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:51:07 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:51:07 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:51:07 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:51:07 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:51:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:07 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:51:07 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:51:07 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:51:07 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:51:08 INFO - Downloading blessings-1.6.tar.gz 15:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:08 INFO - Installing collected packages: blessings 15:51:08 INFO - Running setup.py install for blessings 15:51:08 INFO - Successfully installed blessings 15:51:08 INFO - Cleaning up... 15:51:08 INFO - Return code: 0 15:51:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:09 INFO - Reading from file tmpfile_stdout 15:51:09 INFO - Current package versions: 15:51:09 INFO - argparse == 1.2.1 15:51:09 INFO - blessings == 1.6 15:51:09 INFO - blobuploader == 1.2.4 15:51:09 INFO - docopt == 0.6.1 15:51:09 INFO - functools32 == 3.2.3-2 15:51:09 INFO - jsonschema == 2.5.1 15:51:09 INFO - manifestparser == 1.1 15:51:09 INFO - mozInstall == 1.13 15:51:09 INFO - mozcrash == 1.0 15:51:09 INFO - mozdebug == 0.1 15:51:09 INFO - mozdevice == 0.51 15:51:09 INFO - mozfile == 1.2 15:51:09 INFO - mozhttpd == 0.7 15:51:09 INFO - mozinfo == 0.10 15:51:09 INFO - mozleak == 0.1 15:51:09 INFO - mozlog == 3.5 15:51:09 INFO - moznetwork == 0.27 15:51:09 INFO - mozprocess == 0.25 15:51:09 INFO - mozprofile == 0.28 15:51:09 INFO - mozrunner == 6.13 15:51:09 INFO - mozscreenshot == 0.1 15:51:09 INFO - mozsystemmonitor == 0.3 15:51:09 INFO - moztest == 0.8 15:51:09 INFO - mozversion == 1.4 15:51:09 INFO - psutil == 3.1.1 15:51:09 INFO - requests == 1.2.3 15:51:09 INFO - wsgiref == 0.1.2 15:51:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:09 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:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:09 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:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:09 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 0xa6e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddaa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde090>, '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 0xdded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd8f90>, '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': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', '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:51:09 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:51:09 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:51:09 INFO - Using env: {'DISPLAY': ':0', 15:51:09 INFO - 'HOME': '/home/cltbld', 15:51:09 INFO - 'LANG': 'en_US.UTF-8', 15:51:09 INFO - 'LANGUAGE': 'en_US:en', 15:51:09 INFO - 'LOGNAME': 'cltbld', 15:51:09 INFO - 'MAIL': '/var/mail/cltbld', 15:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:09 INFO - 'MOZ_NO_REMOTE': '1', 15:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:09 INFO - 'NO_EM_RESTART': '1', 15:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:09 INFO - 'PWD': '/builds/slave/test', 15:51:09 INFO - 'SHELL': '/bin/bash', 15:51:09 INFO - 'SHLVL': '1', 15:51:09 INFO - 'TERM': 'linux', 15:51:09 INFO - 'TMOUT': '86400', 15:51:09 INFO - 'USER': 'cltbld', 15:51:09 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', 15:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:09 INFO - '_': '/tools/buildbot/bin/python'} 15:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:09 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:51:09 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:51:09 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:51:09 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:51:09 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:51:09 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:51:09 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:51:09 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:51:09 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:51:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:51:09 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:51:09 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:51:09 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:51:09 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:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:51:10 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:51:10 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:51:10 INFO - Installing collected packages: simplejson 15:51:10 INFO - Running setup.py install for simplejson 15:51:10 INFO - building 'simplejson._speedups' extension 15:51:10 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:51:11 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:51:11 INFO - Successfully installed simplejson 15:51:11 INFO - Cleaning up... 15:51:11 INFO - Return code: 0 15:51:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:51:11 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:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:11 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:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:11 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 0xa6e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddaa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde090>, '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 0xdded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd8f90>, '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': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', '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:51:11 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:51:11 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:51:11 INFO - Using env: {'DISPLAY': ':0', 15:51:11 INFO - 'HOME': '/home/cltbld', 15:51:11 INFO - 'LANG': 'en_US.UTF-8', 15:51:11 INFO - 'LANGUAGE': 'en_US:en', 15:51:11 INFO - 'LOGNAME': 'cltbld', 15:51:11 INFO - 'MAIL': '/var/mail/cltbld', 15:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:11 INFO - 'MOZ_NO_REMOTE': '1', 15:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:11 INFO - 'NO_EM_RESTART': '1', 15:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:11 INFO - 'PWD': '/builds/slave/test', 15:51:11 INFO - 'SHELL': '/bin/bash', 15:51:11 INFO - 'SHLVL': '1', 15:51:11 INFO - 'TERM': 'linux', 15:51:11 INFO - 'TMOUT': '86400', 15:51:11 INFO - 'USER': 'cltbld', 15:51:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', 15:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:11 INFO - '_': '/tools/buildbot/bin/python'} 15:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:51:11 INFO - Cleaning up... 15:51:11 INFO - Return code: 0 15:51:11 INFO - Running post-action listener: _resource_record_post_action 15:51:11 INFO - Running post-action listener: _start_resource_monitoring 15:51:11 INFO - Starting resource monitoring. 15:51:11 INFO - [mozharness: 2017-09-17 22:51:11.791986Z] Finished create-virtualenv step (success) 15:51:11 INFO - [mozharness: 2017-09-17 22:51:11.792455Z] Running install step. 15:51:11 INFO - Running pre-action listener: _resource_record_pre_action 15:51:11 INFO - Running main action method: install 15:51:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:12 INFO - Reading from file tmpfile_stdout 15:51:12 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:12 INFO - Reading from file tmpfile_stdout 15:51:12 INFO - Output received: 15:51:12 INFO - Usage: mozinstall [options] installer 15:51:12 INFO - Options: 15:51:12 INFO - -h, --help show this help message and exit 15:51:12 INFO - -d DEST, --destination=DEST 15:51:12 INFO - Directory to install application into. [default: 15:51:12 INFO - "/builds/slave/test"] 15:51:12 INFO - --app=APP Application being installed. [default: firefox] 15:51:12 INFO - mkdir: /builds/slave/test/build/application 15:51:12 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:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:51:29 INFO - Reading from file tmpfile_stdout 15:51:29 INFO - Output received: 15:51:29 INFO - /builds/slave/test/build/application/firefox/firefox 15:51:29 INFO - Running post-action listener: _resource_record_post_action 15:51:29 INFO - [mozharness: 2017-09-17 22:51:29.823050Z] Finished install step (success) 15:51:29 INFO - [mozharness: 2017-09-17 22:51:29.823200Z] Running setup-mitmproxy step. 15:51:29 INFO - Running pre-action listener: _resource_record_pre_action 15:51:29 INFO - Running main action method: setup_mitmproxy 15:51:29 INFO - Skipping: mitmproxy is not required 15:51:29 INFO - Running post-action listener: _resource_record_post_action 15:51:29 INFO - [mozharness: 2017-09-17 22:51:29.823940Z] Finished setup-mitmproxy step (success) 15:51:29 INFO - [mozharness: 2017-09-17 22:51:29.824159Z] Running run-tests step. 15:51:29 INFO - Running pre-action listener: _resource_record_pre_action 15:51:29 INFO - Running pre-action listener: _set_gcov_prefix 15:51:29 INFO - Running main action method: run_tests 15:51:29 WARNING - Try message not found. 15:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:51:29 INFO - Python 2.7.3 15:51:29 INFO - Return code: 0 15:51:29 INFO - grabbing minidump binary from tooltool 15:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:29 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 0xdde090>, '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 0xdded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd8f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:51:29 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:51:29 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:51:29 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:51:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:51:29 INFO - Return code: 0 15:51:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:51:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:51:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:51:29 INFO - ENV: RUST_BACKTRACE is now full 15:51:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:51:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --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:51:29 INFO - Using env: {'DISPLAY': ':0', 15:51:29 INFO - 'HOME': '/home/cltbld', 15:51:29 INFO - 'LANG': 'en_US.UTF-8', 15:51:29 INFO - 'LANGUAGE': 'en_US:en', 15:51:29 INFO - 'LOGNAME': 'cltbld', 15:51:29 INFO - 'MAIL': '/var/mail/cltbld', 15:51:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:29 INFO - 'MOZ_NO_REMOTE': '1', 15:51:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:29 INFO - 'NO_EM_RESTART': '1', 15:51:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:29 INFO - 'PWD': '/builds/slave/test', 15:51:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:29 INFO - 'RUST_BACKTRACE': 'full', 15:51:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:51:29 INFO - 'SHELL': '/bin/bash', 15:51:29 INFO - 'SHLVL': '1', 15:51:29 INFO - 'TERM': 'linux', 15:51:29 INFO - 'TMOUT': '86400', 15:51:29 INFO - 'USER': 'cltbld', 15:51:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', 15:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:29 INFO - '_': '/tools/buildbot/bin/python'} 15:51:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:51:30 INFO - mozversion application_buildid: 20170917213019 15:51:30 INFO - mozversion application_changeset: dd87b8587fc1d63e57ebdadcbabba89c6d172969 15:51:30 INFO - mozversion application_display_name: Nightly 15:51:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:51:30 INFO - mozversion application_name: Firefox 15:51:30 INFO - mozversion application_remotingname: firefox 15:51:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:51:30 INFO - mozversion application_vendor: Mozilla 15:51:30 INFO - mozversion application_version: 57.0a1 15:51:30 INFO - mozversion platform_buildid: 20170917213019 15:51:30 INFO - mozversion platform_changeset: dd87b8587fc1d63e57ebdadcbabba89c6d172969 15:51:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:51:30 INFO - mozversion platform_version: 57.0a1 15:51:30 INFO - using testdate: 1505688690 15:51:30 INFO - actual date: 1505688690 15:51:30 INFO - starting webserver on 'localhost:42285' 15:51:30 INFO - SUITE-START | Running 2 tests 15:51:30 INFO - TEST-START | dromaeo_css 15:51:30 INFO - Initialising browser for dromaeo_css test... 15:51:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42285/getInfo.html -profile /tmp/tmpQeB83T/profile 15:51:30 INFO - TEST-INFO | started process 12311 (/builds/slave/test/build/application/firefox/firefox http://localhost:42285/getInfo.html) 15:51:36 INFO - TEST-INFO | 12311: exit 0 15:51:36 INFO - Browser initialized. 15:51:36 INFO - Running cycle 1/1 for dromaeo_css test... 15:51:36 INFO - Using env: {'DISPLAY': ':0', 15:51:36 INFO - 'HOME': '/home/cltbld', 15:51:36 INFO - 'JSGC_DISABLE_POISONING': '1', 15:51:36 INFO - 'LANG': 'en_US.UTF-8', 15:51:36 INFO - 'LANGUAGE': 'en_US:en', 15:51:36 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:51:36 INFO - 'LOGNAME': 'cltbld', 15:51:36 INFO - 'MAIL': '/var/mail/cltbld', 15:51:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:51:36 INFO - 'MOZ_CRASHREPORTER': '1', 15:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:36 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:51:36 INFO - 'MOZ_NO_REMOTE': '1', 15:51:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:36 INFO - 'NO_EM_RESTART': '1', 15:51:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:36 INFO - 'PWD': '/builds/slave/test', 15:51:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:36 INFO - 'RUST_BACKTRACE': 'full', 15:51:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:51:36 INFO - 'SHELL': '/bin/bash', 15:51:36 INFO - 'SHLVL': '1', 15:51:36 INFO - 'STYLO_FORCE_DISABLED': '1', 15:51:36 INFO - 'TERM': 'linux', 15:51:36 INFO - 'TMOUT': '86400', 15:51:36 INFO - 'USER': 'cltbld', 15:51:36 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', 15:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:36 INFO - '_': '/tools/buildbot/bin/python'} 15:51:36 INFO - TEST-INFO | started process 12551 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQeB83T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:37 INFO - PID 12551 | 15:51:37 INFO - PID 12551 | (/builds/slave/test/build/application/firefox/firefox:12601): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:51:37 INFO - PID 12551 | 15:51:47 INFO - PID 12551 | RSS: Main: 147918848 15:51:47 INFO - PID 12551 | 15:54:44 INFO - PID 12551 | Cycle 1(1): loaded http://localhost:42285/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42285/tests/dromaeo/cssquery-ext.html) 15:54:45 INFO - PID 12551 | RSS: Main: 148463616 15:54:45 INFO - PID 12551 | 15:57:47 INFO - PID 12551 | Cycle 1(1): loaded http://localhost:42285/tests/dromaeo/cssquery-ext.html (next: http://localhost:42285/tests/dromaeo/cssquery-jquery.html) 15:57:47 INFO - PID 12551 | RSS: Main: 148566016 15:57:47 INFO - PID 12551 | 16:00:49 INFO - PID 12551 | Cycle 1(1): loaded http://localhost:42285/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42285/tests/dromaeo/cssquery-mootools.html) 16:00:50 INFO - PID 12551 | RSS: Main: 150462464 16:00:50 INFO - PID 12551 | 16:03:51 INFO - PID 12551 | Cycle 1(1): loaded http://localhost:42285/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42285/tests/dromaeo/cssquery-prototype.html) 16:03:52 INFO - PID 12551 | RSS: Main: 149135360 16:03:52 INFO - PID 12551 | 16:06:55 INFO - PID 12551 | Cycle 1(1): loaded http://localhost:42285/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42285/tests/dromaeo/cssquery-yui.html) 16:06:55 INFO - PID 12551 | RSS: Main: 150396928 16:06:55 INFO - PID 12551 | 16:09:57 INFO - PID 12551 | Cycle 1(1): loaded http://localhost:42285/tests/dromaeo/cssquery-yui.html (next: http://localhost:42285/tests/dromaeo/cssquery-dojo.html) 16:09:57 INFO - PID 12551 | RSS: Main: 152616960 16:09:57 INFO - PID 12551 | 16:09:57 INFO - PID 12551 | __start_tp_report 16:09:57 INFO - PID 12551 | _x_x_mozilla_page_load 16:09:57 INFO - PID 12551 | _x_x_mozilla_page_load_details 16:09:57 INFO - PID 12551 | |i|pagename|runs| 16:09:57 INFO - PID 12551 | |0;dojo.html;3861.4593956846047;3864.091938394478;3894.318494263505;3895.201483695841;3916.9608303916953;6058.939410605893;6187.4740647045;6228.065790131477;6279.591826531278;6289.905651415233;6219.502439804816;6251.3123556408755;6303.936960630393;6391.776287829927;6414.871702565946;5597.132444471094;5720.370759216483;5730.942690573103;5744.655320680772;5747.109198074284;206.5670418398363;5365.919511207335;5621;5659;5706.7431965561445;5592.412796656354;5681;5718.342390625069;5727.914081288784;5755.0504166812425;5672.149177623348;5682.119271512922;5743.368229494752;5749.310082790092;5751.798687045975;5603.775848966036;5634.859128521779;5705.286839145107;5713.200151978726;5718.085106382959;6094.299155597075;6210.875782484371;6260.561760676755;6323.241211054657;6367.395097465734;6617.536772425932;6690.531662783607;6691.498137639648;6693.1298931138645;6699.765508207238;6804.829879253009;6890.655467226668;6899.517033807636;6900.171979362459;6907.585544867324;6246.906296405557;6337.017762246859;6338.619682819046;6401.1678481797535;6408.166938297992;6967.989641502055;6987.091678081817;6990.196127445409;6991.93008069923;7003.509754317149;6656.400923916871;6680.03139544773;6684.532082754258;6711.530192886451;6720.630365329954;6772.966135169293;6823.658817059128;6839.247682754893;6845.863082738318;6861.931380686229;6675.866482670416;6734.966325168441;6737.764178253738;6758.357955994173;6764.120664313607;6796.8300792479595;6806;6886.552374095668;6896.862062758717;6897.724091036403;4925.335079764258;4950;4994.500549944976;5014.648974571818;5015.072211640858;4429.047754732748;4447.221736196153;4506.1663592235545;4549.704269222556;4598.793054312497;6329;6375.808725738235;6425.74297028123;6428.485721142298;6431.035344698239;6837.589744615339;6838.863222735617;6920.8961865572055;6924.272951340137;6942.826429339206;6278.591891527036;6312.400321969406;6355.3009168991375;6357.427831495188;6363.681815909186;5472.069748142825;5522.088855338904;5538.0585300499015;5538.363088244903;5546.278983732089;6937.098177237028;6938.791836244921;7022.262662420474;7030.437564994788;7049.541779784297;6647.534672573067;6678.499112566674;6777.762778302933;6819.829504262334;6836.17965844082;7115.146182457931;7183.317584829433;7212.593544259029;7215.819604509929;7218.566885986857;6738.09035780183;6750.6624668767345;6811.080504132077;6833.521653484208;6835.487338449537;6690.096836926952;6791.7283308669075;6794.082798822095;6808.183018037867;6901.240863505111;6438.259600146043;6479.611223326616;6519.7392104315295;6524.086627872007;6552.63960482178;6496.70764815575;6527.804165875032;6604.207495100619;6616.7022483987375;6702.329767023259;6455.2576453708425;6519.8044058678315;6587.4071333580205;6590.7693230736695;6594.934050659624;6499.415052645285;6542.509311801538;6594.769183078569;6612.867742645024;6614.834629134118;6267.153934219004;6472.385123413268;6477.093206950936;6559.704813283509;6569.441597464269 16:09:57 INFO - PID 12551 | |1;ext.html;952.6856137474634;972.1056627902329;974.9610015599376;983.237990557318;983.7094917500962;46073.76963115184;46327.536724632744;46518;46679;46850.76574617131;42771.57228427715;42953;43119.3532097018;43214.7839260804;43303;7438.776836694908;7515.774526764206;7541.321281084702;7571.962140189319;7576.924230757677;7412.851742965137;7485.0643669541305;7496.13794413644;7500.212477689845;7503.624818759067;7499.55002699837;8137.145599712034;8351.58242087893;8369.790755231106;8370.58147092646;8238.794030149264;8292.626831792524;8293.33653307734;8293.95853020737;8298.087210406851;7943.404244681672;8117.107118216992;8121.7563473095315;8126.268635822746;8147.918520814776;40946;41061;41113;41293.380599291035;41337.79331103355;3802.3535998880257;3862.1310205203886;3863.9227215455535;3864.9227015459815;3865.613438656112;33734;33794;33998;34014.48978265328;34059;5396.43337449566;5401.405845357008;5410.188471729272;5435.0488664483555;5460.699661518614;220352;222188;224001;224966;225569;48232.7588362056;53651.92696146055;53896.73051634717;54076;54140.72929635327;57387;57631;57719.42280577224;57864;57945.13082303769;15029.323680434407;15223.162726050174;15291.082535047934;15351.53945381618;15363.385464581515;12286.877131228573;12368.81446778299;12418.254904705565;12429.689257768447;12442.440090195963;15132.167730774692;15179.772303415457;15181.240937953278;15219.771703424236;15367.462138825087;5793.2179155814265;5813.447722466359;5944.346121926585;6016.278046634432;6052.636841789506;1064.5422468338688;1094.392612100292;1097.9780404392027;1104.4201794058024;1119.0879433261866;25690.35774105662;25719.871400643253;25833.354166145997;25977.610335844976;25984.35039124037;1189.5776999165346;1194.832723418722;1195.8026925557185;1199.598134624893;1209.6189700244395;13444.932775336061;13486;13488.5279015234;13693.589192324247;13933;303503;303627;303783;304914;306458;60673;60788;60851.39148608546;60877.69561152166;61039.69480152571;1467.5744034230167;1534.96162595936;1536.1090567471063;1539.3996341426853;1542.5603702944607;25544.616830747924;25567.488650227264;25612.61581076248;25654;25721.871390642926;42678.78660606677;42786.35820462758;42799.35800962926;42931.35602965896;42932;240201;242426;242916;242942;243893;33102.834485827414;33769;36364.454533181495;37308.06729831776;37621.247575048896;49415.752921235166;49486.75256623694;49746.25380619221;49807.501924980286;50262.7486862578;36126.277474450886;36439.27121457503;36466.453003205505;36704.63295367012;36736.448953266256;35401.82299088488;35796.105097372776;35880.64119358877;36093.45859812157;36476.088097797765;41417;41538.37692434555;41882.37176442295;41885;41967;33746.66253337435;33945.66054339425;34010.65989340174;34189.82905085458;34865.30269394648;24712.629310560715;25519.362015949006;25766.613500797877;25912.833922473157;25921.22236332913 16:09:57 INFO - PID 12551 | |2;jquery.html;599.8812215218616;600.7596961215513;601.5548494114357;613.6195558753572;613.8158552434269;23310.76689233107;23906.88046559767;23952.999999999978;23957;23972.041118355246;24093.63859542104;25896.35259118523;26005.219843404728;26104.347391315227;26205.34486637835;6532.836679083025;6671.49963752718;6691.899621505681;6707.463402927754;6715.328467153295;6425.45383642391;6483.189601299838;6507.707153178095;6536.117624120754;6723.428508576777;6701.061851340816;6710.664466776666;6723.697433615474;6730.326967303255;6732;6298.4331410172845;6511.641859697715;6544.67276636171;6704.128463299764;6724.495662825283;6084.421979911901;6092.847678808065;6100.359462256488;6104.267487901436;6106.816795496142;29313.56029659557;29496.852515737497;29670;29677.554836677467;29697.554536681968;2214.202886960693;2217.1907253852387;2234.910603575855;2235.8434909556336;2245.820334373246;19613.50966225856;20914.163433462643;20918.686219706564;21033.894830525904;21039.8948005259;2467;2472.27068014936;2500.349909023667;2600.180943002967;2621.3446638340415;130614.3469282657;136153;143213;151016.48983510135;152295;15553.455629053155;15991.840081599035;16016.519504414886;16187.19064046793;16212;24988.625170622454;25013.749862501143;25048.4990300193;25063;25077;9969.102780749767;10018.849717254247;10058.396496210251;10162.593496260215;10209.438480883622;8937.419067760575;8963.865542016874;9042.728718138467;9134.543272836332;9154.86267705985;9472.242220622335;9510.809783804423;9521.619135234512;9549.28380371461;9613.855792163124;2842.7441530261963;2865.4698880707138;2877.093715479617;2917.591537184796;2972.658144313388;1036.6838114375037;1037.6990672704983;1046.3251202974038;1048.046277887119;1065.3235195650818;20485.87327696961;20616;20943.581128377347;21076.05157767904;21090.367288981353;1099.455769394155;1103.757173421846;1104.3318792130806;1116.7989761842946;1121.7027487715761;11328;11346.546138154381;11460.828087578693;11555.942220288845;11584.362860042778;650363;658592;659257;660663;664747;123608;124959.3752031234;125816;126244;126451;1031.8916513765946;1156.5547264303304;1159.9536018559163;1221.773971815217;1266.2149467330498;21425.611892912275;21625;21956.121755129618;22023.77976220217;22142.778572214072;57968;58550;59219.407805921386;60452;61334;77951.61024194842;78417;79126;79156.20843791719;79170.60414697889;15069.54791356261;15187.316570754563;15271.541853744406;15281.312340944907;15294.158821264937;23683.289501314986;23765.16821911225;23990.640140397558;23993.16023939154;24340.148094816595;17622.91188544049;17942.910285448488;18092.90953545224;18092.909535452764;18110.63778724392;16948.745768813726;17044.318227271266;17767.73348399749;17938.820611793715;18229.361972330906;18062;18677.90661046686;19449.12478938423;19727.210911563376;19850.801491984894;14875.776863347275;14942.327595258457;14999.400023998918;15037.849621503645;15038.849611503745;18012.279508820026;18098.638027239645;18119.45641630753;18252.17865196043;18289.17698703535 16:09:57 INFO - PID 12551 | |3;mootools.html;1408.9225092619904;1527.33560901008;1533.1107957384718;1540.7303721848677;1549.2253873063469;16411.83588164118;17147.82852171478;17249.051302178374;17285;17303.221355039022;16781.24484398202;16895.83104168958;16939.83060169398;16949.898256613313;16961;2680.932976675579;2744.7529722324985;2791.1347482280557;2794.0779542750843;2795.580662900561;2750.7386798254133;2751.257160566646;2763.9170824875287;2771.598118272849;2773.251222170013;2679.048937627134;2758.724127587245;2876.0509032019486;2877.266297094238;2877.453283876057;2612.8171028028046;2796.5385711357603;2806.1441260415563;2822.8588570571387;2823.71762823718;2750.051232324845;2768.6262354582277;2774;2777.028040185939;2777.2501424615443;16805.411810586695;16992.660146796996;17096.658066838594;17100.657986840193;17101;8211.425200235986;8466.280366168883;8468.280196183332;8472.237498625153;8479.872801907977;5100.770465329069;5265.473452654742;5313.973430132824;5337.039332920072;5406.297181366397;1997.500624843789;2025.1494372363643;2039.6328660841043;2114.3234165067183;2125.914963401462;29584.26039349012;29960;29975;30125.69874301251;30661.23346916345;6467.223933127961;6594.769183078569;6751.864962700718;6824.863502729918;6844.828879277959;19185.040747962546;19205.13576889043;19378.70931936022;19912.203511859654;20099.39701808948;8157.265846073882;8340.499570025819;8377.70678026266;8381.245687888118;8388.916110838936;7567.886481702779;7572.318491335806;7684.385249180053;7749.186335434811;7776.883346749803;5247.239150323182;5386.649867758583;5501.642393244426;5518.33779946409;5553.444655534414;1528.5261568913672;1534.2098819108169;1537.2160198298725;1544.9073055616475;1551.3019141386196;900.617237673986;913.0777914306598;923.2752289452748;929.3494553812359;933.6265493802533;7676.347510461674;7709.113451953097;7771;7773.727919522789;7799.49303295284;749.0973377080604;749.2619769527012;756.3722110648149;773.6866569039548;774.0981756253901;4641.071785642885;5019.796591890576;5123.436421993578;5251.76367063483;5305.708186049727;23061;24953.750462495507;25465;25504.8724756375;25533.106341277966;23306.184283549996;24585.385365366008;24799.752002479745;24900.128495502933;24908.875455622605;12426.689332766753;12555.811662825065;12650.304233267074;12770.042246831339;13005;8118.675252989814;8730.869036964323;8735.213830755263;8743.125687431206;8746.606402712021;20488.89755551213;20870.478238044172;21430.571388572454;21625.13499460004;21747.347579572637;21294.18400914485;21680.89159554192;21909.233176838734;21919;22369.44076398103;12220.205686630341;12222.266663999833;12229.082818788449;12337.444814983168;12340.136190466581;15353.232338383259;15546.844531554992;15677.921610391875;15756.290966906288;15761.68476630438;12610.684732881384;12765.680857978625;12869.09916305887;13006.349682515647;13141.605751827461;12431.44058517387;12431.75136497247;12490.188137771016;12779.744405112031;12852.807207891701;10522.736931576772;10595.788084238426;10743.194260430655;10753.301035432673;10755.516001780095;7093.467989900675;7271.818204544928;7288.489805713762;7301.196868344372;7357.889631655637;7175.964120179366;7186.712531498891;7195.964020179866;7240.52936559143;7285.890711639224 16:09:57 INFO - PID 12551 | |4;prototype.html;534.3214118070051;560.5095541401274;563.0709329606152;565.2453973944783;572.7165053298617;6329.208848893888;6353.968230158848;6405.42351188393;6413.230412350513;6436.324185960477;6233.812985610428;6251.749650069982;6279.968600157004;6301.936980630192;6317.684115794214;5093;5126.615503837208;5154.819581314655;5191.688498690071;5199.714015729124;4923.82766603169;5010.348654674887;5127.717975511346;5152.92270615941;5167.173252279636;5016.949830501685;5018.272350509174;5021.723805190713;5038.118329292378;5057.747112644372;4989.3535133405885;4998.001598721009;5006.524380183877;5028.49715028496;5051.924221136685;4475.977620111878;4535.977320113411;4540.932880773015;4552.15785079758;4558.133954548625;6102.26772787264;6180.165677633507;6200.844978875519;6212.409821066992;6220.160278362454;5803.5357171426185;5836.941630583725;5867.970660146715;5904.852378690567;5925.259342582177;6689.163854518185;6691.19705635322;6709.161354830646;6720.966395167993;6772.796816095525;5098.490150984909;5103.974480127613;5111.4121875984365;5116.439485956782;5123.974380128113;6803.829904252384;6878.484113691493;6914.412274956584;6960.30396960305;7053.400460960825;5220.92168617471;5221.712805795718;5223.2948551945765;5230.7384630769075;5232.895342093137;5309.230161626542;5311.628186026941;5319.9202011969855;5321.36143662763;5327.094393953037;5877.794277200277;5931.673757943355;5932.2584676915385;5933.732982015819;5947.583669143119;6669.266380698119;6709.530332876652;6782.796516104525;6826.146731658543;6846.931530684729;1801.675698374279;1805.2327760701648;1814.564504518906;1818.8453981411465;1824.5256233379152;1226.8466441694789;1281.7756892543769;1289.2264641215195;1293.1723696834033;1300.7723648361498;6156.569040167235;6161.168242287324;6239.251289845248;6295.213098362705;6308.432241098323;6715.56348837324;6780.830479238059;6827.556208846409;6842.965785171043;6882.242953275136;6137.662428566472;6141.938580614226;6218.347073557302;6219;6237.96881015592;3519.753617246768;3548.27260411615;3572.3391172633146;3579.6599323064265;3621.3662609043313;7055.823604409931;7056.506044576933;7094.574325540484;7116.573005619679;7167.713291468387;6932.826679333057;7003.894941575881;7017.350922533201;7066.858662826715;7076.32774886385;6985.89521157183;6988.860222795515;6990.077728624668;7013.544119632207;7058;6715.93284067153;6737.461003119641;6855.5201135922;6865.347791959756;6883.827904302432;6726.428253598499;6772.424343930821;6829.6243706596615;6855.211650660238;6862.897056544056;7010.929890701028;7068.540544864567;7073.2573079827935;7115.430765538848;7127.75052873147;5129.512696293846;5129.692218466904;5163.793448262028;5165.9483405165465;5209.53114219722;6590.769323073861;6815.7731608308995;6851.554648947803;6868.725250989904;6908.896366554405;6345.650989195638;6662.5348621010535;6671.733130674718;6673.366030227121;6712.597244165366;6600.174978127734;6618.768343107968;6638.900416493853;6680.265170831108;6705.396514313735;6480.935190648033;6519.500514881699;6519.902201466887;6547.690461907733;6630.7679231226675;6663.200415950117;6748;6760.628165450948;6761.966190169018;6799.048133261446;6405.231372235362;6492.74029038852;6514.6416947068365;6558.311377305315;6564.704588293634 16:09:57 INFO - PID 12551 | |5;yui.html;953.6241704366543;981.430770153311;983.6852207293668;990.1732053735135;1019.1846522781775;18541.53646158847;18776.967266800322;18876.811231887677;18933.715994260096;18938.337158199432;19222.327218547354;19596;19921;20034.298799541983;20224.59550808983;1078.4769386847372;1107.9612213572527;1109.938953357565;1110;1110.639042311252;1075.1237741240902;1077.4397313397028;1077.9784404311908;1078.4068762180768;1078.9082927951133;1092.8415379769929;1140.3329052504296;1150.0167356909847;1150.7755987582425;1151.3264740127036;1138.3966497756203;1139.789139009286;1144.1761931409371;1145.5417832866879;1146.01442759227;832.9583520823995;835.3818174550788;835.5738573327586;836.1554829622125;836.3016880904452;20271.79728202714;20696.586068278702;20887.26894558683;21005.68491472629;21009.159633614636;22356.77643223563;22746.77253227463;23253.53492930132;23255.186068487692;23269.53460930772;18583.44249672512;18838.15228314729;18888.33890813815;18946.336878209197;18961;3976.204759048173;4018.8995275118355;4021.155557332934;4046.5751096134777;4064;153530;161704.99999999884;165124;165248;167797;15934.760978585331;16402.589935251715;16404.6719065618;16418.507444776675;16463.588410289838;27821.304467388476;29119.708802912122;30678;30769.692303077132;30772.230694232374;9836.3606365586;9858.507074646239;9915.752106197402;9917.057879501435;9933.155681766986;4037.2934736421007;4114.238865809834;4145.937810932838;4150.439690641725;4190.245755763992;5852.6195797273895;5961.195238642815;5978.252718410199;6067.393260673985;6076.21009268801;1149.2472430557998;1168.9357085360216;1180.6458062581191;1190.696372425026;1200.0879331707965;746.3022074360382;753.5290443472829;766.9118051424047;781.1563511407666;781.1680560203365;12070.336131512675;12694.873051269555;13090.672733181556;13140.408681609159;13200.933995330153;734.3024127079296;755.8752805786984;767.7121079595152;770.4491288728474;777.5917643237233;5662.943370566324;5711.171880077449;5750.30996280449;5793.536517078708;5839.649621022752;151219;152086;152121;155902;156494.2175289139;131525.3423732875;133069.33465332806;133402.33298833444;135790;137642.31178844243;111277.44361278304;115019.42490287662;115505;116248.8375116238;119323.99999999827;10895.346279223271;10906.727331816768;11134.721631958942;11169.329840209613;11260.155488338243;52592.7370363161;53249.20126198188;53982.730086349315;54308.45691543192;54724.726376367864;67018;67380.3261967374;68920;69633;70320;15433;15774.842251577797;15890.60273493172;15927.60180995438;15954.282057307217;15141.772873406688;15286.159261240738;15406.38374465009;15440.227988600749;15511.37954481808;16992.405265815636;17003.14984250807;17035.31858725687;17296.91351543234;17368.044757538457;15342.693146137239;15479;15497.30262138229;15532.767008495108;15537.06777593348;15888.841111589198;15896;15912.602184945468;16108.919455402647;16110.597235068748;11704.70738231551;11850.76298474043;11949.820752688891;12028.458719357825;12043.976262017826;12248.693782655504;12379.75240495203;12394.876051239373;12488.625341239778;12750 16:09:57 INFO - PID 12551 | __end_tp_report 16:09:57 INFO - PID 12551 | __start_cc_report 16:09:57 INFO - PID 12551 | _x_x_mozilla_cycle_collect,277 16:09:57 INFO - PID 12551 | __end_cc_report 16:09:57 INFO - PID 12551 | __startTimestamp1505689797454__endTimestamp 16:09:57 INFO - PID 12551 | 16:09:57 INFO - PID 12551 | ------- Summary: start ------- 16:09:57 INFO - PID 12551 | Number of tests: 6 16:09:57 INFO - PID 12551 | 16:09:57 INFO - PID 12551 | [#0] dojo.html Cycles:165 Average:6237.02 Median:6499.42 stddev:875.82 (13.5%) stddev-sans-first:858.45 16:09:57 INFO - PID 12551 | Values: 3861.5 3864.1 3894.3 3895.2 3917.0 6058.9 6187.5 6228.1 6279.6 6289.9 6219.5 6251.3 6303.9 6391.8 6414.9 5597.1 5720.4 5730.9 5744.7 5747.1 206.6 5365.9 5621.0 5659.0 5706.7 5592.4 5681.0 5718.3 5727.9 5755.1 5672.1 5682.1 5743.4 5749.3 5751.8 5603.8 5634.9 5705.3 5713.2 5718.1 6094.3 6210.9 6260.6 6323.2 6367.4 6617.5 6690.5 6691.5 6693.1 6699.8 6804.8 6890.7 6899.5 6900.2 6907.6 6246.9 6337.0 6338.6 6401.2 6408.2 6968.0 6987.1 6990.2 6991.9 7003.5 6656.4 6680.0 6684.5 6711.5 6720.6 6773.0 6823.7 6839.2 6845.9 6861.9 6675.9 6735.0 6737.8 6758.4 6764.1 6796.8 6806.0 6886.6 6896.9 6897.7 4925.3 4950.0 4994.5 5014.6 5015.1 4429.0 4447.2 4506.2 4549.7 4598.8 6329.0 6375.8 6425.7 6428.5 6431.0 6837.6 6838.9 6920.9 6924.3 6942.8 6278.6 6312.4 6355.3 6357.4 6363.7 5472.1 5522.1 5538.1 5538.4 5546.3 6937.1 6938.8 7022.3 7030.4 7049.5 6647.5 6678.5 6777.8 6819.8 6836.2 7115.1 7183.3 7212.6 7215.8 7218.6 6738.1 6750.7 6811.1 6833.5 6835.5 6690.1 6791.7 6794.1 6808.2 6901.2 6438.3 6479.6 6519.7 6524.1 6552.6 6496.7 6527.8 6604.2 6616.7 6702.3 6455.3 6519.8 6587.4 6590.8 6594.9 6499.4 6542.5 6594.8 6612.9 6614.8 6267.2 6472.4 6477.1 6559.7 6569.4 16:09:57 INFO - PID 12551 | 16:09:57 INFO - PID 12551 | [#1] ext.html Cycles:180 Average:43773.95 Median:3832.24 stddev:67560.54 (1763.0%) stddev-sans-first:67673.55 16:09:57 INFO - PID 12551 | Values: 952.7 972.1 975.0 983.2 983.7 46073.8 46327.5 46518.0 46679.0 46850.8 42771.6 42953.0 43119.4 43214.8 43303.0 7438.8 7515.8 7541.3 7572.0 7576.9 7412.9 7485.1 7496.1 7500.2 7503.6 7499.6 8137.1 8351.6 8369.8 8370.6 8238.8 8292.6 8293.3 8294.0 8298.1 7943.4 8117.1 8121.8 8126.3 8147.9 40946.0 41061.0 41113.0 41293.4 41337.8 3802.4 3862.1 3863.9 3864.9 3865.6 33734.0 33794.0 33998.0 34014.5 34059.0 5396.4 5401.4 5410.2 5435.0 5460.7 220352.0 222188.0 224001.0 224966.0 225569.0 48232.8 53651.9 53896.7 54076.0 54140.7 57387.0 57631.0 57719.4 57864.0 57945.1 15029.3 15223.2 15291.1 15351.5 15363.4 12286.9 12368.8 12418.3 12429.7 12442.4 15132.2 15179.8 15181.2 15219.8 15367.5 5793.2 5813.4 5944.3 6016.3 6052.6 1064.5 1094.4 1098.0 1104.4 1119.1 25690.4 25719.9 25833.4 25977.6 25984.4 1189.6 1194.8 1195.8 1199.6 1209.6 13444.9 13486.0 13488.5 13693.6 13933.0 303503.0 303627.0 303783.0 304914.0 306458.0 60673.0 60788.0 60851.4 60877.7 61039.7 1467.6 1535.0 1536.1 1539.4 1542.6 25544.6 25567.5 25612.6 25654.0 25721.9 42678.8 42786.4 42799.4 42931.4 42932.0 240201.0 242426.0 242916.0 242942.0 243893.0 33102.8 33769.0 36364.5 37308.1 37621.2 49415.8 49486.8 49746.3 49807.5 50262.7 36126.3 36439.3 36466.5 36704.6 36736.4 35401.8 35796.1 35880.6 36093.5 36476.1 41417.0 41538.4 41882.4 41885.0 41967.0 33746.7 33945.7 34010.7 34189.8 34865.3 24712.6 25519.4 25766.6 25912.8 25921.2 16:09:57 INFO - PID 12551 | 16:09:57 INFO - PID 12551 | [#2] jquery.html Cycles:180 Average:40550.81 Median:23724.23 stddev:109335.99 (460.9%) stddev-sans-first:109601.56 16:09:57 INFO - PID 12551 | Values: 599.9 600.8 601.6 613.6 613.8 23310.8 23906.9 23953.0 23957.0 23972.0 24093.6 25896.4 26005.2 26104.3 26205.3 6532.8 6671.5 6691.9 6707.5 6715.3 6425.5 6483.2 6507.7 6536.1 6723.4 6701.1 6710.7 6723.7 6730.3 6732.0 6298.4 6511.6 6544.7 6704.1 6724.5 6084.4 6092.8 6100.4 6104.3 6106.8 29313.6 29496.9 29670.0 29677.6 29697.6 2214.2 2217.2 2234.9 2235.8 2245.8 19613.5 20914.2 20918.7 21033.9 21039.9 2467.0 2472.3 2500.3 2600.2 2621.3 130614.3 136153.0 143213.0 151016.5 152295.0 15553.5 15991.8 16016.5 16187.2 16212.0 24988.6 25013.7 25048.5 25063.0 25077.0 9969.1 10018.8 10058.4 10162.6 10209.4 8937.4 8963.9 9042.7 9134.5 9154.9 9472.2 9510.8 9521.6 9549.3 9613.9 2842.7 2865.5 2877.1 2917.6 2972.7 1036.7 1037.7 1046.3 1048.0 1065.3 20485.9 20616.0 20943.6 21076.1 21090.4 1099.5 1103.8 1104.3 1116.8 1121.7 11328.0 11346.5 11460.8 11555.9 11584.4 650363.0 658592.0 659257.0 660663.0 664747.0 123608.0 124959.4 125816.0 126244.0 126451.0 1031.9 1156.6 1160.0 1221.8 1266.2 21425.6 21625.0 21956.1 22023.8 22142.8 57968.0 58550.0 59219.4 60452.0 61334.0 77951.6 78417.0 79126.0 79156.2 79170.6 15069.5 15187.3 15271.5 15281.3 15294.2 23683.3 23765.2 23990.6 23993.2 24340.1 17622.9 17942.9 18092.9 18092.9 18110.6 16948.7 17044.3 17767.7 17938.8 18229.4 18062.0 18677.9 19449.1 19727.2 19850.8 14875.8 14942.3 14999.4 15037.8 15038.8 18012.3 18098.6 18119.5 18252.2 18289.2 16:09:57 INFO - PID 12551 | 16:09:57 INFO - PID 12551 | [#3] mootools.html Cycles:180 Average:10228.73 Median:2751.00 stddev:7742.30 (281.4%) stddev-sans-first:7735.67 16:09:57 INFO - PID 12551 | Values: 1408.9 1527.3 1533.1 1540.7 1549.2 16411.8 17147.8 17249.1 17285.0 17303.2 16781.2 16895.8 16939.8 16949.9 16961.0 2680.9 2744.8 2791.1 2794.1 2795.6 2750.7 2751.3 2763.9 2771.6 2773.3 2679.0 2758.7 2876.1 2877.3 2877.5 2612.8 2796.5 2806.1 2822.9 2823.7 2750.1 2768.6 2774.0 2777.0 2777.3 16805.4 16992.7 17096.7 17100.7 17101.0 8211.4 8466.3 8468.3 8472.2 8479.9 5100.8 5265.5 5314.0 5337.0 5406.3 1997.5 2025.1 2039.6 2114.3 2125.9 29584.3 29960.0 29975.0 30125.7 30661.2 6467.2 6594.8 6751.9 6824.9 6844.8 19185.0 19205.1 19378.7 19912.2 20099.4 8157.3 8340.5 8377.7 8381.2 8388.9 7567.9 7572.3 7684.4 7749.2 7776.9 5247.2 5386.6 5501.6 5518.3 5553.4 1528.5 1534.2 1537.2 1544.9 1551.3 900.6 913.1 923.3 929.3 933.6 7676.3 7709.1 7771.0 7773.7 7799.5 749.1 749.3 756.4 773.7 774.1 4641.1 5019.8 5123.4 5251.8 5305.7 23061.0 24953.8 25465.0 25504.9 25533.1 23306.2 24585.4 24799.8 24900.1 24908.9 12426.7 12555.8 12650.3 12770.0 13005.0 8118.7 8730.9 8735.2 8743.1 8746.6 20488.9 20870.5 21430.6 21625.1 21747.3 21294.2 21680.9 21909.2 21919.0 22369.4 12220.2 12222.3 12229.1 12337.4 12340.1 15353.2 15546.8 15677.9 15756.3 15761.7 12610.7 12765.7 12869.1 13006.3 13141.6 12431.4 12431.8 12490.2 12779.7 12852.8 10522.7 10595.8 10743.2 10753.3 10755.5 7093.5 7271.8 7288.5 7301.2 7357.9 7176.0 7186.7 7196.0 7240.5 7285.9 16:09:57 INFO - PID 12551 | 16:09:57 INFO - PID 12551 | [#4] prototype.html Cycles:180 Average:5689.08 Median:6287.59 stddev:1598.08 (25.4%) stddev-sans-first:1555.03 16:09:57 INFO - PID 12551 | Values: 534.3 560.5 563.1 565.2 572.7 6329.2 6354.0 6405.4 6413.2 6436.3 6233.8 6251.7 6280.0 6301.9 6317.7 5093.0 5126.6 5154.8 5191.7 5199.7 4923.8 5010.3 5127.7 5152.9 5167.2 5016.9 5018.3 5021.7 5038.1 5057.7 4989.4 4998.0 5006.5 5028.5 5051.9 4476.0 4536.0 4540.9 4552.2 4558.1 6102.3 6180.2 6200.8 6212.4 6220.2 5803.5 5836.9 5868.0 5904.9 5925.3 6689.2 6691.2 6709.2 6721.0 6772.8 5098.5 5104.0 5111.4 5116.4 5124.0 6803.8 6878.5 6914.4 6960.3 7053.4 5220.9 5221.7 5223.3 5230.7 5232.9 5309.2 5311.6 5319.9 5321.4 5327.1 5877.8 5931.7 5932.3 5933.7 5947.6 6669.3 6709.5 6782.8 6826.1 6846.9 1801.7 1805.2 1814.6 1818.8 1824.5 1226.8 1281.8 1289.2 1293.2 1300.8 6156.6 6161.2 6239.3 6295.2 6308.4 6715.6 6780.8 6827.6 6843.0 6882.2 6137.7 6141.9 6218.3 6219.0 6238.0 3519.8 3548.3 3572.3 3579.7 3621.4 7055.8 7056.5 7094.6 7116.6 7167.7 6932.8 7003.9 7017.4 7066.9 7076.3 6985.9 6988.9 6990.1 7013.5 7058.0 6715.9 6737.5 6855.5 6865.3 6883.8 6726.4 6772.4 6829.6 6855.2 6862.9 7010.9 7068.5 7073.3 7115.4 7127.8 5129.5 5129.7 5163.8 5165.9 5209.5 6590.8 6815.8 6851.6 6868.7 6908.9 6345.7 6662.5 6671.7 6673.4 6712.6 6600.2 6618.8 6638.9 6680.3 6705.4 6480.9 6519.5 6519.9 6547.7 6630.8 6663.2 6748.0 6760.6 6762.0 6799.0 6405.2 6492.7 6514.6 6558.3 6564.7 16:09:57 INFO - PID 12551 | 16:09:57 INFO - PID 12551 | [#5] yui.html Cycles:180 Average:27850.02 Median:92394.70 stddev:43075.42 (46.6%) stddev-sans-first:43148.91 16:09:57 INFO - PID 12551 | Values: 953.6 981.4 983.7 990.2 1019.2 18541.5 18777.0 18876.8 18933.7 18938.3 19222.3 19596.0 19921.0 20034.3 20224.6 1078.5 1108.0 1109.9 1110.0 1110.6 1075.1 1077.4 1078.0 1078.4 1078.9 1092.8 1140.3 1150.0 1150.8 1151.3 1138.4 1139.8 1144.2 1145.5 1146.0 833.0 835.4 835.6 836.2 836.3 20271.8 20696.6 20887.3 21005.7 21009.2 22356.8 22746.8 23253.5 23255.2 23269.5 18583.4 18838.2 18888.3 18946.3 18961.0 3976.2 4018.9 4021.2 4046.6 4064.0 153530.0 161705.0 165124.0 165248.0 167797.0 15934.8 16402.6 16404.7 16418.5 16463.6 27821.3 29119.7 30678.0 30769.7 30772.2 9836.4 9858.5 9915.8 9917.1 9933.2 4037.3 4114.2 4145.9 4150.4 4190.2 5852.6 5961.2 5978.3 6067.4 6076.2 1149.2 1168.9 1180.6 1190.7 1200.1 746.3 753.5 766.9 781.2 781.2 12070.3 12694.9 13090.7 13140.4 13200.9 734.3 755.9 767.7 770.4 777.6 5662.9 5711.2 5750.3 5793.5 5839.6 151219.0 152086.0 152121.0 155902.0 156494.2 131525.3 133069.3 133402.3 135790.0 137642.3 111277.4 115019.4 115505.0 116248.8 119324.0 10895.3 10906.7 11134.7 11169.3 11260.2 52592.7 53249.2 53982.7 54308.5 54724.7 67018.0 67380.3 68920.0 69633.0 70320.0 15433.0 15774.8 15890.6 15927.6 15954.3 15141.8 15286.2 15406.4 15440.2 15511.4 16992.4 17003.1 17035.3 17296.9 17368.0 15342.7 15479.0 15497.3 15532.8 15537.1 15888.8 15896.0 15912.6 16108.9 16110.6 11704.7 11850.8 11949.8 12028.5 12044.0 12248.7 12379.8 12394.9 12488.6 12750.0 16:09:57 INFO - PID 12551 | -------- Summary: end -------- 16:09:57 INFO - PID 12551 | 16:09:58 INFO - TEST-INFO | 12551: exit 0 16:09:58 INFO - TEST-OK | dromaeo_css | took 1108050ms 16:09:58 INFO - TEST-START | kraken 16:09:58 INFO - Initialising browser for kraken test... 16:09:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42285/getInfo.html -profile /tmp/tmpz65IGY/profile 16:09:58 INFO - TEST-INFO | started process 12912 (/builds/slave/test/build/application/firefox/firefox http://localhost:42285/getInfo.html) 16:10:04 INFO - TEST-INFO | 12912: exit 0 16:10:04 INFO - Browser initialized. 16:10:04 INFO - Running cycle 1/1 for kraken test... 16:10:04 INFO - Using env: {'DISPLAY': ':0', 16:10:04 INFO - 'HOME': '/home/cltbld', 16:10:04 INFO - 'JSGC_DISABLE_POISONING': '1', 16:10:04 INFO - 'LANG': 'en_US.UTF-8', 16:10:04 INFO - 'LANGUAGE': 'en_US:en', 16:10:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:10:04 INFO - 'LOGNAME': 'cltbld', 16:10:04 INFO - 'MAIL': '/var/mail/cltbld', 16:10:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:10:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:10:04 INFO - 'MOZ_CRASHREPORTER': '1', 16:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:10:04 INFO - 'MOZ_NO_REMOTE': '1', 16:10:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:04 INFO - 'NO_EM_RESTART': '1', 16:10:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:04 INFO - 'PWD': '/builds/slave/test', 16:10:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:10:04 INFO - 'RUST_BACKTRACE': 'full', 16:10:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:10:04 INFO - 'SHELL': '/bin/bash', 16:10:04 INFO - 'SHLVL': '1', 16:10:04 INFO - 'STYLO_FORCE_DISABLED': '1', 16:10:04 INFO - 'TERM': 'linux', 16:10:04 INFO - 'TMOUT': '86400', 16:10:04 INFO - 'USER': 'cltbld', 16:10:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1505687473.552855-995033135', 16:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:04 INFO - '_': '/tools/buildbot/bin/python'} 16:10:04 INFO - TEST-INFO | started process 13150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz65IGY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:04 INFO - PID 13150 | 16:10:04 INFO - PID 13150 | (/builds/slave/test/build/application/firefox/firefox:13199): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:10:04 INFO - PID 13150 | 16:10:15 INFO - PID 13150 | RSS: Main: 147566592 16:10:15 INFO - PID 13150 | 16:10:17 INFO - PID 13150 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42285/tests/kraken/driver.html?testName=audio-beat-detection) 16:10:18 INFO - PID 13150 | RSS: Main: 152432640 16:10:18 INFO - PID 13150 | 16:10:21 INFO - PID 13150 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42285/tests/kraken/driver.html?testName=audio-dft) 16:10:21 INFO - PID 13150 | RSS: Main: 153251840 16:10:21 INFO - PID 13150 | 16:10:24 INFO - PID 13150 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42285/tests/kraken/driver.html?testName=audio-fft) 16:10:25 INFO - PID 13150 | RSS: Main: 149237760 16:10:25 INFO - PID 13150 | 16:10:27 INFO - PID 13150 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42285/tests/kraken/driver.html?testName=audio-oscillator) 16:10:27 INFO - PID 13150 | RSS: Main: 150429696 16:10:27 INFO - PID 13150 | 16:10:29 INFO - PID 13150 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42285/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:10:30 INFO - PID 13150 | RSS: Main: 150159360 16:10:30 INFO - PID 13150 | 16:10:33 INFO - PID 13150 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42285/tests/kraken/driver.html?testName=imaging-darkroom) 16:10:34 INFO - PID 13150 | RSS: Main: 150482944 16:10:34 INFO - PID 13150 | 16:10:37 INFO - PID 13150 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42285/tests/kraken/driver.html?testName=imaging-desaturate) 16:10:38 INFO - PID 13150 | RSS: Main: 151912448 16:10:38 INFO - PID 13150 | 16:10:41 INFO - PID 13150 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42285/tests/kraken/driver.html?testName=json-parse-financial) 16:10:41 INFO - PID 13150 | RSS: Main: 153354240 16:10:41 INFO - PID 13150 | 16:10:43 INFO - PID 13150 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42285/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:10:44 INFO - PID 13150 | RSS: Main: 153300992 16:10:44 INFO - PID 13150 | 16:10:45 INFO - PID 13150 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42285/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:10:46 INFO - PID 13150 | RSS: Main: 153243648 16:10:46 INFO - PID 13150 | 16:10:48 INFO - PID 13150 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42285/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:10:48 INFO - PID 13150 | RSS: Main: 150294528 16:10:48 INFO - PID 13150 | 16:10:51 INFO - PID 13150 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:10:51 INFO - PID 13150 | RSS: Main: 150605824 16:10:51 INFO - PID 13150 | 16:10:54 INFO - PID 13150 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:10:55 INFO - PID 13150 | RSS: Main: 151031808 16:10:55 INFO - PID 13150 | 16:10:56 INFO - PID 13150 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42285/tests/kraken/driver.html?testName=ai-astar) 16:10:57 INFO - PID 13150 | RSS: Main: 152391680 16:10:57 INFO - PID 13150 | 16:10:57 INFO - PID 13150 | __start_tp_report 16:10:57 INFO - PID 13150 | _x_x_mozilla_page_load 16:10:57 INFO - PID 13150 | _x_x_mozilla_page_load_details 16:10:57 INFO - PID 13150 | |i|pagename|runs| 16:10:57 INFO - PID 13150 | |0;ai-astar;106;106;105;105;106;112;98;106;106;106 16:10:57 INFO - PID 13150 | |1;audio-beat-detection;111;116;120;111;112;112;116;111;110;144 16:10:57 INFO - PID 13150 | |2;audio-dft;163;162;161;163;164;161;161;162;162;160 16:10:57 INFO - PID 13150 | |3;audio-fft;74;73;73;76;73;73;75;73;75;76 16:10:57 INFO - PID 13150 | |4;audio-oscillator;79;79;78;78;77;77;78;78;77;77 16:10:57 INFO - PID 13150 | |5;imaging-gaussian-blur;110;114;114;117;116;115;116;117;117;116 16:10:57 INFO - PID 13150 | |6;imaging-darkroom;149;149;150;150;149;150;150;152;151;151 16:10:57 INFO - PID 13150 | |7;imaging-desaturate;93;94;93;94;93;93;94;95;94;98 16:10:57 INFO - PID 13150 | |8;json-parse-financial;43;44;43;46;44;43;43;43;44;43 16:10:57 INFO - PID 13150 | |9;json-stringify-tinderbox;40;40;40;39;39;39;40;40;39;39 16:10:57 INFO - PID 13150 | |10;stanford-crypto-aes;74;70;72;70;71;71;72;73;72;75 16:10:57 INFO - PID 13150 | |11;stanford-crypto-ccm;110;106;111;111;105;105;105;110;106;108 16:10:57 INFO - PID 13150 | |12;stanford-crypto-pbkdf2;159;152;158;153;155;162;151;159;154;154 16:10:57 INFO - PID 13150 | |13;stanford-crypto-sha256-iterative;60;60;61;61;62;61;58;59;59;64 16:10:57 INFO - PID 13150 | __end_tp_report 16:10:57 INFO - PID 13150 | __start_cc_report 16:10:57 INFO - PID 13150 | _x_x_mozilla_cycle_collect,726 16:10:57 INFO - PID 13150 | __end_cc_report 16:10:57 INFO - PID 13150 | __startTimestamp1505689857153__endTimestamp 16:10:57 INFO - PID 13150 | 16:10:57 INFO - PID 13150 | ------- Summary: start ------- 16:10:57 INFO - PID 13150 | Number of tests: 14 16:10:57 INFO - PID 13150 | 16:10:57 INFO - PID 13150 | [#0] ai-astar Cycles:10 Average:105.60 Median:106.00 stddev:3.34 (3.2%) stddev-sans-first:3.54 16:10:57 INFO - PID 13150 | Values: 106.0 106.0 105.0 105.0 106.0 112.0 98.0 106.0 106.0 106.0 16:10:57 INFO - PID 13150 | 16:10:57 INFO - PID 13150 | [#1] audio-beat-detection Cycles:10 Average:116.30 Median:114.00 stddev:10.23 (9.0%) stddev-sans-first:10.67 16:10:57 INFO - PID 13150 | Values: 111.0 116.0 120.0 111.0 112.0 112.0 116.0 111.0 110.0 144.0 16:10:57 INFO - PID 13150 | 16:10:57 INFO - PID 13150 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.20 16:10:57 INFO - PID 13150 | Values: 163.0 162.0 161.0 163.0 164.0 161.0 161.0 162.0 162.0 160.0 16:10:57 INFO - PID 13150 | 16:10:57 INFO - PID 13150 | [#3] audio-fft Cycles:10 Average:74.10 Median:74.50 stddev:1.29 (1.7%) stddev-sans-first:1.36 16:10:57 INFO - PID 13150 | Values: 74.0 73.0 73.0 76.0 73.0 73.0 75.0 73.0 75.0 76.0 16:10:57 INFO - PID 13150 | 16:10:57 INFO - PID 13150 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:78.00 stddev:0.79 (1.0%) stddev-sans-first:0.71 16:10:57 INFO - PID 13150 | Values: 79.0 79.0 78.0 78.0 77.0 77.0 78.0 78.0 77.0 77.0 16:10:57 INFO - PID 13150 | 16:10:57 INFO - PID 13150 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:116.00 stddev:2.15 (1.9%) stddev-sans-first:1.20 16:10:57 INFO - PID 13150 | Values: 110.0 114.0 114.0 117.0 116.0 115.0 116.0 117.0 117.0 116.0 16:10:57 INFO - PID 13150 | 16:10:57 INFO - PID 13150 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 16:10:57 INFO - PID 13150 | Values: 149.0 149.0 150.0 150.0 149.0 150.0 150.0 152.0 151.0 151.0 16:10:57 INFO - PID 13150 | 16:10:57 INFO - PID 13150 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:1.52 (1.6%) stddev-sans-first:1.56 16:10:57 INFO - PID 13150 | Values: 93.0 94.0 93.0 94.0 93.0 93.0 94.0 95.0 94.0 98.0 16:10:57 INFO - PID 13150 | 16:10:57 INFO - PID 13150 | [#8] json-parse-financial Cycles:10 Average:43.60 Median:43.50 stddev:0.97 (2.2%) stddev-sans-first:1.00 16:10:57 INFO - PID 13150 | Values: 43.0 44.0 43.0 46.0 44.0 43.0 43.0 43.0 44.0 43.0 16:10:57 INFO - PID 13150 | 16:10:57 INFO - PID 13150 | [#9] json-stringify-tinderbox Cycles:10 Average:39.50 Median:40.00 stddev:0.53 (1.3%) stddev-sans-first:0.53 16:10:57 INFO - PID 13150 | Values: 40.0 40.0 40.0 39.0 39.0 39.0 40.0 40.0 39.0 39.0 16:10:57 INFO - PID 13150 | 16:10:57 INFO - PID 13150 | [#10] stanford-crypto-aes Cycles:10 Average:72.00 Median:72.00 stddev:1.63 (2.3%) stddev-sans-first:1.56 16:10:57 INFO - PID 13150 | Values: 74.0 70.0 72.0 70.0 71.0 71.0 72.0 73.0 72.0 75.0 16:10:57 INFO - PID 13150 | 16:10:57 INFO - PID 13150 | [#11] stanford-crypto-ccm Cycles:10 Average:107.70 Median:109.00 stddev:2.58 (2.4%) stddev-sans-first:2.60 16:10:57 INFO - PID 13150 | Values: 110.0 106.0 111.0 111.0 105.0 105.0 105.0 110.0 106.0 108.0 16:10:57 INFO - PID 13150 | 16:10:57 INFO - PID 13150 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:156.50 stddev:3.59 (2.3%) stddev-sans-first:3.61 16:10:57 INFO - PID 13150 | Values: 159.0 152.0 158.0 153.0 155.0 162.0 151.0 159.0 154.0 154.0 16:10:57 INFO - PID 13150 | 16:10:57 INFO - PID 13150 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:61.00 stddev:1.72 (2.8%) stddev-sans-first:1.81 16:10:57 INFO - PID 13150 | Values: 60.0 60.0 61.0 61.0 62.0 61.0 58.0 59.0 59.0 64.0 16:10:57 INFO - PID 13150 | -------- Summary: end -------- 16:10:57 INFO - PID 13150 | 16:10:58 INFO - PID 13150 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:10:58 INFO - TEST-INFO | 13150: exit 0 16:10:58 INFO - TEST-OK | kraken | took 60240ms 16:10:58 INFO - SUITE-END | took 1168s 16:10:58 INFO - Completed test suite (00:19:28) 16:10:58 INFO - javascript benchmark 16:10:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8950.693999531864, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3861.4593956846047, 3864.091938394478, 3894.318494263505, 3895.201483695841, 3916.9608303916953, 6058.939410605893, 6187.4740647045, 6228.065790131477, 6279.591826531278, 6289.905651415233, 6219.502439804816, 6251.3123556408755, 6303.936960630393, 6391.776287829927, 6414.871702565946, 5597.132444471094, 5720.370759216483, 5730.942690573103, 5744.655320680772, 5747.109198074284, 206.5670418398363, 5365.919511207335, 5621.0, 5659.0, 5706.7431965561445, 5592.412796656354, 5681.0, 5718.342390625069, 5727.914081288784, 5755.0504166812425, 5672.149177623348, 5682.119271512922, 5743.368229494752, 5749.310082790092, 5751.798687045975, 5603.775848966036, 5634.859128521779, 5705.286839145107, 5713.200151978726, 5718.085106382959, 6094.299155597075, 6210.875782484371, 6260.561760676755, 6323.241211054657, 6367.395097465734, 6617.536772425932, 6690.531662783607, 6691.498137639648, 6693.1298931138645, 6699.765508207238, 6804.829879253009, 6890.655467226668, 6899.517033807636, 6900.171979362459, 6907.585544867324, 6246.906296405557, 6337.017762246859, 6338.619682819046, 6401.1678481797535, 6408.166938297992, 6967.989641502055, 6987.091678081817, 6990.196127445409, 6991.93008069923, 7003.509754317149, 6656.400923916871, 6680.03139544773, 6684.532082754258, 6711.530192886451, 6720.630365329954, 6772.966135169293, 6823.658817059128, 6839.247682754893, 6845.863082738318, 6861.931380686229, 6675.866482670416, 6734.966325168441, 6737.764178253738, 6758.357955994173, 6764.120664313607, 6796.8300792479595, 6806.0, 6886.552374095668, 6896.862062758717, 6897.724091036403, 4925.335079764258, 4950.0, 4994.500549944976, 5014.648974571818, 5015.072211640858, 4429.047754732748, 4447.221736196153, 4506.1663592235545, 4549.704269222556, 4598.793054312497, 6329.0, 6375.808725738235, 6425.74297028123, 6428.485721142298, 6431.035344698239, 6837.589744615339, 6838.863222735617, 6920.8961865572055, 6924.272951340137, 6942.826429339206, 6278.591891527036, 6312.400321969406, 6355.3009168991375, 6357.427831495188, 6363.681815909186, 5472.069748142825, 5522.088855338904, 5538.0585300499015, 5538.363088244903, 5546.278983732089, 6937.098177237028, 6938.791836244921, 7022.262662420474, 7030.437564994788, 7049.541779784297, 6647.534672573067, 6678.499112566674, 6777.762778302933, 6819.829504262334, 6836.17965844082, 7115.146182457931, 7183.317584829433, 7212.593544259029, 7215.819604509929, 7218.566885986857, 6738.09035780183, 6750.6624668767345, 6811.080504132077, 6833.521653484208, 6835.487338449537, 6690.096836926952, 6791.7283308669075, 6794.082798822095, 6808.183018037867, 6901.240863505111, 6438.259600146043, 6479.611223326616, 6519.7392104315295, 6524.086627872007, 6552.63960482178, 6496.70764815575, 6527.804165875032, 6604.207495100619, 6616.7022483987375, 6702.329767023259, 6455.2576453708425, 6519.8044058678315, 6587.4071333580205, 6590.7693230736695, 6594.934050659624, 6499.415052645285, 6542.509311801538, 6594.769183078569, 6612.867742645024, 6614.834629134118, 6267.153934219004, 6472.385123413268, 6477.093206950936, 6559.704813283509, 6569.441597464269], "value": 6179.542919776066, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [952.6856137474634, 972.1056627902329, 974.9610015599376, 983.237990557318, 983.7094917500962, 46073.76963115184, 46327.536724632744, 46518.0, 46679.0, 46850.76574617131, 42771.57228427715, 42953.0, 43119.3532097018, 43214.7839260804, 43303.0, 7438.776836694908, 7515.774526764206, 7541.321281084702, 7571.962140189319, 7576.924230757677, 7412.851742965137, 7485.0643669541305, 7496.13794413644, 7500.212477689845, 7503.624818759067, 7499.55002699837, 8137.145599712034, 8351.58242087893, 8369.790755231106, 8370.58147092646, 8238.794030149264, 8292.626831792524, 8293.33653307734, 8293.95853020737, 8298.087210406851, 7943.404244681672, 8117.107118216992, 8121.7563473095315, 8126.268635822746, 8147.918520814776, 40946.0, 41061.0, 41113.0, 41293.380599291035, 41337.79331103355, 3802.3535998880257, 3862.1310205203886, 3863.9227215455535, 3864.9227015459815, 3865.613438656112, 33734.0, 33794.0, 33998.0, 34014.48978265328, 34059.0, 5396.43337449566, 5401.405845357008, 5410.188471729272, 5435.0488664483555, 5460.699661518614, 220352.0, 222188.0, 224001.0, 224966.0, 225569.0, 48232.7588362056, 53651.92696146055, 53896.73051634717, 54076.0, 54140.72929635327, 57387.0, 57631.0, 57719.42280577224, 57864.0, 57945.13082303769, 15029.323680434407, 15223.162726050174, 15291.082535047934, 15351.53945381618, 15363.385464581515, 12286.877131228573, 12368.81446778299, 12418.254904705565, 12429.689257768447, 12442.440090195963, 15132.167730774692, 15179.772303415457, 15181.240937953278, 15219.771703424236, 15367.462138825087, 5793.2179155814265, 5813.447722466359, 5944.346121926585, 6016.278046634432, 6052.636841789506, 1064.5422468338688, 1094.392612100292, 1097.9780404392027, 1104.4201794058024, 1119.0879433261866, 25690.35774105662, 25719.871400643253, 25833.354166145997, 25977.610335844976, 25984.35039124037, 1189.5776999165346, 1194.832723418722, 1195.8026925557185, 1199.598134624893, 1209.6189700244395, 13444.932775336061, 13486.0, 13488.5279015234, 13693.589192324247, 13933.0, 303503.0, 303627.0, 303783.0, 304914.0, 306458.0, 60673.0, 60788.0, 60851.39148608546, 60877.69561152166, 61039.69480152571, 1467.5744034230167, 1534.96162595936, 1536.1090567471063, 1539.3996341426853, 1542.5603702944607, 25544.616830747924, 25567.488650227264, 25612.61581076248, 25654.0, 25721.871390642926, 42678.78660606677, 42786.35820462758, 42799.35800962926, 42931.35602965896, 42932.0, 240201.0, 242426.0, 242916.0, 242942.0, 243893.0, 33102.834485827414, 33769.0, 36364.454533181495, 37308.06729831776, 37621.247575048896, 49415.752921235166, 49486.75256623694, 49746.25380619221, 49807.501924980286, 50262.7486862578, 36126.277474450886, 36439.27121457503, 36466.453003205505, 36704.63295367012, 36736.448953266256, 35401.82299088488, 35796.105097372776, 35880.64119358877, 36093.45859812157, 36476.088097797765, 41417.0, 41538.37692434555, 41882.37176442295, 41885.0, 41967.0, 33746.66253337435, 33945.66054339425, 34010.65989340174, 34189.82905085458, 34865.30269394648, 24712.629310560715, 25519.362015949006, 25766.613500797877, 25912.833922473157, 25921.22236332913], "value": 18687.619701504816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.8812215218616, 600.7596961215513, 601.5548494114357, 613.6195558753572, 613.8158552434269, 23310.76689233107, 23906.88046559767, 23952.999999999978, 23957.0, 23972.041118355246, 24093.63859542104, 25896.35259118523, 26005.219843404728, 26104.347391315227, 26205.34486637835, 6532.836679083025, 6671.49963752718, 6691.899621505681, 6707.463402927754, 6715.328467153295, 6425.45383642391, 6483.189601299838, 6507.707153178095, 6536.117624120754, 6723.428508576777, 6701.061851340816, 6710.664466776666, 6723.697433615474, 6730.326967303255, 6732.0, 6298.4331410172845, 6511.641859697715, 6544.67276636171, 6704.128463299764, 6724.495662825283, 6084.421979911901, 6092.847678808065, 6100.359462256488, 6104.267487901436, 6106.816795496142, 29313.56029659557, 29496.852515737497, 29670.0, 29677.554836677467, 29697.554536681968, 2214.202886960693, 2217.1907253852387, 2234.910603575855, 2235.8434909556336, 2245.820334373246, 19613.50966225856, 20914.163433462643, 20918.686219706564, 21033.894830525904, 21039.8948005259, 2467.0, 2472.27068014936, 2500.349909023667, 2600.180943002967, 2621.3446638340415, 130614.3469282657, 136153.0, 143213.0, 151016.48983510135, 152295.0, 15553.455629053155, 15991.840081599035, 16016.519504414886, 16187.19064046793, 16212.0, 24988.625170622454, 25013.749862501143, 25048.4990300193, 25063.0, 25077.0, 9969.102780749767, 10018.849717254247, 10058.396496210251, 10162.593496260215, 10209.438480883622, 8937.419067760575, 8963.865542016874, 9042.728718138467, 9134.543272836332, 9154.86267705985, 9472.242220622335, 9510.809783804423, 9521.619135234512, 9549.28380371461, 9613.855792163124, 2842.7441530261963, 2865.4698880707138, 2877.093715479617, 2917.591537184796, 2972.658144313388, 1036.6838114375037, 1037.6990672704983, 1046.3251202974038, 1048.046277887119, 1065.3235195650818, 20485.87327696961, 20616.0, 20943.581128377347, 21076.05157767904, 21090.367288981353, 1099.455769394155, 1103.757173421846, 1104.3318792130806, 1116.7989761842946, 1121.7027487715761, 11328.0, 11346.546138154381, 11460.828087578693, 11555.942220288845, 11584.362860042778, 650363.0, 658592.0, 659257.0, 660663.0, 664747.0, 123608.0, 124959.3752031234, 125816.0, 126244.0, 126451.0, 1031.8916513765946, 1156.5547264303304, 1159.9536018559163, 1221.773971815217, 1266.2149467330498, 21425.611892912275, 21625.0, 21956.121755129618, 22023.77976220217, 22142.778572214072, 57968.0, 58550.0, 59219.407805921386, 60452.0, 61334.0, 77951.61024194842, 78417.0, 79126.0, 79156.20843791719, 79170.60414697889, 15069.54791356261, 15187.316570754563, 15271.541853744406, 15281.312340944907, 15294.158821264937, 23683.289501314986, 23765.16821911225, 23990.640140397558, 23993.16023939154, 24340.148094816595, 17622.91188544049, 17942.910285448488, 18092.90953545224, 18092.909535452764, 18110.63778724392, 16948.745768813726, 17044.318227271266, 17767.73348399749, 17938.820611793715, 18229.361972330906, 18062.0, 18677.90661046686, 19449.12478938423, 19727.210911563376, 19850.801491984894, 14875.776863347275, 14942.327595258457, 14999.400023998918, 15037.849621503645, 15038.849611503745, 18012.279508820026, 18098.638027239645, 18119.45641630753, 18252.17865196043, 18289.17698703535], "value": 12549.619436055853, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.9225092619904, 1527.33560901008, 1533.1107957384718, 1540.7303721848677, 1549.2253873063469, 16411.83588164118, 17147.82852171478, 17249.051302178374, 17285.0, 17303.221355039022, 16781.24484398202, 16895.83104168958, 16939.83060169398, 16949.898256613313, 16961.0, 2680.932976675579, 2744.7529722324985, 2791.1347482280557, 2794.0779542750843, 2795.580662900561, 2750.7386798254133, 2751.257160566646, 2763.9170824875287, 2771.598118272849, 2773.251222170013, 2679.048937627134, 2758.724127587245, 2876.0509032019486, 2877.266297094238, 2877.453283876057, 2612.8171028028046, 2796.5385711357603, 2806.1441260415563, 2822.8588570571387, 2823.71762823718, 2750.051232324845, 2768.6262354582277, 2774.0, 2777.028040185939, 2777.2501424615443, 16805.411810586695, 16992.660146796996, 17096.658066838594, 17100.657986840193, 17101.0, 8211.425200235986, 8466.280366168883, 8468.280196183332, 8472.237498625153, 8479.872801907977, 5100.770465329069, 5265.473452654742, 5313.973430132824, 5337.039332920072, 5406.297181366397, 1997.500624843789, 2025.1494372363643, 2039.6328660841043, 2114.3234165067183, 2125.914963401462, 29584.26039349012, 29960.0, 29975.0, 30125.69874301251, 30661.23346916345, 6467.223933127961, 6594.769183078569, 6751.864962700718, 6824.863502729918, 6844.828879277959, 19185.040747962546, 19205.13576889043, 19378.70931936022, 19912.203511859654, 20099.39701808948, 8157.265846073882, 8340.499570025819, 8377.70678026266, 8381.245687888118, 8388.916110838936, 7567.886481702779, 7572.318491335806, 7684.385249180053, 7749.186335434811, 7776.883346749803, 5247.239150323182, 5386.649867758583, 5501.642393244426, 5518.33779946409, 5553.444655534414, 1528.5261568913672, 1534.2098819108169, 1537.2160198298725, 1544.9073055616475, 1551.3019141386196, 900.617237673986, 913.0777914306598, 923.2752289452748, 929.3494553812359, 933.6265493802533, 7676.347510461674, 7709.113451953097, 7771.0, 7773.727919522789, 7799.49303295284, 749.0973377080604, 749.2619769527012, 756.3722110648149, 773.6866569039548, 774.0981756253901, 4641.071785642885, 5019.796591890576, 5123.436421993578, 5251.76367063483, 5305.708186049727, 23061.0, 24953.750462495507, 25465.0, 25504.8724756375, 25533.106341277966, 23306.184283549996, 24585.385365366008, 24799.752002479745, 24900.128495502933, 24908.875455622605, 12426.689332766753, 12555.811662825065, 12650.304233267074, 12770.042246831339, 13005.0, 8118.675252989814, 8730.869036964323, 8735.213830755263, 8743.125687431206, 8746.606402712021, 20488.89755551213, 20870.478238044172, 21430.571388572454, 21625.13499460004, 21747.347579572637, 21294.18400914485, 21680.89159554192, 21909.233176838734, 21919.0, 22369.44076398103, 12220.205686630341, 12222.266663999833, 12229.082818788449, 12337.444814983168, 12340.136190466581, 15353.232338383259, 15546.844531554992, 15677.921610391875, 15756.290966906288, 15761.68476630438, 12610.684732881384, 12765.680857978625, 12869.09916305887, 13006.349682515647, 13141.605751827461, 12431.44058517387, 12431.75136497247, 12490.188137771016, 12779.744405112031, 12852.807207891701, 10522.736931576772, 10595.788084238426, 10743.194260430655, 10753.301035432673, 10755.516001780095, 7093.467989900675, 7271.818204544928, 7288.489805713762, 7301.196868344372, 7357.889631655637, 7175.964120179366, 7186.712531498891, 7195.964020179866, 7240.52936559143, 7285.890711639224], "value": 7054.337370986379, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.3214118070051, 560.5095541401274, 563.0709329606152, 565.2453973944783, 572.7165053298617, 6329.208848893888, 6353.968230158848, 6405.42351188393, 6413.230412350513, 6436.324185960477, 6233.812985610428, 6251.749650069982, 6279.968600157004, 6301.936980630192, 6317.684115794214, 5093.0, 5126.615503837208, 5154.819581314655, 5191.688498690071, 5199.714015729124, 4923.82766603169, 5010.348654674887, 5127.717975511346, 5152.92270615941, 5167.173252279636, 5016.949830501685, 5018.272350509174, 5021.723805190713, 5038.118329292378, 5057.747112644372, 4989.3535133405885, 4998.001598721009, 5006.524380183877, 5028.49715028496, 5051.924221136685, 4475.977620111878, 4535.977320113411, 4540.932880773015, 4552.15785079758, 4558.133954548625, 6102.26772787264, 6180.165677633507, 6200.844978875519, 6212.409821066992, 6220.160278362454, 5803.5357171426185, 5836.941630583725, 5867.970660146715, 5904.852378690567, 5925.259342582177, 6689.163854518185, 6691.19705635322, 6709.161354830646, 6720.966395167993, 6772.796816095525, 5098.490150984909, 5103.974480127613, 5111.4121875984365, 5116.439485956782, 5123.974380128113, 6803.829904252384, 6878.484113691493, 6914.412274956584, 6960.30396960305, 7053.400460960825, 5220.92168617471, 5221.712805795718, 5223.2948551945765, 5230.7384630769075, 5232.895342093137, 5309.230161626542, 5311.628186026941, 5319.9202011969855, 5321.36143662763, 5327.094393953037, 5877.794277200277, 5931.673757943355, 5932.2584676915385, 5933.732982015819, 5947.583669143119, 6669.266380698119, 6709.530332876652, 6782.796516104525, 6826.146731658543, 6846.931530684729, 1801.675698374279, 1805.2327760701648, 1814.564504518906, 1818.8453981411465, 1824.5256233379152, 1226.8466441694789, 1281.7756892543769, 1289.2264641215195, 1293.1723696834033, 1300.7723648361498, 6156.569040167235, 6161.168242287324, 6239.251289845248, 6295.213098362705, 6308.432241098323, 6715.56348837324, 6780.830479238059, 6827.556208846409, 6842.965785171043, 6882.242953275136, 6137.662428566472, 6141.938580614226, 6218.347073557302, 6219.0, 6237.96881015592, 3519.753617246768, 3548.27260411615, 3572.3391172633146, 3579.6599323064265, 3621.3662609043313, 7055.823604409931, 7056.506044576933, 7094.574325540484, 7116.573005619679, 7167.713291468387, 6932.826679333057, 7003.894941575881, 7017.350922533201, 7066.858662826715, 7076.32774886385, 6985.89521157183, 6988.860222795515, 6990.077728624668, 7013.544119632207, 7058.0, 6715.93284067153, 6737.461003119641, 6855.5201135922, 6865.347791959756, 6883.827904302432, 6726.428253598499, 6772.424343930821, 6829.6243706596615, 6855.211650660238, 6862.897056544056, 7010.929890701028, 7068.540544864567, 7073.2573079827935, 7115.430765538848, 7127.75052873147, 5129.512696293846, 5129.692218466904, 5163.793448262028, 5165.9483405165465, 5209.53114219722, 6590.769323073861, 6815.7731608308995, 6851.554648947803, 6868.725250989904, 6908.896366554405, 6345.650989195638, 6662.5348621010535, 6671.733130674718, 6673.366030227121, 6712.597244165366, 6600.174978127734, 6618.768343107968, 6638.900416493853, 6680.265170831108, 6705.396514313735, 6480.935190648033, 6519.500514881699, 6519.902201466887, 6547.690461907733, 6630.7679231226675, 6663.200415950117, 6748.0, 6760.628165450948, 6761.966190169018, 6799.048133261446, 6405.231372235362, 6492.74029038852, 6514.6416947068365, 6558.311377305315, 6564.704588293634], "value": 5225.608426608111, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [953.6241704366543, 981.430770153311, 983.6852207293668, 990.1732053735135, 1019.1846522781775, 18541.53646158847, 18776.967266800322, 18876.811231887677, 18933.715994260096, 18938.337158199432, 19222.327218547354, 19596.0, 19921.0, 20034.298799541983, 20224.59550808983, 1078.4769386847372, 1107.9612213572527, 1109.938953357565, 1110.0, 1110.639042311252, 1075.1237741240902, 1077.4397313397028, 1077.9784404311908, 1078.4068762180768, 1078.9082927951133, 1092.8415379769929, 1140.3329052504296, 1150.0167356909847, 1150.7755987582425, 1151.3264740127036, 1138.3966497756203, 1139.789139009286, 1144.1761931409371, 1145.5417832866879, 1146.01442759227, 832.9583520823995, 835.3818174550788, 835.5738573327586, 836.1554829622125, 836.3016880904452, 20271.79728202714, 20696.586068278702, 20887.26894558683, 21005.68491472629, 21009.159633614636, 22356.77643223563, 22746.77253227463, 23253.53492930132, 23255.186068487692, 23269.53460930772, 18583.44249672512, 18838.15228314729, 18888.33890813815, 18946.336878209197, 18961.0, 3976.204759048173, 4018.8995275118355, 4021.155557332934, 4046.5751096134777, 4064.0, 153530.0, 161704.99999999884, 165124.0, 165248.0, 167797.0, 15934.760978585331, 16402.589935251715, 16404.6719065618, 16418.507444776675, 16463.588410289838, 27821.304467388476, 29119.708802912122, 30678.0, 30769.692303077132, 30772.230694232374, 9836.3606365586, 9858.507074646239, 9915.752106197402, 9917.057879501435, 9933.155681766986, 4037.2934736421007, 4114.238865809834, 4145.937810932838, 4150.439690641725, 4190.245755763992, 5852.6195797273895, 5961.195238642815, 5978.252718410199, 6067.393260673985, 6076.21009268801, 1149.2472430557998, 1168.9357085360216, 1180.6458062581191, 1190.696372425026, 1200.0879331707965, 746.3022074360382, 753.5290443472829, 766.9118051424047, 781.1563511407666, 781.1680560203365, 12070.336131512675, 12694.873051269555, 13090.672733181556, 13140.408681609159, 13200.933995330153, 734.3024127079296, 755.8752805786984, 767.7121079595152, 770.4491288728474, 777.5917643237233, 5662.943370566324, 5711.171880077449, 5750.30996280449, 5793.536517078708, 5839.649621022752, 151219.0, 152086.0, 152121.0, 155902.0, 156494.2175289139, 131525.3423732875, 133069.33465332806, 133402.33298833444, 135790.0, 137642.31178844243, 111277.44361278304, 115019.42490287662, 115505.0, 116248.8375116238, 119323.99999999827, 10895.346279223271, 10906.727331816768, 11134.721631958942, 11169.329840209613, 11260.155488338243, 52592.7370363161, 53249.20126198188, 53982.730086349315, 54308.45691543192, 54724.726376367864, 67018.0, 67380.3261967374, 68920.0, 69633.0, 70320.0, 15433.0, 15774.842251577797, 15890.60273493172, 15927.60180995438, 15954.282057307217, 15141.772873406688, 15286.159261240738, 15406.38374465009, 15440.227988600749, 15511.37954481808, 16992.405265815636, 17003.14984250807, 17035.31858725687, 17296.91351543234, 17368.044757538457, 15342.693146137239, 15479.0, 15497.30262138229, 15532.767008495108, 15537.06777593348, 15888.841111589198, 15896.0, 15912.602184945468, 16108.919455402647, 16110.597235068748, 11704.70738231551, 11850.76298474043, 11949.820752688891, 12028.458719357825, 12043.976262017826, 12248.693782655504, 12379.75240495203, 12394.876051239373, 12488.625341239778, 12750.0], "value": 9624.528942982437, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1374.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 106.0, 105.0, 105.0, 106.0, 112.0, 98.0, 106.0, 106.0, 106.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 120.0, 111.0, 112.0, 112.0, 116.0, 111.0, 110.0, 144.0], "value": 116.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 163.0, 164.0, 161.0, 161.0, 162.0, 162.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 76.0, 73.0, 73.0, 75.0, 73.0, 75.0, 76.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 78.0, 77.0, 77.0, 78.0, 78.0, 77.0, 77.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 114.0, 117.0, 116.0, 115.0, 116.0, 117.0, 117.0, 116.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 150.0, 149.0, 150.0, 150.0, 152.0, 151.0, 151.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 94.0, 93.0, 93.0, 94.0, 95.0, 94.0, 98.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 44.0, 43.0, 46.0, 44.0, 43.0, 43.0, 43.0, 44.0, 43.0], "value": 43.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 40.0, 40.0, 39.0, 39.0, 39.0, 40.0, 40.0, 39.0, 39.0], "value": 39.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 72.0, 70.0, 71.0, 71.0, 72.0, 73.0, 72.0, 75.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 111.0, 111.0, 105.0, 105.0, 105.0, 110.0, 106.0, 108.0], "value": 107.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 152.0, 158.0, 153.0, 155.0, 162.0, 151.0, 159.0, 154.0, 154.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 61.0, 62.0, 61.0, 58.0, 59.0, 59.0, 64.0], "value": 60.5, "unit": "score"}]}]} 16:10:58 INFO - Return code: 0 16:10:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:10:58 INFO - # TBPL SUCCESS # 16:10:58 INFO - Running post-action listener: _package_coverage_data 16:10:58 INFO - Running post-action listener: _resource_record_post_action 16:10:58 INFO - [mozharness: 2017-09-17 23:10:58.918236Z] Finished run-tests step (success) 16:10:58 INFO - Running post-run listener: _resource_record_post_run 16:10:58 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 334663680; Read time: 0; Write time: 352552 16:10:58 INFO - TinderboxPrint: CPU usage
13.1% 16:10:58 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:10:58 INFO - TinderboxPrint: I/O write bytes / time
334,663,680 / 352,552 16:10:58 INFO - TinderboxPrint: CPU idle
8,225.5 (86.9%) 16:10:58 INFO - TinderboxPrint: CPU user
1,186.7 (12.5%) 16:10:58 INFO - TinderboxPrint: Swap in / out
0 / 0 16:10:58 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 16211968; Read time: 0; Write time: 2488 16:10:58 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:10:59 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 317919232; Read time: 0; Write time: 349936 16:10:59 INFO - Running post-run listener: _upload_blobber_files 16:10:59 INFO - Blob upload gear active. 16:10:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:10:59 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 16:10:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:10:59 INFO - (blobuploader) - INFO - Open directory for files ... 16:10:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:10:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:11:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:01 INFO - (blobuploader) - INFO - Done attempting. 16:11:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:11:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:11:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:07 INFO - (blobuploader) - INFO - Done attempting. 16:11:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:11:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:11:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:08 INFO - (blobuploader) - INFO - Done attempting. 16:11:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:11:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:11:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:09 INFO - (blobuploader) - INFO - Done attempting. 16:11:09 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:09 INFO - Return code: 0 16:11:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:09 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/402c92add39e3d1de2ee9202e951c8e8db6939aa61586d5b34e2656ecc63a3b3895e9935809a6d34297794e614bb5ed018d89e342296878553215cdf14f778bb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f1db94f5ecf7cd4f77d1ecb2ce61ac25687f5ecd552f29ad2f37425936f7206557ee2593b6f04b657bc5cdbe15c168340673447d02637cfef7e529bacd98459", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d00f01e8315c5a289f07f03601edce73d7b20641f4f85efaa9beaaa7a766c716bd3ff79914ca8fda1f4fa64d11be3fa770eec7c799252f77e6524e55fd9147e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63c9efc1539a8714deae3a65c6e272c10e8d395dc392ac48b0ee5dd7ecf9832e4908f7c95049d606cc485100855f1076fa7340de2f7b327471b1637269de5b7c"} 16:11:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:09 INFO - Contents: 16:11:09 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/402c92add39e3d1de2ee9202e951c8e8db6939aa61586d5b34e2656ecc63a3b3895e9935809a6d34297794e614bb5ed018d89e342296878553215cdf14f778bb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f1db94f5ecf7cd4f77d1ecb2ce61ac25687f5ecd552f29ad2f37425936f7206557ee2593b6f04b657bc5cdbe15c168340673447d02637cfef7e529bacd98459", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d00f01e8315c5a289f07f03601edce73d7b20641f4f85efaa9beaaa7a766c716bd3ff79914ca8fda1f4fa64d11be3fa770eec7c799252f77e6524e55fd9147e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63c9efc1539a8714deae3a65c6e272c10e8d395dc392ac48b0ee5dd7ecf9832e4908f7c95049d606cc485100855f1076fa7340de2f7b327471b1637269de5b7c"} 16:11:09 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:09 INFO - Copying logs to upload dir... 16:11:09 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.925053 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-17 16:11:09.915900) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 16:11:09.920634) ========= 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=df17445c3590ff7897617a0e00000225-1505687473.552855-995033135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/402c92add39e3d1de2ee9202e951c8e8db6939aa61586d5b34e2656ecc63a3b3895e9935809a6d34297794e614bb5ed018d89e342296878553215cdf14f778bb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f1db94f5ecf7cd4f77d1ecb2ce61ac25687f5ecd552f29ad2f37425936f7206557ee2593b6f04b657bc5cdbe15c168340673447d02637cfef7e529bacd98459", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d00f01e8315c5a289f07f03601edce73d7b20641f4f85efaa9beaaa7a766c716bd3ff79914ca8fda1f4fa64d11be3fa770eec7c799252f77e6524e55fd9147e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63c9efc1539a8714deae3a65c6e272c10e8d395dc392ac48b0ee5dd7ecf9832e4908f7c95049d606cc485100855f1076fa7340de2f7b327471b1637269de5b7c"} build_url:https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011452 build_url: 'https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/402c92add39e3d1de2ee9202e951c8e8db6939aa61586d5b34e2656ecc63a3b3895e9935809a6d34297794e614bb5ed018d89e342296878553215cdf14f778bb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f1db94f5ecf7cd4f77d1ecb2ce61ac25687f5ecd552f29ad2f37425936f7206557ee2593b6f04b657bc5cdbe15c168340673447d02637cfef7e529bacd98459", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d00f01e8315c5a289f07f03601edce73d7b20641f4f85efaa9beaaa7a766c716bd3ff79914ca8fda1f4fa64d11be3fa770eec7c799252f77e6524e55fd9147e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63c9efc1539a8714deae3a65c6e272c10e8d395dc392ac48b0ee5dd7ecf9832e4908f7c95049d606cc485100855f1076fa7340de2f7b327471b1637269de5b7c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 16:11:09.948224) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 16:11:09.948525) ========= 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=df17445c3590ff7897617a0e00000225-1505687473.552855-995033135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 16:11:10.001958) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 16:11:10.003810) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 16:11:10.004127) ========= ========= Total master_lag: 0.28 =========