builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1504864611.28 results: success (0) revision: 50857982881ae7803ceb438fee90650a282f7f05 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 02:56:51.284795) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 02:56:51.285447) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 02:56:51.285823) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 02:56:51.306863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:56:51.307248) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-08 02:56:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-09-08 02:56:51 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146851 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:56:51.474513) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:56:51.474939) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015659 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:56:51.525518) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:56:51.525930) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 50857982881ae7803ceb438fee90650a282f7f05 --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 50857982881ae7803ceb438fee90650a282f7f05 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-08 02:56:51,561 truncating revision to first 12 chars 2017-09-08 02:56:51,561 Setting DEBUG logging. 2017-09-08 02:56:51,561 attempt 1/10 2017-09-08 02:56:51,561 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/50857982881a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-08 02:56:51,846 unpacking tar archive at: mozilla-central-50857982881a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.573092 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:56:52.118826) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 02:56:52.119221) ========= script_repo_revision: 50857982881ae7803ceb438fee90650a282f7f05 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 02:56:52.119638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 02:56:52.119952) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 02:56:52.133894) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-08 02:56:52.134322) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:56:52 INFO - MultiFileLogger online at 20170908 02:56:52 in /builds/slave/test 02:56:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:56:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:56:52 INFO - {'append_to_log': False, 02:56:52 INFO - 'base_work_dir': '/builds/slave/test', 02:56:52 INFO - 'blob_upload_branch': 'Firefox', 02:56:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:56:52 INFO - 'branch': 'Firefox', 02:56:52 INFO - 'buildbot_json_path': 'buildprops.json', 02:56:52 INFO - 'code_coverage': False, 02:56:52 INFO - 'config_files': ('talos/linux_config.py',), 02:56:52 INFO - 'default_actions': ('clobber', 02:56:52 INFO - 'read-buildbot-config', 02:56:52 INFO - 'download-and-extract', 02:56:52 INFO - 'populate-webroot', 02:56:52 INFO - 'create-virtualenv', 02:56:52 INFO - 'install', 02:56:52 INFO - 'setup-mitmproxy', 02:56:52 INFO - 'run-tests'), 02:56:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:56:52 INFO - 'disable_ccov_upload': False, 02:56:52 INFO - 'disable_stylo': False, 02:56:52 INFO - 'download_minidump_stackwalk': True, 02:56:52 INFO - 'download_symbols': 'ondemand', 02:56:52 INFO - 'enable_stylo': False, 02:56:52 INFO - 'enable_webrender': False, 02:56:52 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:56:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:56:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:56:52 INFO - 'gecko_profile': False, 02:56:52 INFO - 'gecko_profile_interval': 0, 02:56:52 INFO - 'installer_path': 'installer.exe', 02:56:52 INFO - 'log_level': 'info', 02:56:52 INFO - 'log_name': 'talos', 02:56:52 INFO - 'log_to_console': True, 02:56:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:56:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:56:52 INFO - 'opt_config_files': (), 02:56:52 INFO - 'pip_index': False, 02:56:52 INFO - 'suite': 'dromaeojs-e10s', 02:56:52 INFO - 'system_bits': '32', 02:56:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:56:52 INFO - 'title': 'talos-linux64-ix-017', 02:56:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:56:52 INFO - 'use_talos_json': True, 02:56:52 INFO - 'verify': 'False', 02:56:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:56:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:56:52 INFO - 'work_dir': 'build'} 02:56:52 INFO - [mozharness: 2017-09-08 09:56:52.313072Z] Running clobber step. 02:56:52 INFO - Running pre-action listener: _resource_record_pre_action 02:56:52 INFO - Running main action method: clobber 02:56:52 INFO - rmtree: /builds/slave/test/build 02:56:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:56:53 INFO - Running post-action listener: _resource_record_post_action 02:56:53 INFO - [mozharness: 2017-09-08 09:56:53.951768Z] Finished clobber step (success) 02:56:53 INFO - [mozharness: 2017-09-08 09:56:53.951866Z] Running read-buildbot-config step. 02:56:53 INFO - Running pre-action listener: _resource_record_pre_action 02:56:53 INFO - Running main action method: read_buildbot_config 02:56:53 INFO - Using buildbot properties: 02:56:53 INFO - { 02:56:53 INFO - "project": "", 02:56:53 INFO - "product": "firefox", 02:56:53 INFO - "who": "archaeopteryx@coole-files.de", 02:56:53 INFO - "installer_path": "public/build/target.tar.bz2", 02:56:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:56:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:56:53 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:56:53 INFO - "stage_platform": "linux64-stylosequential", 02:56:53 INFO - "basedir": "/builds/slave/test", 02:56:53 INFO - "buildnumber": 66, 02:56:53 INFO - "platform": "ubuntu64_hw_styloseq", 02:56:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:56:53 INFO - "slavebuilddir": "test", 02:56:53 INFO - "taskId": "CGdzo3lvRAmSCu1Q2yhIgQ", 02:56:53 INFO - "branch": "mozilla-central", 02:56:53 INFO - "script_repo_revision": "production", 02:56:53 INFO - "revision": "50857982881ae7803ceb438fee90650a282f7f05", 02:56:53 INFO - "slavename": "talos-linux64-ix-017", 02:56:53 INFO - "repo_path": "mozilla-central" 02:56:53 INFO - } 02:56:53 INFO - Finding installer, test and symbols from parent task. 02:56:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CGdzo3lvRAmSCu1Q2yhIgQ'}, attempt #1 02:56:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CGdzo3lvRAmSCu1Q2yhIgQ'}, attempt #1 02:56:54 INFO - Task dependencies: HxFCvI-vRe6udwBtwR09eA 02:56:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA'}, attempt #1 02:56:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.tar.bz2 02:56:55 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.test_packages.json 02:56:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.crashreporter-symbols.zip 02:56:55 INFO - Running post-action listener: _resource_record_post_action 02:56:55 INFO - [mozharness: 2017-09-08 09:56:55.323913Z] Finished read-buildbot-config step (success) 02:56:55 INFO - [mozharness: 2017-09-08 09:56:55.324132Z] Running download-and-extract step. 02:56:55 INFO - Running pre-action listener: _resource_record_pre_action 02:56:55 INFO - Running main action method: download_and_extract 02:56:55 INFO - mkdir: /builds/slave/test/build/tests 02:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:55 INFO - trying https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.test_packages.json 02:56:55 INFO - Downloading https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:56:55 INFO - Downloaded 989 bytes. 02:56:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:56:55 INFO - Using the following test package requirements: 02:56:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:56:55 INFO - u'common': [u'target.common.tests.zip'], 02:56:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:56:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:56:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:56:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:56:55 INFO - u'mozbase': [u'target.common.tests.zip'], 02:56:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:56:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:56:55 INFO - u'web-platform': [u'target.common.tests.zip', 02:56:55 INFO - u'target.web-platform.tests.tar.gz'], 02:56:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:56:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 02:56:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.common.tests.zip 02:56:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:56:55 INFO - Fetch https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.common.tests.zip into memory 02:56:57 INFO - Content-Length response header: 55023697 02:56:57 INFO - Bytes received: 55023697 02:57:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.talos.tests.zip 02:57:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:57:08 INFO - Fetch https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.talos.tests.zip into memory 02:57:09 INFO - Content-Length response header: 14496665 02:57:09 INFO - Bytes received: 14496665 02:57: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')]} 02:57:09 INFO - trying https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.tar.bz2 02:57:09 INFO - Downloading https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:57:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:57:11 INFO - Downloaded 62786616 bytes. 02:57:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.tar.bz2 02:57:11 INFO - mkdir: /builds/slave/test/properties 02:57:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:57:11 INFO - Writing to file /builds/slave/test/properties/build_url 02:57:11 INFO - Contents: 02:57:11 INFO - build_url:https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.tar.bz2 02:57:11 INFO - Running post-action listener: _resource_record_post_action 02:57:11 INFO - Running post-action listener: find_tests_for_verification 02:57:11 INFO - Running post-action listener: set_extra_try_arguments 02:57:11 INFO - [mozharness: 2017-09-08 09:57:11.270592Z] Finished download-and-extract step (success) 02:57:11 INFO - [mozharness: 2017-09-08 09:57:11.270703Z] Running populate-webroot step. 02:57:11 INFO - Running pre-action listener: _resource_record_pre_action 02:57:11 INFO - Running main action method: populate_webroot 02:57:11 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:57:11 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:57:11 INFO - 'tests': ['tresize', 02:57:11 INFO - 'tcanvasmark']}, 02:57:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:57:11 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:57:11 INFO - 'tests': ['dromaeo_css', 02:57:11 INFO - 'kraken']}, 02:57:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:57:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:11 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:57:11 INFO - 'talos_options': ['--disable-stylo'], 02:57:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:57:11 INFO - 'tests': ['damp', 'tps']}, 02:57:11 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:57:11 INFO - 'talos_options': ['--disable-stylo'], 02:57:11 INFO - 'tests': ['damp', 'tps']}, 02:57:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:57:11 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:57:11 INFO - 'tests': ['dromaeo_dom']}, 02:57:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:57:11 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:57:11 INFO - 'tests': ['basic_compositor_video', 02:57:11 INFO - 'glvideo']}, 02:57:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:57:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:57:11 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:57:11 INFO - 'talos_options': ['--disable-stylo'], 02:57:11 INFO - 'tests': ['ts_paint_webext', 02:57:11 INFO - 'tp5o_webext']}, 02:57:11 INFO - 'other-e10s': {'tests': ['a11yr', 02:57:11 INFO - 'ts_paint', 02:57:11 INFO - 'tpaint', 02:57:11 INFO - 'sessionrestore', 02:57:11 INFO - 'sessionrestore_many_windows', 02:57:11 INFO - 'sessionrestore_no_auto_restore', 02:57:11 INFO - 'tabpaint']}, 02:57:11 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:57:11 INFO - 'tests': ['a11yr', 02:57:11 INFO - 'ts_paint', 02:57:11 INFO - 'tpaint', 02:57:11 INFO - 'sessionrestore', 02:57:11 INFO - 'sessionrestore_many_windows', 02:57:11 INFO - 'sessionrestore_no_auto_restore', 02:57:11 INFO - 'tabpaint']}, 02:57:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:57:11 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:57:11 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:57:11 INFO - 'tests': ['bloom_basic_singleton']}, 02:57:11 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:57:11 INFO - 'tests': ['bloom_basic']}, 02:57:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:57:11 INFO - 'tsvgr_opacity', 02:57:11 INFO - 'tart', 02:57:11 INFO - 'tscrollx', 02:57:11 INFO - 'tsvg_static']}, 02:57:11 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:57:11 INFO - 'tests': ['tsvgx', 02:57:11 INFO - 'tsvgr_opacity', 02:57:11 INFO - 'tart', 02:57:11 INFO - 'tscrollx', 02:57:11 INFO - 'tsvg_static']}, 02:57:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:57:11 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:57:11 INFO - 'talos_options': ['--disable-stylo'], 02:57:11 INFO - 'tests': ['tp5o']}, 02:57:11 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:57:11 INFO - 'talos_options': ['--mitmproxy', 02:57:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:57:11 INFO - '--firstNonBlankPaint'], 02:57:11 INFO - 'tests': ['tp6_google', 02:57:11 INFO - 'tp6_youtube', 02:57:11 INFO - 'tp6_amazon', 02:57:11 INFO - 'tp6_facebook']}, 02:57:11 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:57:11 INFO - 'talos_options': ['--disable-stylo', 02:57:11 INFO - '--mitmproxy', 02:57:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:57:11 INFO - '--firstNonBlankPaint'], 02:57:11 INFO - 'tests': ['tp6_google', 02:57:11 INFO - 'tp6_youtube', 02:57:11 INFO - 'tp6_amazon', 02:57:11 INFO - 'tp6_facebook']}, 02:57:11 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:57:11 INFO - 'talos_options': ['--stylo-threads=1', 02:57:11 INFO - '--mitmproxy', 02:57:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:57:11 INFO - '--firstNonBlankPaint'], 02:57:11 INFO - 'tests': ['tp6_google', 02:57:11 INFO - 'tp6_youtube', 02:57:11 INFO - 'tp6_amazon', 02:57:11 INFO - 'tp6_facebook']}, 02:57:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:57:11 INFO - 'talos_options': ['--xperf_path', 02:57:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:11 INFO - 'tests': ['tp5n']}, 02:57:11 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:57:11 INFO - 'talos_options': ['--disable-stylo', 02:57:11 INFO - '--xperf_path', 02:57:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:11 INFO - 'tests': ['tp5n']}}} 02:57:11 INFO - Running post-action listener: _resource_record_post_action 02:57:11 INFO - [mozharness: 2017-09-08 09:57:11.288062Z] Finished populate-webroot step (success) 02:57:11 INFO - [mozharness: 2017-09-08 09:57:11.288170Z] Running create-virtualenv step. 02:57:11 INFO - Running pre-action listener: _resource_record_pre_action 02:57:11 INFO - Running main action method: create_virtualenv 02:57:11 INFO - Creating virtualenv /builds/slave/test/build/venv 02:57:11 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:57:11 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:57:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:57:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:57:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:57:11 INFO - Installing distribute.............................................................................................................................................................................................done. 02:57:12 INFO - Installing pip...............done. 02:57:12 INFO - Return code: 0 02:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:57:12 INFO - Reading from file tmpfile_stdout 02:57:12 INFO - Output received: 02:57:12 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:57:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:12 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 0x1c621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2090>, '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 0x1fd2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fccf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:57:12 INFO - Using env: {'DISPLAY': ':0', 02:57:12 INFO - 'HOME': '/home/cltbld', 02:57:12 INFO - 'LANG': 'en_US.UTF-8', 02:57:12 INFO - 'LANGUAGE': 'en_US:en', 02:57:12 INFO - 'LOGNAME': 'cltbld', 02:57:12 INFO - 'MAIL': '/var/mail/cltbld', 02:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:12 INFO - 'MOZ_NO_REMOTE': '1', 02:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:12 INFO - 'NO_EM_RESTART': '1', 02:57:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:12 INFO - 'PWD': '/builds/slave/test', 02:57:12 INFO - 'SHELL': '/bin/bash', 02:57:12 INFO - 'SHLVL': '1', 02:57:12 INFO - 'TERM': 'linux', 02:57:12 INFO - 'TMOUT': '86400', 02:57:12 INFO - 'USER': 'cltbld', 02:57:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 02:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:12 INFO - '_': '/tools/buildbot/bin/python'} 02:57:13 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:57:13 INFO - Downloading/unpacking pip>=1.5 02:57:13 INFO - Running setup.py egg_info for package pip 02:57:13 INFO - warning: no files found matching 'pip/cacert.pem' 02:57:13 INFO - warning: no files found matching '*.html' under directory 'docs' 02:57:13 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:57:13 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:57:13 INFO - Installing collected packages: pip 02:57:13 INFO - Found existing installation: pip 1.1 02:57:13 INFO - Uninstalling pip: 02:57:13 INFO - Successfully uninstalled pip 02:57:13 INFO - Running setup.py install for pip 02:57:13 INFO - warning: no files found matching 'pip/cacert.pem' 02:57:13 INFO - warning: no files found matching '*.html' under directory 'docs' 02:57:13 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:57:13 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:57:13 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:57:13 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:57:13 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:57:13 INFO - Successfully installed pip 02:57:13 INFO - Cleaning up... 02:57:13 INFO - Return code: 0 02:57:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:13 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 0x1c621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2090>, '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 0x1fd2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fccf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:57:13 INFO - Using env: {'DISPLAY': ':0', 02:57:13 INFO - 'HOME': '/home/cltbld', 02:57:13 INFO - 'LANG': 'en_US.UTF-8', 02:57:13 INFO - 'LANGUAGE': 'en_US:en', 02:57:13 INFO - 'LOGNAME': 'cltbld', 02:57:13 INFO - 'MAIL': '/var/mail/cltbld', 02:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:13 INFO - 'MOZ_NO_REMOTE': '1', 02:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:13 INFO - 'NO_EM_RESTART': '1', 02:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:13 INFO - 'PWD': '/builds/slave/test', 02:57:13 INFO - 'SHELL': '/bin/bash', 02:57:13 INFO - 'SHLVL': '1', 02:57:13 INFO - 'TERM': 'linux', 02:57:13 INFO - 'TMOUT': '86400', 02:57:13 INFO - 'USER': 'cltbld', 02:57:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 02:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:13 INFO - '_': '/tools/buildbot/bin/python'} 02:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:13 INFO - Downloading/unpacking psutil>=3.1.1 02:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:57:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:14 INFO - Installing collected packages: psutil 02:57:14 INFO - Running setup.py install for psutil 02:57:15 INFO - building 'psutil._psutil_linux' extension 02:57:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:57:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:57:15 INFO - building 'psutil._psutil_posix' extension 02:57:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:57:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:57:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:15 INFO - Successfully installed psutil 02:57:15 INFO - Cleaning up... 02:57:15 INFO - Return code: 0 02:57:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2090>, '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 0x1fd2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fccf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:57:15 INFO - Using env: {'DISPLAY': ':0', 02:57:15 INFO - 'HOME': '/home/cltbld', 02:57:15 INFO - 'LANG': 'en_US.UTF-8', 02:57:15 INFO - 'LANGUAGE': 'en_US:en', 02:57:15 INFO - 'LOGNAME': 'cltbld', 02:57:15 INFO - 'MAIL': '/var/mail/cltbld', 02:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:15 INFO - 'MOZ_NO_REMOTE': '1', 02:57:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:15 INFO - 'NO_EM_RESTART': '1', 02:57:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:15 INFO - 'PWD': '/builds/slave/test', 02:57:15 INFO - 'SHELL': '/bin/bash', 02:57:15 INFO - 'SHLVL': '1', 02:57:15 INFO - 'TERM': 'linux', 02:57:15 INFO - 'TMOUT': '86400', 02:57:15 INFO - 'USER': 'cltbld', 02:57:15 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 02:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:15 INFO - '_': '/tools/buildbot/bin/python'} 02:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:57:16 INFO - Installing collected packages: mozsystemmonitor 02:57:16 INFO - Running setup.py install for mozsystemmonitor 02:57:17 INFO - Successfully installed mozsystemmonitor 02:57:17 INFO - Cleaning up... 02:57:17 INFO - Return code: 0 02:57:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2090>, '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 0x1fd2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fccf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:57:17 INFO - Using env: {'DISPLAY': ':0', 02:57:17 INFO - 'HOME': '/home/cltbld', 02:57:17 INFO - 'LANG': 'en_US.UTF-8', 02:57:17 INFO - 'LANGUAGE': 'en_US:en', 02:57:17 INFO - 'LOGNAME': 'cltbld', 02:57:17 INFO - 'MAIL': '/var/mail/cltbld', 02:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:17 INFO - 'MOZ_NO_REMOTE': '1', 02:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:17 INFO - 'NO_EM_RESTART': '1', 02:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:17 INFO - 'PWD': '/builds/slave/test', 02:57:17 INFO - 'SHELL': '/bin/bash', 02:57:17 INFO - 'SHLVL': '1', 02:57:17 INFO - 'TERM': 'linux', 02:57:17 INFO - 'TMOUT': '86400', 02:57:17 INFO - 'USER': 'cltbld', 02:57:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 02:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:17 INFO - '_': '/tools/buildbot/bin/python'} 02:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:17 INFO - Downloading/unpacking jsonschema==2.5.1 02:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:57:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:20 INFO - Downloading functools32-3.2.3-2.tar.gz 02:57:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:57:20 INFO - warning: no files found matching '*.txt' 02:57:20 INFO - no previously-included directories found matching 'build' 02:57:20 INFO - no previously-included directories found matching 'dist' 02:57:20 INFO - no previously-included directories found matching '.git*' 02:57:20 INFO - Installing collected packages: jsonschema, functools32 02:57:20 INFO - Running setup.py install for functools32 02:57:20 INFO - warning: no files found matching '*.txt' 02:57:20 INFO - no previously-included directories found matching 'build' 02:57:20 INFO - no previously-included directories found matching 'dist' 02:57:20 INFO - no previously-included directories found matching '.git*' 02:57:20 INFO - Successfully installed jsonschema functools32 02:57:20 INFO - Cleaning up... 02:57:20 INFO - Return code: 0 02:57:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2090>, '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 0x1fd2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fccf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:57:20 INFO - Using env: {'DISPLAY': ':0', 02:57:20 INFO - 'HOME': '/home/cltbld', 02:57:20 INFO - 'LANG': 'en_US.UTF-8', 02:57:20 INFO - 'LANGUAGE': 'en_US:en', 02:57:20 INFO - 'LOGNAME': 'cltbld', 02:57:20 INFO - 'MAIL': '/var/mail/cltbld', 02:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:20 INFO - 'MOZ_NO_REMOTE': '1', 02:57:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:20 INFO - 'NO_EM_RESTART': '1', 02:57:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:20 INFO - 'PWD': '/builds/slave/test', 02:57:20 INFO - 'SHELL': '/bin/bash', 02:57:20 INFO - 'SHLVL': '1', 02:57:20 INFO - 'TERM': 'linux', 02:57:20 INFO - 'TMOUT': '86400', 02:57:20 INFO - 'USER': 'cltbld', 02:57:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 02:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:20 INFO - '_': '/tools/buildbot/bin/python'} 02:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:57:20 INFO - Cleaning up... 02:57:20 INFO - Return code: 0 02:57:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2090>, '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 0x1fd2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fccf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:57:20 INFO - Using env: {'DISPLAY': ':0', 02:57:20 INFO - 'HOME': '/home/cltbld', 02:57:20 INFO - 'LANG': 'en_US.UTF-8', 02:57:20 INFO - 'LANGUAGE': 'en_US:en', 02:57:20 INFO - 'LOGNAME': 'cltbld', 02:57:20 INFO - 'MAIL': '/var/mail/cltbld', 02:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:20 INFO - 'MOZ_NO_REMOTE': '1', 02:57:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:20 INFO - 'NO_EM_RESTART': '1', 02:57:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:20 INFO - 'PWD': '/builds/slave/test', 02:57:20 INFO - 'SHELL': '/bin/bash', 02:57:20 INFO - 'SHLVL': '1', 02:57:20 INFO - 'TERM': 'linux', 02:57:20 INFO - 'TMOUT': '86400', 02:57:20 INFO - 'USER': 'cltbld', 02:57:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 02:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:20 INFO - '_': '/tools/buildbot/bin/python'} 02:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:21 INFO - Downloading/unpacking blobuploader==1.2.4 02:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:22 INFO - Downloading blobuploader-1.2.4.tar.gz 02:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:57:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:57:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:22 INFO - Downloading docopt-0.6.1.tar.gz 02:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:57:22 INFO - Installing collected packages: blobuploader, requests, docopt 02:57:22 INFO - Running setup.py install for blobuploader 02:57:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:57:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:57:22 INFO - Running setup.py install for requests 02:57:23 INFO - Running setup.py install for docopt 02:57:23 INFO - Successfully installed blobuploader requests docopt 02:57:23 INFO - Cleaning up... 02:57:23 INFO - Return code: 0 02:57:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2090>, '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 0x1fd2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fccf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:57:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:57:23 INFO - Using env: {'DISPLAY': ':0', 02:57:23 INFO - 'HOME': '/home/cltbld', 02:57:23 INFO - 'LANG': 'en_US.UTF-8', 02:57:23 INFO - 'LANGUAGE': 'en_US:en', 02:57:23 INFO - 'LOGNAME': 'cltbld', 02:57:23 INFO - 'MAIL': '/var/mail/cltbld', 02:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:23 INFO - 'MOZ_NO_REMOTE': '1', 02:57:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:23 INFO - 'NO_EM_RESTART': '1', 02:57:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:23 INFO - 'PWD': '/builds/slave/test', 02:57:23 INFO - 'SHELL': '/bin/bash', 02:57:23 INFO - 'SHLVL': '1', 02:57:23 INFO - 'TERM': 'linux', 02:57:23 INFO - 'TMOUT': '86400', 02:57:23 INFO - 'USER': 'cltbld', 02:57:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 02:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:23 INFO - '_': '/tools/buildbot/bin/python'} 02:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:57:23 INFO - Running setup.py (path:/tmp/pip-aA5p2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:57:23 INFO - Running setup.py (path:/tmp/pip-cnATrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:57:23 INFO - Running setup.py (path:/tmp/pip-9j6hBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:57:23 INFO - Running setup.py (path:/tmp/pip-TQbhtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:57:23 INFO - Running setup.py (path:/tmp/pip-WWQbmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:57:23 INFO - Running setup.py (path:/tmp/pip-OSgrV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:57:23 INFO - Running setup.py (path:/tmp/pip-aBm8B8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:57:24 INFO - Running setup.py (path:/tmp/pip-1gxR8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:57:24 INFO - Running setup.py (path:/tmp/pip-n95Jq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:57:24 INFO - Running setup.py (path:/tmp/pip-eS3mY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:57:24 INFO - Running setup.py (path:/tmp/pip-VlK_Qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:57:24 INFO - Running setup.py (path:/tmp/pip-EZL2s5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:57:24 INFO - Running setup.py (path:/tmp/pip-e2Sr1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:57:24 INFO - Running setup.py (path:/tmp/pip-0Ew_Ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:24 INFO - Running setup.py (path:/tmp/pip-o2_l65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:57:24 INFO - Running setup.py (path:/tmp/pip-H5LTAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:57:24 INFO - Running setup.py (path:/tmp/pip-556xAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:57:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:57:24 INFO - Running setup.py install for manifestparser 02:57:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:57:24 INFO - Running setup.py install for mozcrash 02:57:24 INFO - Running setup.py install for mozdebug 02:57:25 INFO - Running setup.py install for mozdevice 02:57:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:57:25 INFO - Running setup.py install for mozfile 02:57:25 INFO - Running setup.py install for mozhttpd 02:57:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:57:25 INFO - Running setup.py install for mozinfo 02:57:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:57:25 INFO - Running setup.py install for mozInstall 02:57:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:57:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:57:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:57:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:57:25 INFO - Running setup.py install for mozleak 02:57:25 INFO - Running setup.py install for mozlog 02:57:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:57:25 INFO - Running setup.py install for moznetwork 02:57:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:57:25 INFO - Running setup.py install for mozprocess 02:57:25 INFO - Running setup.py install for mozprofile 02:57:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:57:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:57:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:57:26 INFO - Running setup.py install for mozrunner 02:57:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:57:26 INFO - Running setup.py install for mozscreenshot 02:57:26 INFO - Running setup.py install for moztest 02:57:26 INFO - Running setup.py install for mozversion 02:57:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:57:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:57:26 INFO - Cleaning up... 02:57:26 INFO - Return code: 0 02:57:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2090>, '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 0x1fd2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fccf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:57:26 INFO - Using env: {'DISPLAY': ':0', 02:57:26 INFO - 'HOME': '/home/cltbld', 02:57:26 INFO - 'LANG': 'en_US.UTF-8', 02:57:26 INFO - 'LANGUAGE': 'en_US:en', 02:57:26 INFO - 'LOGNAME': 'cltbld', 02:57:26 INFO - 'MAIL': '/var/mail/cltbld', 02:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:26 INFO - 'MOZ_NO_REMOTE': '1', 02:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:26 INFO - 'NO_EM_RESTART': '1', 02:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:26 INFO - 'PWD': '/builds/slave/test', 02:57:26 INFO - 'SHELL': '/bin/bash', 02:57:26 INFO - 'SHLVL': '1', 02:57:26 INFO - 'TERM': 'linux', 02:57:26 INFO - 'TMOUT': '86400', 02:57:26 INFO - 'USER': 'cltbld', 02:57:26 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 02:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:26 INFO - '_': '/tools/buildbot/bin/python'} 02:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:57:26 INFO - Running setup.py (path:/tmp/pip-mmL37x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:57:26 INFO - Running setup.py (path:/tmp/pip-t7D5et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:57:26 INFO - Running setup.py (path:/tmp/pip-1ywyDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:57:26 INFO - Running setup.py (path:/tmp/pip-E2pIzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:57:26 INFO - Running setup.py (path:/tmp/pip-GC5vF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:57:27 INFO - Running setup.py (path:/tmp/pip-npk8KB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:57:27 INFO - Running setup.py (path:/tmp/pip-tydqZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:57:27 INFO - Running setup.py (path:/tmp/pip-f238_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:57:27 INFO - Running setup.py (path:/tmp/pip-IrOa8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:57:27 INFO - Running setup.py (path:/tmp/pip-AkORMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:57:27 INFO - Running setup.py (path:/tmp/pip-FuCosz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:57:27 INFO - Running setup.py (path:/tmp/pip-P3P3J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:57:27 INFO - Running setup.py (path:/tmp/pip-x8WRc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:57:27 INFO - Running setup.py (path:/tmp/pip-7RWJKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:27 INFO - Running setup.py (path:/tmp/pip-dAca5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:57:27 INFO - Running setup.py (path:/tmp/pip-Kp5r4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:57:27 INFO - Running setup.py (path:/tmp/pip-O4KKc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:57:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:29 INFO - Downloading blessings-1.6.tar.gz 02:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:57:29 INFO - Installing collected packages: blessings 02:57:29 INFO - Running setup.py install for blessings 02:57:29 INFO - Successfully installed blessings 02:57:29 INFO - Cleaning up... 02:57:29 INFO - Return code: 0 02:57:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:57:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:57:29 INFO - Reading from file tmpfile_stdout 02:57:29 INFO - Current package versions: 02:57:29 INFO - argparse == 1.2.1 02:57:29 INFO - blessings == 1.6 02:57:29 INFO - blobuploader == 1.2.4 02:57:29 INFO - docopt == 0.6.1 02:57:29 INFO - functools32 == 3.2.3-2 02:57:29 INFO - jsonschema == 2.5.1 02:57:29 INFO - manifestparser == 1.1 02:57:29 INFO - mozInstall == 1.13 02:57:29 INFO - mozcrash == 1.0 02:57:29 INFO - mozdebug == 0.1 02:57:29 INFO - mozdevice == 0.51 02:57:29 INFO - mozfile == 1.2 02:57:29 INFO - mozhttpd == 0.7 02:57:29 INFO - mozinfo == 0.10 02:57:29 INFO - mozleak == 0.1 02:57:29 INFO - mozlog == 3.5 02:57:29 INFO - moznetwork == 0.27 02:57:29 INFO - mozprocess == 0.25 02:57:29 INFO - mozprofile == 0.28 02:57:29 INFO - mozrunner == 6.13 02:57:29 INFO - mozscreenshot == 0.1 02:57:29 INFO - mozsystemmonitor == 0.3 02:57:29 INFO - moztest == 0.8 02:57:29 INFO - mozversion == 1.4 02:57:29 INFO - psutil == 3.1.1 02:57:29 INFO - requests == 1.2.3 02:57:29 INFO - wsgiref == 0.1.2 02:57:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57: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')]} 02:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2090>, '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 0x1fd2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fccf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:57:29 INFO - Using env: {'DISPLAY': ':0', 02:57:29 INFO - 'HOME': '/home/cltbld', 02:57:29 INFO - 'LANG': 'en_US.UTF-8', 02:57:29 INFO - 'LANGUAGE': 'en_US:en', 02:57:29 INFO - 'LOGNAME': 'cltbld', 02:57:29 INFO - 'MAIL': '/var/mail/cltbld', 02:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:29 INFO - 'MOZ_NO_REMOTE': '1', 02:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:29 INFO - 'NO_EM_RESTART': '1', 02:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:29 INFO - 'PWD': '/builds/slave/test', 02:57:29 INFO - 'SHELL': '/bin/bash', 02:57:29 INFO - 'SHLVL': '1', 02:57:29 INFO - 'TERM': 'linux', 02:57:29 INFO - 'TMOUT': '86400', 02:57:29 INFO - 'USER': 'cltbld', 02:57:29 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 02:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:29 INFO - '_': '/tools/buildbot/bin/python'} 02:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:57:29 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:57:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:57:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:57:30 INFO - Installing collected packages: simplejson 02:57:30 INFO - Running setup.py install for simplejson 02:57:30 INFO - building 'simplejson._speedups' extension 02:57:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 02:57:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 02:57:31 INFO - Successfully installed simplejson 02:57:31 INFO - Cleaning up... 02:57:31 INFO - Return code: 0 02:57:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2090>, '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 0x1fd2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fccf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:57:31 INFO - Using env: {'DISPLAY': ':0', 02:57:31 INFO - 'HOME': '/home/cltbld', 02:57:31 INFO - 'LANG': 'en_US.UTF-8', 02:57:31 INFO - 'LANGUAGE': 'en_US:en', 02:57:31 INFO - 'LOGNAME': 'cltbld', 02:57:31 INFO - 'MAIL': '/var/mail/cltbld', 02:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:31 INFO - 'MOZ_NO_REMOTE': '1', 02:57:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:31 INFO - 'NO_EM_RESTART': '1', 02:57:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:31 INFO - 'PWD': '/builds/slave/test', 02:57:31 INFO - 'SHELL': '/bin/bash', 02:57:31 INFO - 'SHLVL': '1', 02:57:31 INFO - 'TERM': 'linux', 02:57:31 INFO - 'TMOUT': '86400', 02:57:31 INFO - 'USER': 'cltbld', 02:57:31 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 02:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:31 INFO - '_': '/tools/buildbot/bin/python'} 02:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:57:32 INFO - Cleaning up... 02:57:32 INFO - Return code: 0 02:57:32 INFO - Running post-action listener: _resource_record_post_action 02:57:32 INFO - Running post-action listener: _start_resource_monitoring 02:57:32 INFO - Starting resource monitoring. 02:57:32 INFO - [mozharness: 2017-09-08 09:57:32.196049Z] Finished create-virtualenv step (success) 02:57:32 INFO - [mozharness: 2017-09-08 09:57:32.196566Z] Running install step. 02:57:32 INFO - Running pre-action listener: _resource_record_pre_action 02:57:32 INFO - Running main action method: install 02:57:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:57:32 INFO - Reading from file tmpfile_stdout 02:57:32 INFO - Detecting whether we're running mozinstall >=1.0... 02:57:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:57:32 INFO - Reading from file tmpfile_stdout 02:57:32 INFO - Output received: 02:57:32 INFO - Usage: mozinstall [options] installer 02:57:32 INFO - Options: 02:57:32 INFO - -h, --help show this help message and exit 02:57:32 INFO - -d DEST, --destination=DEST 02:57:32 INFO - Directory to install application into. [default: 02:57:32 INFO - "/builds/slave/test"] 02:57:32 INFO - --app=APP Application being installed. [default: firefox] 02:57:32 INFO - mkdir: /builds/slave/test/build/application 02:57:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:57:49 INFO - Reading from file tmpfile_stdout 02:57:49 INFO - Output received: 02:57:49 INFO - /builds/slave/test/build/application/firefox/firefox 02:57:49 INFO - Running post-action listener: _resource_record_post_action 02:57:49 INFO - [mozharness: 2017-09-08 09:57:49.087794Z] Finished install step (success) 02:57:49 INFO - [mozharness: 2017-09-08 09:57:49.087939Z] Running setup-mitmproxy step. 02:57:49 INFO - Running pre-action listener: _resource_record_pre_action 02:57:49 INFO - Running main action method: setup_mitmproxy 02:57:49 INFO - Skipping: mitmproxy is not required 02:57:49 INFO - Running post-action listener: _resource_record_post_action 02:57:49 INFO - [mozharness: 2017-09-08 09:57:49.088470Z] Finished setup-mitmproxy step (success) 02:57:49 INFO - [mozharness: 2017-09-08 09:57:49.088573Z] Running run-tests step. 02:57:49 INFO - Running pre-action listener: _resource_record_pre_action 02:57:49 INFO - Running pre-action listener: _set_gcov_prefix 02:57:49 INFO - Running main action method: run_tests 02:57:49 WARNING - Try message not found. 02:57:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:57:49 INFO - Python 2.7.3 02:57:49 INFO - Return code: 0 02:57:49 INFO - grabbing minidump binary from tooltool 02:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:49 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 0x1fd2090>, '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 0x1fd2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fccf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:57:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:57:49 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:57:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:57:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:57:49 INFO - Return code: 0 02:57:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:57:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:57:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:57:49 INFO - ENV: RUST_BACKTRACE is now full 02:57:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:57:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:57:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:57:49 INFO - Using env: {'DISPLAY': ':0', 02:57:49 INFO - 'HOME': '/home/cltbld', 02:57:49 INFO - 'LANG': 'en_US.UTF-8', 02:57:49 INFO - 'LANGUAGE': 'en_US:en', 02:57:49 INFO - 'LOGNAME': 'cltbld', 02:57:49 INFO - 'MAIL': '/var/mail/cltbld', 02:57:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:57:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:49 INFO - 'MOZ_NO_REMOTE': '1', 02:57:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:49 INFO - 'NO_EM_RESTART': '1', 02:57:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:49 INFO - 'PWD': '/builds/slave/test', 02:57:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:57:49 INFO - 'RUST_BACKTRACE': 'full', 02:57:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:57:49 INFO - 'SHELL': '/bin/bash', 02:57:49 INFO - 'SHLVL': '1', 02:57:49 INFO - 'STYLO_FORCE_ENABLED': '1', 02:57:49 INFO - 'STYLO_THREADS': '1', 02:57:49 INFO - 'TERM': 'linux', 02:57:49 INFO - 'TMOUT': '86400', 02:57:49 INFO - 'USER': 'cltbld', 02:57:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 02:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:49 INFO - '_': '/tools/buildbot/bin/python'} 02:57:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:57:49 INFO - mozversion application_buildid: 20170908090235 02:57:49 INFO - mozversion application_changeset: 50857982881ae7803ceb438fee90650a282f7f05 02:57:49 INFO - mozversion application_display_name: Nightly 02:57:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:57:49 INFO - mozversion application_name: Firefox 02:57:49 INFO - mozversion application_remotingname: firefox 02:57:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:57:49 INFO - mozversion application_vendor: Mozilla 02:57:49 INFO - mozversion application_version: 57.0a1 02:57:49 INFO - mozversion platform_buildid: 20170908090235 02:57:49 INFO - mozversion platform_changeset: 50857982881ae7803ceb438fee90650a282f7f05 02:57:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:57:49 INFO - mozversion platform_version: 57.0a1 02:57:49 INFO - using testdate: 1504864669 02:57:49 INFO - actual date: 1504864669 02:57:49 INFO - starting webserver on 'localhost:52574' 02:57:49 INFO - SUITE-START | Running 2 tests 02:57:49 INFO - TEST-START | dromaeo_css 02:57:49 INFO - Initialising browser for dromaeo_css test... 02:57:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52574/getInfo.html -profile /tmp/tmpYnWjTX/profile 02:57:49 INFO - TEST-INFO | started process 28653 (/builds/slave/test/build/application/firefox/firefox http://localhost:52574/getInfo.html) 02:57:54 INFO - TEST-INFO | 28653: exit 0 02:57:54 INFO - Browser initialized. 02:57:54 INFO - Running cycle 1/1 for dromaeo_css test... 02:57:54 INFO - Using env: {'DISPLAY': ':0', 02:57:54 INFO - 'HOME': '/home/cltbld', 02:57:54 INFO - 'JSGC_DISABLE_POISONING': '1', 02:57:54 INFO - 'LANG': 'en_US.UTF-8', 02:57:54 INFO - 'LANGUAGE': 'en_US:en', 02:57:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:57:54 INFO - 'LOGNAME': 'cltbld', 02:57:54 INFO - 'MAIL': '/var/mail/cltbld', 02:57:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:57:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:57:54 INFO - 'MOZ_CRASHREPORTER': '1', 02:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:57:54 INFO - 'MOZ_NO_REMOTE': '1', 02:57:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:57:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:54 INFO - 'NO_EM_RESTART': '1', 02:57:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:54 INFO - 'PWD': '/builds/slave/test', 02:57:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:57:54 INFO - 'RUST_BACKTRACE': 'full', 02:57:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:57:54 INFO - 'SHELL': '/bin/bash', 02:57:54 INFO - 'SHLVL': '1', 02:57:54 INFO - 'STYLO_FORCE_ENABLED': '1', 02:57:54 INFO - 'STYLO_THREADS': '1', 02:57:54 INFO - 'TERM': 'linux', 02:57:54 INFO - 'TMOUT': '86400', 02:57:54 INFO - 'USER': 'cltbld', 02:57:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 02:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:54 INFO - '_': '/tools/buildbot/bin/python'} 02:57:54 INFO - TEST-INFO | started process 28834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYnWjTX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:57:55 INFO - PID 28834 | 02:57:55 INFO - PID 28834 | (/builds/slave/test/build/application/firefox/firefox:28885): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:57:55 INFO - PID 28834 | 02:58:05 INFO - PID 28834 | RSS: Main: 172437504 02:58:05 INFO - PID 28834 | 03:01:03 INFO - PID 28834 | Cycle 1(1): loaded http://localhost:52574/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52574/tests/dromaeo/cssquery-ext.html) 03:01:04 INFO - PID 28834 | RSS: Main: 172814336 03:01:04 INFO - PID 28834 | 03:04:06 INFO - PID 28834 | Cycle 1(1): loaded http://localhost:52574/tests/dromaeo/cssquery-ext.html (next: http://localhost:52574/tests/dromaeo/cssquery-jquery.html) 03:04:06 INFO - PID 28834 | RSS: Main: 171053056 03:04:06 INFO - PID 28834 | 03:07:08 INFO - PID 28834 | Cycle 1(1): loaded http://localhost:52574/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52574/tests/dromaeo/cssquery-mootools.html) 03:07:09 INFO - PID 28834 | RSS: Main: 171573248 03:07:09 INFO - PID 28834 | 03:10:11 INFO - PID 28834 | Cycle 1(1): loaded http://localhost:52574/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52574/tests/dromaeo/cssquery-prototype.html) 03:10:11 INFO - PID 28834 | RSS: Main: 172265472 03:10:11 INFO - PID 28834 | 03:13:15 INFO - PID 28834 | Cycle 1(1): loaded http://localhost:52574/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52574/tests/dromaeo/cssquery-yui.html) 03:13:15 INFO - PID 28834 | RSS: Main: 173146112 03:13:15 INFO - PID 28834 | 03:16:17 INFO - PID 28834 | Cycle 1(1): loaded http://localhost:52574/tests/dromaeo/cssquery-yui.html (next: http://localhost:52574/tests/dromaeo/cssquery-dojo.html) 03:16:17 INFO - PID 28834 | RSS: Main: 175398912 03:16:17 INFO - PID 28834 | 03:16:17 INFO - PID 28834 | __start_tp_report 03:16:17 INFO - PID 28834 | _x_x_mozilla_page_load 03:16:17 INFO - PID 28834 | _x_x_mozilla_page_load_details 03:16:17 INFO - PID 28834 | |i|pagename|runs| 03:16:17 INFO - PID 28834 | |0;dojo.html;3090.119315994942;3106.5184896341066;3117.6570577236484;3144.9842750786256;3148.9527657085146;6113.755449782004;6318.810435686931;6326.240851097869;6328.398802113803;6344.619322840633;6254.655993920333;6307.747690092391;6349.492040636749;6384.585001974869;6414;5688.288963879515;5836;5861.325947516048;5879.147523609074;5898.528117750569;5852.063669812831;5924.289085309769;5938.079597662369;5962.04607262838;5986.191864098357;5684.204211410406;5766.250387449647;5805.73874175661;5836.153757705109;5875.588708790365;5759.68321742304;5788.131780232957;5818.5636077294375;5850.795222167204;5870.236869206976;5755.827325180251;5817.098349755753;5831.708414579297;5834.679092649945;5878.647281163144;6201.627902325875;6333.7466501339895;6336.873262534769;6344.302126766052;6411.422971932502;6666.766663166814;6703.832404189886;6719.93280067198;6726.966365168192;6740.730370785162;6812.965935170292;6889.414399776025;6945.617991010492;6948.583085014915;6967.860642787166;6030.427109424598;6081.6351018939;6199.628022318675;6360.650164240965;6379.457746091588;6955.721771129098;6967.721291148398;6969.756058537927;7020.087388639444;7052.682629281695;6623.271440141581;6633.369829866155;6642.937130059264;6710.295418981034;6724.4284235840505;6632.635205063768;6742.898856517156;6774.220964589037;6855.622940738208;6858.862822743517;6757.729690812411;6785;6816.7614133505085;6847.726090956406;6850.417714494224;6794.45644348451;6799.11611490503;6874.2094659113845;6891.689873955584;6893.517453778188;5249.42256351801;5295.12630415977;5303.575713942875;5382.67703937765;5385.973070134624;4548.1813273610405;4553.385292985471;4619.676622636451;4715.7877895494785;4745.572898439157;5732.0255556555485;5794.783095549982;5812.79655212074;5818.069108942634;5819.272590926134;6664.100346453167;6725.19297684281;6750.763723269662;6837.247902730695;6842.418394436529;5658.321001479767;5712.971435142881;5769.394213607595;5783.739731712083;5797.91303130445;5831.766729330864;5854.590178687451;5873.471387575053;5884.941150588525;5895;6531.542792004514;6557.442617377481;6606.372394622503;6612.0412540181405;6652;6714.026466162477;6773.796786096425;6777.89833152513;6794.3545363190415;6883.586984780929;6515.804525864231;6565.901511477427;6574;6596.208454985433;6604.207495100619;6674.933250667431;6681.164854393201;6695.0292207628645;6762.019507171334;6789.966050169717;6695.363940425652;6795.694193761392;6797.898031529432;6807.489438292247;6819.113515242987;6524.249711283073;6546.607203567801;6623.966880165761;6632.336766323329;6646.966765166143;6559.836004099936;6605.471562275103;6642.43539299165;6645.102911106938;6656.567323123982;6487.837804054936;6504.38208370204;6514.54398192122;6573.868522629617;6589.17635295588;6385;6592.868142637025;6617.503687223381;6716.966415167893;6722.260551339251;6390.137331460193;6396.616203027833;6397.648129352744;6421.036844473367;6443.194600674916 03:16:17 INFO - PID 28834 | |1;ext.html;847.9364047696423;871.3943809052707;881.7222574888909;884.0364003236471;885.0529932971718;39222.60777392225;42613.36079958803;42803.57196428031;42900.14199716004;42922;39181.41227881584;39545;39554.20891582167;39670.206595868134;39683.40474892872;7046.330598593126;7156.17703964043;7508.962455187717;7679.654415551314;7699.807504812368;7462.664180111881;7566.508176968479;7570.962145189266;7572.545647261154;7573.772786816405;7570.507916985406;7617.657205425741;7621.1235707893475;7621.161672216052;7635.083789945214;7550.282723141293;7600;7600.049993750808;7600.125985511626;7603.733869314575;7572.318491335751;7619.199984001655;7619.428542859252;7625.084989801204;7627.847443051108;32886.6711332886;33018.17454563655;33286.33427331464;33424.83287583546;33430;3563.3407819553468;3596.856125754967;3597.0647631615707;3599.892003239907;3600.6039335673054;31531.527027094613;31596.684033159603;31614.209644759067;31621.20946976321;31644.208894777585;5015.749212539358;5191.273221748958;5236;5253.86865328366;5275.630705850592;188534;189048;189050;189505.99999999863;190117;42241.78879105646;43184.784076080046;48557.27164092541;48591.75704121528;48683.026339473014;52201.2169817453;52666.73666631642;52764.20853687198;52792.472075278754;52890.73554632202;15552.144632045347;15651.765223521656;15689.058656480647;15690.450834220748;15697.921510392604;12663;12690.682732931751;12723.55467558631;12728.363581820871;12740.936295318465;13582.86417135816;13799.793003104962;13898.930505347409;13916.165030098227;13941.163530188222;5661.547076233891;5690;5753.223314852525;5773.364929857712;5854.443827836349;1000.4297550396204;1008.7730260691286;1028.3469996552094;1028.7325295423095;1038.8597539332093;22615.519180307383;22883.199088031837;23008.19471318496;23236.883815580815;23286;1108.2242430298822;1123.690984979121;1124.9550017999188;1127.3517727306833;1131.6774719204986;11945.086474854435;12184.268943863397;12215.206011609216;12338.75322493563;12354.196977196454;225242;225425;225949;226139;226360;50439.49560504421;50602.240966385536;50795.492045079074;50861.49138508642;50862;1404.908680935736;1456.2500312339155;1458.9568458552187;1465.9853401465848;1468.5741135070923;22142.44342806916;22262.888685556467;22281.220157294418;22417.215397461012;22833.657495137253;37602.811985939894;37630;37708.43437348497;37760.81119594385;37816.43275350817;186052.06973965044;186434;186755;187068;187288.06355968132;33133;35603.287934241685;35839.64160358363;36136.63863361333;36199;46468.7676561615;46711.29933051075;46763.53236467592;46815.531844681114;46931.53068469408;33282.500762489064;33349.83325083359;33488.16279593029;33570.832145839115;33951;32719;32768;32883.50674739929;33036;33749.325013500085;37630.43554346632;37664.246715066096;37965.43051854169;38006.049848754;38150.23699526049;32542.674573253964;32668.67331326656;32701.509477357384;33068.66931330656;33191;23855.926483307947;23999.76000240045;24250.636240456053;24571.50856982886;24724.13465528698 03:16:17 INFO - PID 28834 | |2;jquery.html;549.8735290883096;576.8961586914354;578.2482772395886;580.2862479150645;603.1856993059371;21672.89163554182;22653.886730566344;22654;22683.31950041497;22695.432614184614;23749.881250593724;24348.147814826483;24732.75267247327;24978.25065248041;25208.621870671956;6446.677666116699;6588.703508342112;6589.20929488462;6720.059191713164;6733.966330168342;6419.26178489475;6565.015247712858;6684.4986626003;6697.866042679144;6706.530542862001;6643;6652.101966234569;6652.567583107107;6653.101831252768;6653.135092437977;6411.647359395231;6653.2681405045405;6655.500837437212;6662.83342916431;6669.133012708341;6139.140520327158;6166.383361663798;6167.506599472032;6167.568270221086;6167.691615419211;29326;29812.40375192484;29921.850390748124;29930.85034574835;29952.550711739343;2079.074811708775;2107.9156833726634;2110.3246960972497;2110.725605671253;2111.5037966077957;19406.805931940642;19632.411027669194;19935.202591896308;20099.89950050255;20177.29379471726;2263.321003698884;2313.2944451942153;2322.5354929014266;2407.7231118421255;2458.6557881896547;118720;124554;132874.33562832125;133447;137712.999999999;14650.487232946796;14783.408663653549;14809.92595037018;14974.595244149934;15151.393944242327;22982.655260171112;22985.310440686808;22992.88503557505;22996.08015679354;23005.539889202122;10331.380117192992;10426.322289051188;10466.267361284637;10514.158867290598;10535.683929482127;9789.902100979041;9796.706098817047;9826.80346393068;9854.556544955494;9974.152197063331;8945.73162805117;8989.280857531381;8994.595243214071;9045.276377889753;9241.445513269091;2423.333583264581;2429.4169399344382;2432.1609044879488;2523.735007824189;2560.8719564021726;935.1910597333393;961.1829944547219;964.0937518732369;974.356924429887;981.0366120871598;19032.42902712921;19104.33134840302;19233.326833561037;19287.132079056475;19446.416607501797;1011.7672935224939;1013.9746506337401;1014.9137323327452;1020.3673722292226;1022.2384323678907;10554.366737995744;10660.413677247825;10728.356298622108;10876.945615271872;10912.727181820517;443143;445682;449564;462187;462668;104553.47723261335;105813;105826;107675.46162269138;108337.45831270951;1042.8435734639713;1089.6894385100209;1130.813415786386;1144.3464194239411;1191.5710344276054;20596;20634.793652063887;20841.37475875726;20889;20955.685664714736;53610;54607.180892285854;54812;55459.445405545426;55660.443395565526;72028.63985680038;72251.63874180596;72750.63624681842;72787.27212728017;73575.63212183905;14032.859671403156;14104.153750774987;14279.64300892486;14327.57017289483;14340.641483962985;22453.438664032878;22707.886460568254;22970.96630651591;23031.309060728207;23081.076756929535;17442.82557174412;17480.650386991936;17678.204480798137;17703.291868325123;17705.645887082443;15772.842271577138;16131.919340403223;16368.345266189219;16633;16697.415590454275;17036.829631703524;17214.827851721824;17218;17304.048277344868;17591.384301549384;13833.930830345784;13840.723185536031;13905.304734763424;13934.721305573628;13942.860571394562;16919.66160676755;17205.655886882443;17234.65530689404;17380;17380.82619173792 03:16:17 INFO - PID 28834 | |3;mootools.html;1356.5862411964351;1449.22466480433;1451.8693317601414;1455.8107446032013;1457.2567990324944;14745.926270368647;15336.616584585377;15349.079055256678;15373.615659608515;15373.92313038436;15011.924940375282;15016.174110423923;15066.84933150668;15082;15082;2751.1883994221653;2780.986095069527;2814.957775633357;2823.774098072149;2831.8725657345367;2711.30861630284;2761.9171424857186;2777.5555911054234;2780.152053623644;2790.2745286225627;2640.194740604115;2825;2828.179827849921;2829.122971878714;2835.4045650413436;2808.9016884409048;2826.2510434734604;2833.2208642623236;2850.8432036238;2872.928176795576;2615.8299710518945;2736.945261094787;2836.290927268183;2837.8297302161936;2838.0918106206022;15095.622609434742;15122.168280744554;15130.167840768754;15207.391704331814;15257.237138143048;8046.436749427542;8393.16068393162;8396.034456037572;8396.118407567239;8405.873911891327;5461.290032295816;5478.945210547883;5613.129964855413;5615.719214039282;5663.348714897757;1849.7687789026372;1881.5672395349009;1892.9053547322578;1910.503269150017;1928.807119288074;26112.216633501026;26134.34664133393;26268.474630507284;26334.6049809253;26349.73650263492;6624.536282460182;6704.363085506869;6781.11845460087;6966.512344135862;6991.405730512964;17254.309827606754;17392.47822565325;17471.301147954193;17504.03727794958;17505.824941750674;7891.171427000198;8143;8165.550894700729;8187.38594605407;8190.836183276301;7343.339099480965;7412.925870741224;7482.775516734507;7498.362639175732;7507.436942229355;5232.39827419844;5339.652922560099;5358.196270559447;5358.464153584689;5398.460153984649;1507.5402002389376;1518.825335086457;1524.885633577486;1527.3127092808058;1529.3041666041925;871.538084815049;892.9553522323857;900.5722281916169;900.8558630619069;903.6069309850236;7188.388986936065;7413.440733948691;7423.665935032828;7508.2867127622785;7524.2851929066655;722.8373615936372;724.8550289942033;734.097060615446;736.8820988641792;744.4825846037061;4568.17772800899;4576.839810606612;4672;4808.206645903387;5309.177077552986;20422;20606.690899636516;21486.677699834516;21683.132674692835;21772.564548709255;21574.89212553927;21908;21912.780872191393;22115;22150.003249853795;10984.395858227874;11346.716332091599;11385.544578216945;11413.657590272305;11547.133964952662;7673.117591476828;7741.225877412439;7782.494137881246;7807.570583617956;7883.369330453435;17082.91458542749;17315.307387704856;17351.56621084483;17375.56561085983;17657.29370825204;18127.81872181261;18152.818471815113;18242;18261.726074109163;18559.907200463913;10610.89389106099;10662.73343166396;10711.732206694895;10740.83888741654;10765.30025548337;13202.273874936971;13280.335983200608;13283.800742989057;13297.069205155933;13311.26788026629;10443.477826108512;10568.365898046142;10603.628872989408;10626.574937002433;10775;10455.268131230741;10597.89402105969;10619.628313009007;10641.255112142077;10868.347899126078;9346.252299816135;9436.150746432853;9528.571214295234;9541.188998935168;9563.282753793354;6113.786017489367;6161.815145545641;6175.752969881334;6179.474744646755;6272.905906411499;6773.966130169318;6826.795196143925;6837.726490940506;6890.104286442931;6901.792946211622 03:16:17 INFO - PID 28834 | |4;prototype.html;498.2252597211335;501.5285631506384;503.7154007985488;509.4065413792931;519.9064168449678;6201.2868520120255;6330.968345158273;6396.232452105748;6398.424141827235;6409.903851442232;5915.704214789265;6092.603980741249;6092.878142437148;6156.521565315594;6191.0188739603345;4930.235813448903;4980.302757613937;4995.750212489361;5012.721755952227;5032.069067222557;4740.881477963044;4929.4824043475455;4955.281484184791;5029.3964724232965;5044;4826.589739872115;4917.926231106536;4954.851354459354;4990.126727822635;4999.575036121916;4915.901681966358;4930.260460930871;4961.603071754287;4961.982793527318;5029.597632189416;4425.491068527096;4463.575960283768;4468.486124095738;4468.687191896569;4510.188166130095;6164.568480206387;6184.608463095812;6192.535559833031;6247.812565623039;6267.749290028393;5593.440655934414;5596.188552659842;5616.831495055155;5725.541956643458;5732.770689172428;6421.876171669939;6514.283428822826;6553.541252112354;6566.179227596551;6576.572522786004;4783.95216047842;4794.37673102498;4811.182099043136;4835.05716385305;4840.75796210188;6857.691403886837;6899;6930.049871573206;6948.096747422853;6950.374466298057;4880.511948805091;4929.3345398371475;4930.5069493050405;4947.208446648519;4981.758208806052;5012.8496145115705;5030.849074527697;5038.2190760432195;5039.143345631178;5073.289739436482;5681.715914204273;5699.145128230799;5704.857378565569;5727.856803579861;5749;6582.2936600330995;6597.8350541235895;6601.240857301375;6619.172603424572;6627.701753421107;1669.6744134893822;1677.563833403324;1715.3567412220418;1724.3016578285815;1753.7720096387388;1199.898008669273;1223.6818427208989;1226.6626677663714;1243.7885559454915;1243.7947738623207;5721.140629295495;5739.339975902742;5741.1388291756575;5770.105633626795;5773.336066352339;6606.438452731475;6713.932860671331;6723.966380168165;6800.251972283045;6811.386975172259;5698.52390042074;5717.742701578356;5770.855728606818;5794.275715535558;5816.156657284755;3544;3553.431450967833;3564.7861128332383;3569.4110471772387;3578.481120237551;6425.421712045938;6485.837854053592;6495.805125846232;6538.444232240217;6560.311167327457;6878.55289406197;6910.689018994158;6938.722451101899;6950.721971121098;7023.367896889203;6341.904871426932;6439.291677915426;6449;6461.381626289199;6569.967150164219;6654.334566543501;6677.532572719863;6725.49558783103;6755.763548275787;6815.045893574805;6663.733450661919;6685.69914353865;6692.5315227935525;6749.190097188369;6796.456283497408;6392.264889537577;6506.3818937200895;6523.478121750343;6538.411542961157;6580.177477815273;4929.704217746947;4962.3052772611145;4984.42679091909;5009.5491405773655;5011.273365362075;6738.494612903954;6797.5581587196675;6814.693338799667;6858.759943401957;6864.931350686429;6517.674116294261;6599.571027883172;6621.602703837785;6630.336966303331;6631.403173714196;6297.622142671271;6386.552941294065;6436.613803171825;6451.4516266116025;6544.54188206821;6335.976654824128;6383.32975037633;6436.806895793134;6501.219853617407;6521.934780652133;6494.7077381517;6555.901661474986;6669.633170175687;6676.866462670622;6688.531802773759;6328.968355158195;6330.303666596763;6335.954567496311;6341.080543321101;6378.33027532121 03:16:17 INFO - PID 28834 | |5;yui.html;883.8686481303934;896.4307664632959;924.3252425729213;926.8563372677233;941.3269512298707;19330.32343867965;20453.590928181427;20531.794682053194;20551.280705175286;20552.89723551382;18492.815071849276;18782.81217187828;18956.146973386196;19016.714749278774;19196.904015479937;950.6910254167406;963.3786207895903;966.0918736387808;966.6520052780993;966.6809952715622;945.4091193004373;980.2696990741872;986.7878406142678;987.9802403951917;989.5101924547323;1019.5157300282343;1024.774549599087;1025.461632642861;1025.7179275699204;1025.830737928241;984.4733067808688;1007.2143727892219;1014.0113389445305;1014.2798612984716;1015.94920253987;737.5943231222859;738.1068906622993;738.8596166728358;739.0244876762675;740.326303064209;20401.285954991654;20551.075201615964;20587.794122058887;20641.8967905161;20642.380728578166;21325.466863328387;21611.67582486264;22209.666854997187;22237.777622223733;22360.32919012432;16490.83509164917;16592.502224933272;16887.66224675512;16996.575085622833;17007;3362.041818081859;3382.2897191589796;3382.3404436134965;3383.2387712764676;3391.3556424279554;138610;140703.57283863053;141175;141865.29067354702;145044;14783.556493305217;14937.775933361008;14957;15001.399944002336;15022.624434389008;29205.561916571267;29581.408371832873;29592.408151836844;29922.102336929926;30128.69871301259;8136.0643525995265;8249.422540422112;8257.256846883809;8257.669693212325;8261.091279959199;4075.3479443289525;4099.549049604541;4169.082801783603;4180.602842729936;4185.455890734185;4974.502549745069;5057.620678449131;5081.390233172043;5081.695098294114;5083.72039537829;976.7411635916487;992.4442312305132;1008.6016023670609;1011.438651548383;1012.6810054832704;682.6586706646676;697.4106879686657;697.6825544377297;702.9402500787388;713.2225873797482;11154.888451115547;11267.380294083903;11568.132390070778;11590.014848737952;11624.476898539586;665.3579295979306;665.5274754923961;671.2951401028901;675.3280485916447;684.1038239905739;4979.601631869442;5004.699718016931;5107.131787596118;5145.588352931756;5193.766280517386;119287.40356298164;119406;122408.38795805964;123328.38335808263;124496;104099;108871.45564272128;109763;114141;114308.42845785718;94919;95302.5234873835;99036;100398.4980075095;100893;9569.330146889652;9831.9016809831;9860.816701995807;9866.062724041205;9956.900430995887;44482.777586111864;44597.331040035075;44678;45044.54955450403;45492;57324.42675573191;57634.423655762905;58205;58394.708026461296;59354;14830.777538336717;14858.702825943205;14994.100353978796;15004.324805384002;15069.698606028038;16021.359145634044;16064.116473594064;16235;16332.510024699279;16340.591485212964;14117.2941352934;14249.287535623385;14292.21392823363;14301.856981430052;14465.204413757345;14400;14481.203533805741;14502.709945801236;14635.268236588341;14639.92680036593;12563.18339307942;12759.48962041508;12965.740685186054;13004.674883127998;13019.218846869218;11320.433978300887;11371.943140284246;11505.137114716263;11531.481083351102;11566.462249322589;12147.331896745764;12296.569620063256;12359.69100772488;12375.504979800708;12419.542574040699 03:16:17 INFO - PID 28834 | __end_tp_report 03:16:17 INFO - PID 28834 | __start_cc_report 03:16:17 INFO - PID 28834 | _x_x_mozilla_cycle_collect,380 03:16:17 INFO - PID 28834 | __end_cc_report 03:16:17 INFO - PID 28834 | __startTimestamp1504865777508__endTimestamp 03:16:17 INFO - PID 28834 | 03:16:17 INFO - PID 28834 | ------- Summary: start ------- 03:16:17 INFO - PID 28834 | Number of tests: 6 03:16:17 INFO - PID 28834 | 03:16:17 INFO - PID 28834 | [#0] dojo.html Cycles:165 Average:6229.09 Median:6504.38 stddev:759.65 (11.7%) stddev-sans-first:720.96 03:16:17 INFO - PID 28834 | Values: 3090.1 3106.5 3117.7 3145.0 3149.0 6113.8 6318.8 6326.2 6328.4 6344.6 6254.7 6307.7 6349.5 6384.6 6414.0 5688.3 5836.0 5861.3 5879.1 5898.5 5852.1 5924.3 5938.1 5962.0 5986.2 5684.2 5766.3 5805.7 5836.2 5875.6 5759.7 5788.1 5818.6 5850.8 5870.2 5755.8 5817.1 5831.7 5834.7 5878.6 6201.6 6333.7 6336.9 6344.3 6411.4 6666.8 6703.8 6719.9 6727.0 6740.7 6813.0 6889.4 6945.6 6948.6 6967.9 6030.4 6081.6 6199.6 6360.7 6379.5 6955.7 6967.7 6969.8 7020.1 7052.7 6623.3 6633.4 6642.9 6710.3 6724.4 6632.6 6742.9 6774.2 6855.6 6858.9 6757.7 6785.0 6816.8 6847.7 6850.4 6794.5 6799.1 6874.2 6891.7 6893.5 5249.4 5295.1 5303.6 5382.7 5386.0 4548.2 4553.4 4619.7 4715.8 4745.6 5732.0 5794.8 5812.8 5818.1 5819.3 6664.1 6725.2 6750.8 6837.2 6842.4 5658.3 5713.0 5769.4 5783.7 5797.9 5831.8 5854.6 5873.5 5884.9 5895.0 6531.5 6557.4 6606.4 6612.0 6652.0 6714.0 6773.8 6777.9 6794.4 6883.6 6515.8 6565.9 6574.0 6596.2 6604.2 6674.9 6681.2 6695.0 6762.0 6790.0 6695.4 6795.7 6797.9 6807.5 6819.1 6524.2 6546.6 6624.0 6632.3 6647.0 6559.8 6605.5 6642.4 6645.1 6656.6 6487.8 6504.4 6514.5 6573.9 6589.2 6385.0 6592.9 6617.5 6717.0 6722.3 6390.1 6396.6 6397.6 6421.0 6443.2 03:16:17 INFO - PID 28834 | 03:16:17 INFO - PID 28834 | [#1] ext.html Cycles:180 Average:37105.90 Median:34777.14 stddev:52149.29 (150.0%) stddev-sans-first:52224.51 03:16:17 INFO - PID 28834 | Values: 847.9 871.4 881.7 884.0 885.1 39222.6 42613.4 42803.6 42900.1 42922.0 39181.4 39545.0 39554.2 39670.2 39683.4 7046.3 7156.2 7509.0 7679.7 7699.8 7462.7 7566.5 7571.0 7572.5 7573.8 7570.5 7617.7 7621.1 7621.2 7635.1 7550.3 7600.0 7600.0 7600.1 7603.7 7572.3 7619.2 7619.4 7625.1 7627.8 32886.7 33018.2 33286.3 33424.8 33430.0 3563.3 3596.9 3597.1 3599.9 3600.6 31531.5 31596.7 31614.2 31621.2 31644.2 5015.7 5191.3 5236.0 5253.9 5275.6 188534.0 189048.0 189050.0 189506.0 190117.0 42241.8 43184.8 48557.3 48591.8 48683.0 52201.2 52666.7 52764.2 52792.5 52890.7 15552.1 15651.8 15689.1 15690.5 15697.9 12663.0 12690.7 12723.6 12728.4 12740.9 13582.9 13799.8 13898.9 13916.2 13941.2 5661.5 5690.0 5753.2 5773.4 5854.4 1000.4 1008.8 1028.3 1028.7 1038.9 22615.5 22883.2 23008.2 23236.9 23286.0 1108.2 1123.7 1125.0 1127.4 1131.7 11945.1 12184.3 12215.2 12338.8 12354.2 225242.0 225425.0 225949.0 226139.0 226360.0 50439.5 50602.2 50795.5 50861.5 50862.0 1404.9 1456.3 1459.0 1466.0 1468.6 22142.4 22262.9 22281.2 22417.2 22833.7 37602.8 37630.0 37708.4 37760.8 37816.4 186052.1 186434.0 186755.0 187068.0 187288.1 33133.0 35603.3 35839.6 36136.6 36199.0 46468.8 46711.3 46763.5 46815.5 46931.5 33282.5 33349.8 33488.2 33570.8 33951.0 32719.0 32768.0 32883.5 33036.0 33749.3 37630.4 37664.2 37965.4 38006.0 38150.2 32542.7 32668.7 32701.5 33068.7 33191.0 23855.9 23999.8 24250.6 24571.5 24724.1 03:16:17 INFO - PID 28834 | 03:16:17 INFO - PID 28834 | [#2] jquery.html Cycles:180 Average:33149.37 Median:22689.38 stddev:76314.63 (336.3%) stddev-sans-first:76489.46 03:16:17 INFO - PID 28834 | Values: 549.9 576.9 578.2 580.3 603.2 21672.9 22653.9 22654.0 22683.3 22695.4 23749.9 24348.1 24732.8 24978.3 25208.6 6446.7 6588.7 6589.2 6720.1 6734.0 6419.3 6565.0 6684.5 6697.9 6706.5 6643.0 6652.1 6652.6 6653.1 6653.1 6411.6 6653.3 6655.5 6662.8 6669.1 6139.1 6166.4 6167.5 6167.6 6167.7 29326.0 29812.4 29921.9 29930.9 29952.6 2079.1 2107.9 2110.3 2110.7 2111.5 19406.8 19632.4 19935.2 20099.9 20177.3 2263.3 2313.3 2322.5 2407.7 2458.7 118720.0 124554.0 132874.3 133447.0 137713.0 14650.5 14783.4 14809.9 14974.6 15151.4 22982.7 22985.3 22992.9 22996.1 23005.5 10331.4 10426.3 10466.3 10514.2 10535.7 9789.9 9796.7 9826.8 9854.6 9974.2 8945.7 8989.3 8994.6 9045.3 9241.4 2423.3 2429.4 2432.2 2523.7 2560.9 935.2 961.2 964.1 974.4 981.0 19032.4 19104.3 19233.3 19287.1 19446.4 1011.8 1014.0 1014.9 1020.4 1022.2 10554.4 10660.4 10728.4 10876.9 10912.7 443143.0 445682.0 449564.0 462187.0 462668.0 104553.5 105813.0 105826.0 107675.5 108337.5 1042.8 1089.7 1130.8 1144.3 1191.6 20596.0 20634.8 20841.4 20889.0 20955.7 53610.0 54607.2 54812.0 55459.4 55660.4 72028.6 72251.6 72750.6 72787.3 73575.6 14032.9 14104.2 14279.6 14327.6 14340.6 22453.4 22707.9 22971.0 23031.3 23081.1 17442.8 17480.7 17678.2 17703.3 17705.6 15772.8 16131.9 16368.3 16633.0 16697.4 17036.8 17214.8 17218.0 17304.0 17591.4 13833.9 13840.7 13905.3 13934.7 13942.9 16919.7 17205.7 17234.7 17380.0 17380.8 03:16:17 INFO - PID 28834 | 03:16:17 INFO - PID 28834 | [#3] mootools.html Cycles:180 Average:9137.62 Median:2769.74 stddev:6566.96 (237.1%) stddev-sans-first:6559.36 03:16:17 INFO - PID 28834 | Values: 1356.6 1449.2 1451.9 1455.8 1457.3 14745.9 15336.6 15349.1 15373.6 15373.9 15011.9 15016.2 15066.8 15082.0 15082.0 2751.2 2781.0 2815.0 2823.8 2831.9 2711.3 2761.9 2777.6 2780.2 2790.3 2640.2 2825.0 2828.2 2829.1 2835.4 2808.9 2826.3 2833.2 2850.8 2872.9 2615.8 2736.9 2836.3 2837.8 2838.1 15095.6 15122.2 15130.2 15207.4 15257.2 8046.4 8393.2 8396.0 8396.1 8405.9 5461.3 5478.9 5613.1 5615.7 5663.3 1849.8 1881.6 1892.9 1910.5 1928.8 26112.2 26134.3 26268.5 26334.6 26349.7 6624.5 6704.4 6781.1 6966.5 6991.4 17254.3 17392.5 17471.3 17504.0 17505.8 7891.2 8143.0 8165.6 8187.4 8190.8 7343.3 7412.9 7482.8 7498.4 7507.4 5232.4 5339.7 5358.2 5358.5 5398.5 1507.5 1518.8 1524.9 1527.3 1529.3 871.5 893.0 900.6 900.9 903.6 7188.4 7413.4 7423.7 7508.3 7524.3 722.8 724.9 734.1 736.9 744.5 4568.2 4576.8 4672.0 4808.2 5309.2 20422.0 20606.7 21486.7 21683.1 21772.6 21574.9 21908.0 21912.8 22115.0 22150.0 10984.4 11346.7 11385.5 11413.7 11547.1 7673.1 7741.2 7782.5 7807.6 7883.4 17082.9 17315.3 17351.6 17375.6 17657.3 18127.8 18152.8 18242.0 18261.7 18559.9 10610.9 10662.7 10711.7 10740.8 10765.3 13202.3 13280.3 13283.8 13297.1 13311.3 10443.5 10568.4 10603.6 10626.6 10775.0 10455.3 10597.9 10619.6 10641.3 10868.3 9346.3 9436.2 9528.6 9541.2 9563.3 6113.8 6161.8 6175.8 6179.5 6272.9 6774.0 6826.8 6837.7 6890.1 6901.8 03:16:17 INFO - PID 28834 | 03:16:17 INFO - PID 28834 | [#4] prototype.html Cycles:180 Average:5512.41 Median:6187.81 stddev:1559.97 (25.2%) stddev-sans-first:1518.27 03:16:17 INFO - PID 28834 | Values: 498.2 501.5 503.7 509.4 519.9 6201.3 6331.0 6396.2 6398.4 6409.9 5915.7 6092.6 6092.9 6156.5 6191.0 4930.2 4980.3 4995.8 5012.7 5032.1 4740.9 4929.5 4955.3 5029.4 5044.0 4826.6 4917.9 4954.9 4990.1 4999.6 4915.9 4930.3 4961.6 4962.0 5029.6 4425.5 4463.6 4468.5 4468.7 4510.2 6164.6 6184.6 6192.5 6247.8 6267.7 5593.4 5596.2 5616.8 5725.5 5732.8 6421.9 6514.3 6553.5 6566.2 6576.6 4784.0 4794.4 4811.2 4835.1 4840.8 6857.7 6899.0 6930.0 6948.1 6950.4 4880.5 4929.3 4930.5 4947.2 4981.8 5012.8 5030.8 5038.2 5039.1 5073.3 5681.7 5699.1 5704.9 5727.9 5749.0 6582.3 6597.8 6601.2 6619.2 6627.7 1669.7 1677.6 1715.4 1724.3 1753.8 1199.9 1223.7 1226.7 1243.8 1243.8 5721.1 5739.3 5741.1 5770.1 5773.3 6606.4 6713.9 6724.0 6800.3 6811.4 5698.5 5717.7 5770.9 5794.3 5816.2 3544.0 3553.4 3564.8 3569.4 3578.5 6425.4 6485.8 6495.8 6538.4 6560.3 6878.6 6910.7 6938.7 6950.7 7023.4 6341.9 6439.3 6449.0 6461.4 6570.0 6654.3 6677.5 6725.5 6755.8 6815.0 6663.7 6685.7 6692.5 6749.2 6796.5 6392.3 6506.4 6523.5 6538.4 6580.2 4929.7 4962.3 4984.4 5009.5 5011.3 6738.5 6797.6 6814.7 6858.8 6864.9 6517.7 6599.6 6621.6 6630.3 6631.4 6297.6 6386.6 6436.6 6451.5 6544.5 6336.0 6383.3 6436.8 6501.2 6521.9 6494.7 6555.9 6669.6 6676.9 6688.5 6329.0 6330.3 6336.0 6341.1 6378.3 03:16:17 INFO - PID 28834 | 03:16:17 INFO - PID 28834 | [#5] yui.html Cycles:180 Average:24153.36 Median:20570.35 stddev:35784.81 (174.0%) stddev-sans-first:35842.54 03:16:17 INFO - PID 28834 | Values: 883.9 896.4 924.3 926.9 941.3 19330.3 20453.6 20531.8 20551.3 20552.9 18492.8 18782.8 18956.1 19016.7 19196.9 950.7 963.4 966.1 966.7 966.7 945.4 980.3 986.8 988.0 989.5 1019.5 1024.8 1025.5 1025.7 1025.8 984.5 1007.2 1014.0 1014.3 1015.9 737.6 738.1 738.9 739.0 740.3 20401.3 20551.1 20587.8 20641.9 20642.4 21325.5 21611.7 22209.7 22237.8 22360.3 16490.8 16592.5 16887.7 16996.6 17007.0 3362.0 3382.3 3382.3 3383.2 3391.4 138610.0 140703.6 141175.0 141865.3 145044.0 14783.6 14937.8 14957.0 15001.4 15022.6 29205.6 29581.4 29592.4 29922.1 30128.7 8136.1 8249.4 8257.3 8257.7 8261.1 4075.3 4099.5 4169.1 4180.6 4185.5 4974.5 5057.6 5081.4 5081.7 5083.7 976.7 992.4 1008.6 1011.4 1012.7 682.7 697.4 697.7 702.9 713.2 11154.9 11267.4 11568.1 11590.0 11624.5 665.4 665.5 671.3 675.3 684.1 4979.6 5004.7 5107.1 5145.6 5193.8 119287.4 119406.0 122408.4 123328.4 124496.0 104099.0 108871.5 109763.0 114141.0 114308.4 94919.0 95302.5 99036.0 100398.5 100893.0 9569.3 9831.9 9860.8 9866.1 9956.9 44482.8 44597.3 44678.0 45044.5 45492.0 57324.4 57634.4 58205.0 58394.7 59354.0 14830.8 14858.7 14994.1 15004.3 15069.7 16021.4 16064.1 16235.0 16332.5 16340.6 14117.3 14249.3 14292.2 14301.9 14465.2 14400.0 14481.2 14502.7 14635.3 14639.9 12563.2 12759.5 12965.7 13004.7 13019.2 11320.4 11371.9 11505.1 11531.5 11566.5 12147.3 12296.6 12359.7 12375.5 12419.5 03:16:17 INFO - PID 28834 | -------- Summary: end -------- 03:16:17 INFO - PID 28834 | 03:16:18 INFO - TEST-INFO | 28834: exit 0 03:16:18 INFO - TEST-OK | dromaeo_css | took 1108724ms 03:16:18 INFO - TEST-START | kraken 03:16:18 INFO - Initialising browser for kraken test... 03:16:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52574/getInfo.html -profile /tmp/tmpt_wkhq/profile 03:16:18 INFO - TEST-INFO | started process 29202 (/builds/slave/test/build/application/firefox/firefox http://localhost:52574/getInfo.html) 03:16:23 INFO - TEST-INFO | 29202: exit 0 03:16:23 INFO - Browser initialized. 03:16:23 INFO - Running cycle 1/1 for kraken test... 03:16:23 INFO - Using env: {'DISPLAY': ':0', 03:16:23 INFO - 'HOME': '/home/cltbld', 03:16:23 INFO - 'JSGC_DISABLE_POISONING': '1', 03:16:23 INFO - 'LANG': 'en_US.UTF-8', 03:16:23 INFO - 'LANGUAGE': 'en_US:en', 03:16:23 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:16:23 INFO - 'LOGNAME': 'cltbld', 03:16:23 INFO - 'MAIL': '/var/mail/cltbld', 03:16:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:16:23 INFO - 'MOZ_CRASHREPORTER': '1', 03:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:23 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:16:23 INFO - 'MOZ_NO_REMOTE': '1', 03:16:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:23 INFO - 'NO_EM_RESTART': '1', 03:16:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:23 INFO - 'PWD': '/builds/slave/test', 03:16:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:23 INFO - 'RUST_BACKTRACE': 'full', 03:16:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:16:23 INFO - 'SHELL': '/bin/bash', 03:16:23 INFO - 'SHLVL': '1', 03:16:23 INFO - 'STYLO_FORCE_ENABLED': '1', 03:16:23 INFO - 'STYLO_THREADS': '1', 03:16:23 INFO - 'TERM': 'linux', 03:16:23 INFO - 'TMOUT': '86400', 03:16:23 INFO - 'USER': 'cltbld', 03:16:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357', 03:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:23 INFO - '_': '/tools/buildbot/bin/python'} 03:16:23 INFO - TEST-INFO | started process 29384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt_wkhq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:24 INFO - PID 29384 | 03:16:24 INFO - PID 29384 | (/builds/slave/test/build/application/firefox/firefox:29435): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:16:24 INFO - PID 29384 | 03:16:34 INFO - PID 29384 | RSS: Main: 172163072 03:16:34 INFO - PID 29384 | 03:16:37 INFO - PID 29384 | Cycle 1(1): loaded http://localhost:52574/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52574/tests/kraken/driver.html?testName=audio-beat-detection) 03:16:38 INFO - PID 29384 | RSS: Main: 178417664 03:16:38 INFO - PID 29384 | 03:16:40 INFO - PID 29384 | Cycle 1(1): loaded http://localhost:52574/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52574/tests/kraken/driver.html?testName=audio-dft) 03:16:41 INFO - PID 29384 | RSS: Main: 179269632 03:16:41 INFO - PID 29384 | 03:16:44 INFO - PID 29384 | Cycle 1(1): loaded http://localhost:52574/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52574/tests/kraken/driver.html?testName=audio-fft) 03:16:44 INFO - PID 29384 | RSS: Main: 173350912 03:16:44 INFO - PID 29384 | 03:16:47 INFO - PID 29384 | Cycle 1(1): loaded http://localhost:52574/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52574/tests/kraken/driver.html?testName=audio-oscillator) 03:16:47 INFO - PID 29384 | RSS: Main: 174002176 03:16:47 INFO - PID 29384 | 03:16:49 INFO - PID 29384 | Cycle 1(1): loaded http://localhost:52574/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52574/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:16:50 INFO - PID 29384 | RSS: Main: 174473216 03:16:50 INFO - PID 29384 | 03:16:53 INFO - PID 29384 | Cycle 1(1): loaded http://localhost:52574/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52574/tests/kraken/driver.html?testName=imaging-darkroom) 03:16:54 INFO - PID 29384 | RSS: Main: 177287168 03:16:54 INFO - PID 29384 | 03:16:57 INFO - PID 29384 | Cycle 1(1): loaded http://localhost:52574/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52574/tests/kraken/driver.html?testName=imaging-desaturate) 03:16:58 INFO - PID 29384 | RSS: Main: 176721920 03:16:58 INFO - PID 29384 | 03:17:01 INFO - PID 29384 | Cycle 1(1): loaded http://localhost:52574/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52574/tests/kraken/driver.html?testName=json-parse-financial) 03:17:02 INFO - PID 29384 | RSS: Main: 177049600 03:17:02 INFO - PID 29384 | 03:17:03 INFO - PID 29384 | Cycle 1(1): loaded http://localhost:52574/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52574/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:17:04 INFO - PID 29384 | RSS: Main: 177020928 03:17:04 INFO - PID 29384 | 03:17:05 INFO - PID 29384 | Cycle 1(1): loaded http://localhost:52574/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52574/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:17:06 INFO - PID 29384 | RSS: Main: 177119232 03:17:06 INFO - PID 29384 | 03:17:08 INFO - PID 29384 | Cycle 1(1): loaded http://localhost:52574/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52574/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:17:09 INFO - PID 29384 | RSS: Main: 174006272 03:17:09 INFO - PID 29384 | 03:17:11 INFO - PID 29384 | Cycle 1(1): loaded http://localhost:52574/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52574/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:17:12 INFO - PID 29384 | RSS: Main: 174170112 03:17:12 INFO - PID 29384 | 03:17:15 INFO - PID 29384 | Cycle 1(1): loaded http://localhost:52574/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52574/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:17:16 INFO - PID 29384 | RSS: Main: 174309376 03:17:16 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | Cycle 1(1): loaded http://localhost:52574/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52574/tests/kraken/driver.html?testName=ai-astar) 03:17:18 INFO - PID 29384 | RSS: Main: 176283648 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | __start_tp_report 03:17:18 INFO - PID 29384 | _x_x_mozilla_page_load 03:17:18 INFO - PID 29384 | _x_x_mozilla_page_load_details 03:17:18 INFO - PID 29384 | |i|pagename|runs| 03:17:18 INFO - PID 29384 | |0;ai-astar;108;108;108;109;106;97;109;108;108;106 03:17:18 INFO - PID 29384 | |1;audio-beat-detection;119;120;118;120;115;117;117;146;119;125 03:17:18 INFO - PID 29384 | |2;audio-dft;162;162;163;163;164;171;168;174;163;167 03:17:18 INFO - PID 29384 | |3;audio-fft;77;73;73;75;75;73;74;74;73;75 03:17:18 INFO - PID 29384 | |4;audio-oscillator;80;80;80;79;79;78;79;79;79;80 03:17:18 INFO - PID 29384 | |5;imaging-gaussian-blur;113;113;115;110;114;114;114;114;114;114 03:17:18 INFO - PID 29384 | |6;imaging-darkroom;147;150;150;148;149;150;147;149;148;153 03:17:18 INFO - PID 29384 | |7;imaging-desaturate;93;94;94;95;95;94;94;94;95;94 03:17:18 INFO - PID 29384 | |8;json-parse-financial;52;51;52;50;53;53;52;52;53;51 03:17:18 INFO - PID 29384 | |9;json-stringify-tinderbox;37;38;37;38;37;37;37;37;38;38 03:17:18 INFO - PID 29384 | |10;stanford-crypto-aes;77;77;76;74;76;77;75;75;73;76 03:17:18 INFO - PID 29384 | |11;stanford-crypto-ccm;130;118;118;120;116;117;120;125;122;127 03:17:18 INFO - PID 29384 | |12;stanford-crypto-pbkdf2;179;180;171;170;180;174;184;169;174;174 03:17:18 INFO - PID 29384 | |13;stanford-crypto-sha256-iterative;71;66;63;63;64;68;67;63;63;65 03:17:18 INFO - PID 29384 | __end_tp_report 03:17:18 INFO - PID 29384 | __start_cc_report 03:17:18 INFO - PID 29384 | _x_x_mozilla_cycle_collect,977 03:17:18 INFO - PID 29384 | __end_cc_report 03:17:18 INFO - PID 29384 | __startTimestamp1504865838299__endTimestamp 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | ------- Summary: start ------- 03:17:18 INFO - PID 29384 | Number of tests: 14 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | [#0] ai-astar Cycles:10 Average:106.70 Median:108.00 stddev:3.56 (3.3%) stddev-sans-first:3.75 03:17:18 INFO - PID 29384 | Values: 108.0 108.0 108.0 109.0 106.0 97.0 109.0 108.0 108.0 106.0 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | [#1] audio-beat-detection Cycles:10 Average:121.60 Median:119.50 stddev:8.97 (7.5%) stddev-sans-first:9.47 03:17:18 INFO - PID 29384 | Values: 119.0 120.0 118.0 120.0 115.0 117.0 117.0 146.0 119.0 125.0 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | [#2] audio-dft Cycles:10 Average:165.70 Median:165.50 stddev:4.16 (2.5%) stddev-sans-first:4.20 03:17:18 INFO - PID 29384 | Values: 162.0 162.0 163.0 163.0 164.0 171.0 168.0 174.0 163.0 167.0 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | [#3] audio-fft Cycles:10 Average:74.20 Median:74.50 stddev:1.32 (1.8%) stddev-sans-first:0.93 03:17:18 INFO - PID 29384 | Values: 77.0 73.0 73.0 75.0 75.0 73.0 74.0 74.0 73.0 75.0 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:79.50 stddev:0.67 (0.8%) stddev-sans-first:0.67 03:17:18 INFO - PID 29384 | Values: 80.0 80.0 80.0 79.0 79.0 78.0 79.0 79.0 79.0 80.0 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 03:17:18 INFO - PID 29384 | Values: 113.0 113.0 115.0 110.0 114.0 114.0 114.0 114.0 114.0 114.0 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.50 stddev:1.79 (1.2%) stddev-sans-first:1.73 03:17:18 INFO - PID 29384 | Values: 147.0 150.0 150.0 148.0 149.0 150.0 147.0 149.0 148.0 153.0 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 03:17:18 INFO - PID 29384 | Values: 93.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.99 (1.9%) stddev-sans-first:1.05 03:17:18 INFO - PID 29384 | Values: 52.0 51.0 52.0 50.0 53.0 53.0 52.0 52.0 53.0 51.0 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | [#9] json-stringify-tinderbox Cycles:10 Average:37.40 Median:37.50 stddev:0.52 (1.4%) stddev-sans-first:0.53 03:17:18 INFO - PID 29384 | Values: 37.0 38.0 37.0 38.0 37.0 37.0 37.0 37.0 38.0 38.0 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:76.00 stddev:1.35 (1.8%) stddev-sans-first:1.33 03:17:18 INFO - PID 29384 | Values: 77.0 77.0 76.0 74.0 76.0 77.0 75.0 75.0 73.0 76.0 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:121.00 stddev:4.64 (3.8%) stddev-sans-first:3.71 03:17:18 INFO - PID 29384 | Values: 130.0 118.0 118.0 120.0 116.0 117.0 120.0 125.0 122.0 127.0 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:176.50 stddev:4.99 (2.8%) stddev-sans-first:5.13 03:17:18 INFO - PID 29384 | Values: 179.0 180.0 171.0 170.0 180.0 174.0 184.0 169.0 174.0 174.0 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:2.71 (4.1%) stddev-sans-first:1.94 03:17:18 INFO - PID 29384 | Values: 71.0 66.0 63.0 63.0 64.0 68.0 67.0 63.0 63.0 65.0 03:17:18 INFO - PID 29384 | -------- Summary: end -------- 03:17:18 INFO - PID 29384 | 03:17:18 INFO - PID 29384 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:17:18 INFO - TEST-INFO | 29384: exit 0 03:17:19 INFO - TEST-OK | kraken | took 60850ms 03:17:19 INFO - SUITE-END | took 1169s 03:17:19 INFO - Completed test suite (00:19:29) 03:17:19 INFO - javascript benchmark 03:17:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8419.998016230222, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.119315994942, 3106.5184896341066, 3117.6570577236484, 3144.9842750786256, 3148.9527657085146, 6113.755449782004, 6318.810435686931, 6326.240851097869, 6328.398802113803, 6344.619322840633, 6254.655993920333, 6307.747690092391, 6349.492040636749, 6384.585001974869, 6414.0, 5688.288963879515, 5836.0, 5861.325947516048, 5879.147523609074, 5898.528117750569, 5852.063669812831, 5924.289085309769, 5938.079597662369, 5962.04607262838, 5986.191864098357, 5684.204211410406, 5766.250387449647, 5805.73874175661, 5836.153757705109, 5875.588708790365, 5759.68321742304, 5788.131780232957, 5818.5636077294375, 5850.795222167204, 5870.236869206976, 5755.827325180251, 5817.098349755753, 5831.708414579297, 5834.679092649945, 5878.647281163144, 6201.627902325875, 6333.7466501339895, 6336.873262534769, 6344.302126766052, 6411.422971932502, 6666.766663166814, 6703.832404189886, 6719.93280067198, 6726.966365168192, 6740.730370785162, 6812.965935170292, 6889.414399776025, 6945.617991010492, 6948.583085014915, 6967.860642787166, 6030.427109424598, 6081.6351018939, 6199.628022318675, 6360.650164240965, 6379.457746091588, 6955.721771129098, 6967.721291148398, 6969.756058537927, 7020.087388639444, 7052.682629281695, 6623.271440141581, 6633.369829866155, 6642.937130059264, 6710.295418981034, 6724.4284235840505, 6632.635205063768, 6742.898856517156, 6774.220964589037, 6855.622940738208, 6858.862822743517, 6757.729690812411, 6785.0, 6816.7614133505085, 6847.726090956406, 6850.417714494224, 6794.45644348451, 6799.11611490503, 6874.2094659113845, 6891.689873955584, 6893.517453778188, 5249.42256351801, 5295.12630415977, 5303.575713942875, 5382.67703937765, 5385.973070134624, 4548.1813273610405, 4553.385292985471, 4619.676622636451, 4715.7877895494785, 4745.572898439157, 5732.0255556555485, 5794.783095549982, 5812.79655212074, 5818.069108942634, 5819.272590926134, 6664.100346453167, 6725.19297684281, 6750.763723269662, 6837.247902730695, 6842.418394436529, 5658.321001479767, 5712.971435142881, 5769.394213607595, 5783.739731712083, 5797.91303130445, 5831.766729330864, 5854.590178687451, 5873.471387575053, 5884.941150588525, 5895.0, 6531.542792004514, 6557.442617377481, 6606.372394622503, 6612.0412540181405, 6652.0, 6714.026466162477, 6773.796786096425, 6777.89833152513, 6794.3545363190415, 6883.586984780929, 6515.804525864231, 6565.901511477427, 6574.0, 6596.208454985433, 6604.207495100619, 6674.933250667431, 6681.164854393201, 6695.0292207628645, 6762.019507171334, 6789.966050169717, 6695.363940425652, 6795.694193761392, 6797.898031529432, 6807.489438292247, 6819.113515242987, 6524.249711283073, 6546.607203567801, 6623.966880165761, 6632.336766323329, 6646.966765166143, 6559.836004099936, 6605.471562275103, 6642.43539299165, 6645.102911106938, 6656.567323123982, 6487.837804054936, 6504.38208370204, 6514.54398192122, 6573.868522629617, 6589.17635295588, 6385.0, 6592.868142637025, 6617.503687223381, 6716.966415167893, 6722.260551339251, 6390.137331460193, 6396.616203027833, 6397.648129352744, 6421.036844473367, 6443.194600674916], "value": 6169.803551815412, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [847.9364047696423, 871.3943809052707, 881.7222574888909, 884.0364003236471, 885.0529932971718, 39222.60777392225, 42613.36079958803, 42803.57196428031, 42900.14199716004, 42922.0, 39181.41227881584, 39545.0, 39554.20891582167, 39670.206595868134, 39683.40474892872, 7046.330598593126, 7156.17703964043, 7508.962455187717, 7679.654415551314, 7699.807504812368, 7462.664180111881, 7566.508176968479, 7570.962145189266, 7572.545647261154, 7573.772786816405, 7570.507916985406, 7617.657205425741, 7621.1235707893475, 7621.161672216052, 7635.083789945214, 7550.282723141293, 7600.0, 7600.049993750808, 7600.125985511626, 7603.733869314575, 7572.318491335751, 7619.199984001655, 7619.428542859252, 7625.084989801204, 7627.847443051108, 32886.6711332886, 33018.17454563655, 33286.33427331464, 33424.83287583546, 33430.0, 3563.3407819553468, 3596.856125754967, 3597.0647631615707, 3599.892003239907, 3600.6039335673054, 31531.527027094613, 31596.684033159603, 31614.209644759067, 31621.20946976321, 31644.208894777585, 5015.749212539358, 5191.273221748958, 5236.0, 5253.86865328366, 5275.630705850592, 188534.0, 189048.0, 189050.0, 189505.99999999863, 190117.0, 42241.78879105646, 43184.784076080046, 48557.27164092541, 48591.75704121528, 48683.026339473014, 52201.2169817453, 52666.73666631642, 52764.20853687198, 52792.472075278754, 52890.73554632202, 15552.144632045347, 15651.765223521656, 15689.058656480647, 15690.450834220748, 15697.921510392604, 12663.0, 12690.682732931751, 12723.55467558631, 12728.363581820871, 12740.936295318465, 13582.86417135816, 13799.793003104962, 13898.930505347409, 13916.165030098227, 13941.163530188222, 5661.547076233891, 5690.0, 5753.223314852525, 5773.364929857712, 5854.443827836349, 1000.4297550396204, 1008.7730260691286, 1028.3469996552094, 1028.7325295423095, 1038.8597539332093, 22615.519180307383, 22883.199088031837, 23008.19471318496, 23236.883815580815, 23286.0, 1108.2242430298822, 1123.690984979121, 1124.9550017999188, 1127.3517727306833, 1131.6774719204986, 11945.086474854435, 12184.268943863397, 12215.206011609216, 12338.75322493563, 12354.196977196454, 225242.0, 225425.0, 225949.0, 226139.0, 226360.0, 50439.49560504421, 50602.240966385536, 50795.492045079074, 50861.49138508642, 50862.0, 1404.908680935736, 1456.2500312339155, 1458.9568458552187, 1465.9853401465848, 1468.5741135070923, 22142.44342806916, 22262.888685556467, 22281.220157294418, 22417.215397461012, 22833.657495137253, 37602.811985939894, 37630.0, 37708.43437348497, 37760.81119594385, 37816.43275350817, 186052.06973965044, 186434.0, 186755.0, 187068.0, 187288.06355968132, 33133.0, 35603.287934241685, 35839.64160358363, 36136.63863361333, 36199.0, 46468.7676561615, 46711.29933051075, 46763.53236467592, 46815.531844681114, 46931.53068469408, 33282.500762489064, 33349.83325083359, 33488.16279593029, 33570.832145839115, 33951.0, 32719.0, 32768.0, 32883.50674739929, 33036.0, 33749.325013500085, 37630.43554346632, 37664.246715066096, 37965.43051854169, 38006.049848754, 38150.23699526049, 32542.674573253964, 32668.67331326656, 32701.509477357384, 33068.66931330656, 33191.0, 23855.926483307947, 23999.76000240045, 24250.636240456053, 24571.50856982886, 24724.13465528698], "value": 17090.478866204794, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.8735290883096, 576.8961586914354, 578.2482772395886, 580.2862479150645, 603.1856993059371, 21672.89163554182, 22653.886730566344, 22654.0, 22683.31950041497, 22695.432614184614, 23749.881250593724, 24348.147814826483, 24732.75267247327, 24978.25065248041, 25208.621870671956, 6446.677666116699, 6588.703508342112, 6589.20929488462, 6720.059191713164, 6733.966330168342, 6419.26178489475, 6565.015247712858, 6684.4986626003, 6697.866042679144, 6706.530542862001, 6643.0, 6652.101966234569, 6652.567583107107, 6653.101831252768, 6653.135092437977, 6411.647359395231, 6653.2681405045405, 6655.500837437212, 6662.83342916431, 6669.133012708341, 6139.140520327158, 6166.383361663798, 6167.506599472032, 6167.568270221086, 6167.691615419211, 29326.0, 29812.40375192484, 29921.850390748124, 29930.85034574835, 29952.550711739343, 2079.074811708775, 2107.9156833726634, 2110.3246960972497, 2110.725605671253, 2111.5037966077957, 19406.805931940642, 19632.411027669194, 19935.202591896308, 20099.89950050255, 20177.29379471726, 2263.321003698884, 2313.2944451942153, 2322.5354929014266, 2407.7231118421255, 2458.6557881896547, 118720.0, 124554.0, 132874.33562832125, 133447.0, 137712.999999999, 14650.487232946796, 14783.408663653549, 14809.92595037018, 14974.595244149934, 15151.393944242327, 22982.655260171112, 22985.310440686808, 22992.88503557505, 22996.08015679354, 23005.539889202122, 10331.380117192992, 10426.322289051188, 10466.267361284637, 10514.158867290598, 10535.683929482127, 9789.902100979041, 9796.706098817047, 9826.80346393068, 9854.556544955494, 9974.152197063331, 8945.73162805117, 8989.280857531381, 8994.595243214071, 9045.276377889753, 9241.445513269091, 2423.333583264581, 2429.4169399344382, 2432.1609044879488, 2523.735007824189, 2560.8719564021726, 935.1910597333393, 961.1829944547219, 964.0937518732369, 974.356924429887, 981.0366120871598, 19032.42902712921, 19104.33134840302, 19233.326833561037, 19287.132079056475, 19446.416607501797, 1011.7672935224939, 1013.9746506337401, 1014.9137323327452, 1020.3673722292226, 1022.2384323678907, 10554.366737995744, 10660.413677247825, 10728.356298622108, 10876.945615271872, 10912.727181820517, 443143.0, 445682.0, 449564.0, 462187.0, 462668.0, 104553.47723261335, 105813.0, 105826.0, 107675.46162269138, 108337.45831270951, 1042.8435734639713, 1089.6894385100209, 1130.813415786386, 1144.3464194239411, 1191.5710344276054, 20596.0, 20634.793652063887, 20841.37475875726, 20889.0, 20955.685664714736, 53610.0, 54607.180892285854, 54812.0, 55459.445405545426, 55660.443395565526, 72028.63985680038, 72251.63874180596, 72750.63624681842, 72787.27212728017, 73575.63212183905, 14032.859671403156, 14104.153750774987, 14279.64300892486, 14327.57017289483, 14340.641483962985, 22453.438664032878, 22707.886460568254, 22970.96630651591, 23031.309060728207, 23081.076756929535, 17442.82557174412, 17480.650386991936, 17678.204480798137, 17703.291868325123, 17705.645887082443, 15772.842271577138, 16131.919340403223, 16368.345266189219, 16633.0, 16697.415590454275, 17036.829631703524, 17214.827851721824, 17218.0, 17304.048277344868, 17591.384301549384, 13833.930830345784, 13840.723185536031, 13905.304734763424, 13934.721305573628, 13942.860571394562, 16919.66160676755, 17205.655886882443, 17234.65530689404, 17380.0, 17380.82619173792], "value": 11807.518670070083, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.5862411964351, 1449.22466480433, 1451.8693317601414, 1455.8107446032013, 1457.2567990324944, 14745.926270368647, 15336.616584585377, 15349.079055256678, 15373.615659608515, 15373.92313038436, 15011.924940375282, 15016.174110423923, 15066.84933150668, 15082.0, 15082.0, 2751.1883994221653, 2780.986095069527, 2814.957775633357, 2823.774098072149, 2831.8725657345367, 2711.30861630284, 2761.9171424857186, 2777.5555911054234, 2780.152053623644, 2790.2745286225627, 2640.194740604115, 2825.0, 2828.179827849921, 2829.122971878714, 2835.4045650413436, 2808.9016884409048, 2826.2510434734604, 2833.2208642623236, 2850.8432036238, 2872.928176795576, 2615.8299710518945, 2736.945261094787, 2836.290927268183, 2837.8297302161936, 2838.0918106206022, 15095.622609434742, 15122.168280744554, 15130.167840768754, 15207.391704331814, 15257.237138143048, 8046.436749427542, 8393.16068393162, 8396.034456037572, 8396.118407567239, 8405.873911891327, 5461.290032295816, 5478.945210547883, 5613.129964855413, 5615.719214039282, 5663.348714897757, 1849.7687789026372, 1881.5672395349009, 1892.9053547322578, 1910.503269150017, 1928.807119288074, 26112.216633501026, 26134.34664133393, 26268.474630507284, 26334.6049809253, 26349.73650263492, 6624.536282460182, 6704.363085506869, 6781.11845460087, 6966.512344135862, 6991.405730512964, 17254.309827606754, 17392.47822565325, 17471.301147954193, 17504.03727794958, 17505.824941750674, 7891.171427000198, 8143.0, 8165.550894700729, 8187.38594605407, 8190.836183276301, 7343.339099480965, 7412.925870741224, 7482.775516734507, 7498.362639175732, 7507.436942229355, 5232.39827419844, 5339.652922560099, 5358.196270559447, 5358.464153584689, 5398.460153984649, 1507.5402002389376, 1518.825335086457, 1524.885633577486, 1527.3127092808058, 1529.3041666041925, 871.538084815049, 892.9553522323857, 900.5722281916169, 900.8558630619069, 903.6069309850236, 7188.388986936065, 7413.440733948691, 7423.665935032828, 7508.2867127622785, 7524.2851929066655, 722.8373615936372, 724.8550289942033, 734.097060615446, 736.8820988641792, 744.4825846037061, 4568.17772800899, 4576.839810606612, 4672.0, 4808.206645903387, 5309.177077552986, 20422.0, 20606.690899636516, 21486.677699834516, 21683.132674692835, 21772.564548709255, 21574.89212553927, 21908.0, 21912.780872191393, 22115.0, 22150.003249853795, 10984.395858227874, 11346.716332091599, 11385.544578216945, 11413.657590272305, 11547.133964952662, 7673.117591476828, 7741.225877412439, 7782.494137881246, 7807.570583617956, 7883.369330453435, 17082.91458542749, 17315.307387704856, 17351.56621084483, 17375.56561085983, 17657.29370825204, 18127.81872181261, 18152.818471815113, 18242.0, 18261.726074109163, 18559.907200463913, 10610.89389106099, 10662.73343166396, 10711.732206694895, 10740.83888741654, 10765.30025548337, 13202.273874936971, 13280.335983200608, 13283.800742989057, 13297.069205155933, 13311.26788026629, 10443.477826108512, 10568.365898046142, 10603.628872989408, 10626.574937002433, 10775.0, 10455.268131230741, 10597.89402105969, 10619.628313009007, 10641.255112142077, 10868.347899126078, 9346.252299816135, 9436.150746432853, 9528.571214295234, 9541.188998935168, 9563.282753793354, 6113.786017489367, 6161.815145545641, 6175.752969881334, 6179.474744646755, 6272.905906411499, 6773.966130169318, 6826.795196143925, 6837.726490940506, 6890.104286442931, 6901.792946211622], "value": 6533.665885608154, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.2252597211335, 501.5285631506384, 503.7154007985488, 509.4065413792931, 519.9064168449678, 6201.2868520120255, 6330.968345158273, 6396.232452105748, 6398.424141827235, 6409.903851442232, 5915.704214789265, 6092.603980741249, 6092.878142437148, 6156.521565315594, 6191.0188739603345, 4930.235813448903, 4980.302757613937, 4995.750212489361, 5012.721755952227, 5032.069067222557, 4740.881477963044, 4929.4824043475455, 4955.281484184791, 5029.3964724232965, 5044.0, 4826.589739872115, 4917.926231106536, 4954.851354459354, 4990.126727822635, 4999.575036121916, 4915.901681966358, 4930.260460930871, 4961.603071754287, 4961.982793527318, 5029.597632189416, 4425.491068527096, 4463.575960283768, 4468.486124095738, 4468.687191896569, 4510.188166130095, 6164.568480206387, 6184.608463095812, 6192.535559833031, 6247.812565623039, 6267.749290028393, 5593.440655934414, 5596.188552659842, 5616.831495055155, 5725.541956643458, 5732.770689172428, 6421.876171669939, 6514.283428822826, 6553.541252112354, 6566.179227596551, 6576.572522786004, 4783.95216047842, 4794.37673102498, 4811.182099043136, 4835.05716385305, 4840.75796210188, 6857.691403886837, 6899.0, 6930.049871573206, 6948.096747422853, 6950.374466298057, 4880.511948805091, 4929.3345398371475, 4930.5069493050405, 4947.208446648519, 4981.758208806052, 5012.8496145115705, 5030.849074527697, 5038.2190760432195, 5039.143345631178, 5073.289739436482, 5681.715914204273, 5699.145128230799, 5704.857378565569, 5727.856803579861, 5749.0, 6582.2936600330995, 6597.8350541235895, 6601.240857301375, 6619.172603424572, 6627.701753421107, 1669.6744134893822, 1677.563833403324, 1715.3567412220418, 1724.3016578285815, 1753.7720096387388, 1199.898008669273, 1223.6818427208989, 1226.6626677663714, 1243.7885559454915, 1243.7947738623207, 5721.140629295495, 5739.339975902742, 5741.1388291756575, 5770.105633626795, 5773.336066352339, 6606.438452731475, 6713.932860671331, 6723.966380168165, 6800.251972283045, 6811.386975172259, 5698.52390042074, 5717.742701578356, 5770.855728606818, 5794.275715535558, 5816.156657284755, 3544.0, 3553.431450967833, 3564.7861128332383, 3569.4110471772387, 3578.481120237551, 6425.421712045938, 6485.837854053592, 6495.805125846232, 6538.444232240217, 6560.311167327457, 6878.55289406197, 6910.689018994158, 6938.722451101899, 6950.721971121098, 7023.367896889203, 6341.904871426932, 6439.291677915426, 6449.0, 6461.381626289199, 6569.967150164219, 6654.334566543501, 6677.532572719863, 6725.49558783103, 6755.763548275787, 6815.045893574805, 6663.733450661919, 6685.69914353865, 6692.5315227935525, 6749.190097188369, 6796.456283497408, 6392.264889537577, 6506.3818937200895, 6523.478121750343, 6538.411542961157, 6580.177477815273, 4929.704217746947, 4962.3052772611145, 4984.42679091909, 5009.5491405773655, 5011.273365362075, 6738.494612903954, 6797.5581587196675, 6814.693338799667, 6858.759943401957, 6864.931350686429, 6517.674116294261, 6599.571027883172, 6621.602703837785, 6630.336966303331, 6631.403173714196, 6297.622142671271, 6386.552941294065, 6436.613803171825, 6451.4516266116025, 6544.54188206821, 6335.976654824128, 6383.32975037633, 6436.806895793134, 6501.219853617407, 6521.934780652133, 6494.7077381517, 6555.901661474986, 6669.633170175687, 6676.866462670622, 6688.531802773759, 6328.968355158195, 6330.303666596763, 6335.954567496311, 6341.080543321101, 6378.33027532121], "value": 5051.02136199299, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [883.8686481303934, 896.4307664632959, 924.3252425729213, 926.8563372677233, 941.3269512298707, 19330.32343867965, 20453.590928181427, 20531.794682053194, 20551.280705175286, 20552.89723551382, 18492.815071849276, 18782.81217187828, 18956.146973386196, 19016.714749278774, 19196.904015479937, 950.6910254167406, 963.3786207895903, 966.0918736387808, 966.6520052780993, 966.6809952715622, 945.4091193004373, 980.2696990741872, 986.7878406142678, 987.9802403951917, 989.5101924547323, 1019.5157300282343, 1024.774549599087, 1025.461632642861, 1025.7179275699204, 1025.830737928241, 984.4733067808688, 1007.2143727892219, 1014.0113389445305, 1014.2798612984716, 1015.94920253987, 737.5943231222859, 738.1068906622993, 738.8596166728358, 739.0244876762675, 740.326303064209, 20401.285954991654, 20551.075201615964, 20587.794122058887, 20641.8967905161, 20642.380728578166, 21325.466863328387, 21611.67582486264, 22209.666854997187, 22237.777622223733, 22360.32919012432, 16490.83509164917, 16592.502224933272, 16887.66224675512, 16996.575085622833, 17007.0, 3362.041818081859, 3382.2897191589796, 3382.3404436134965, 3383.2387712764676, 3391.3556424279554, 138610.0, 140703.57283863053, 141175.0, 141865.29067354702, 145044.0, 14783.556493305217, 14937.775933361008, 14957.0, 15001.399944002336, 15022.624434389008, 29205.561916571267, 29581.408371832873, 29592.408151836844, 29922.102336929926, 30128.69871301259, 8136.0643525995265, 8249.422540422112, 8257.256846883809, 8257.669693212325, 8261.091279959199, 4075.3479443289525, 4099.549049604541, 4169.082801783603, 4180.602842729936, 4185.455890734185, 4974.502549745069, 5057.620678449131, 5081.390233172043, 5081.695098294114, 5083.72039537829, 976.7411635916487, 992.4442312305132, 1008.6016023670609, 1011.438651548383, 1012.6810054832704, 682.6586706646676, 697.4106879686657, 697.6825544377297, 702.9402500787388, 713.2225873797482, 11154.888451115547, 11267.380294083903, 11568.132390070778, 11590.014848737952, 11624.476898539586, 665.3579295979306, 665.5274754923961, 671.2951401028901, 675.3280485916447, 684.1038239905739, 4979.601631869442, 5004.699718016931, 5107.131787596118, 5145.588352931756, 5193.766280517386, 119287.40356298164, 119406.0, 122408.38795805964, 123328.38335808263, 124496.0, 104099.0, 108871.45564272128, 109763.0, 114141.0, 114308.42845785718, 94919.0, 95302.5234873835, 99036.0, 100398.4980075095, 100893.0, 9569.330146889652, 9831.9016809831, 9860.816701995807, 9866.062724041205, 9956.900430995887, 44482.777586111864, 44597.331040035075, 44678.0, 45044.54955450403, 45492.0, 57324.42675573191, 57634.423655762905, 58205.0, 58394.708026461296, 59354.0, 14830.777538336717, 14858.702825943205, 14994.100353978796, 15004.324805384002, 15069.698606028038, 16021.359145634044, 16064.116473594064, 16235.0, 16332.510024699279, 16340.591485212964, 14117.2941352934, 14249.287535623385, 14292.21392823363, 14301.856981430052, 14465.204413757345, 14400.0, 14481.203533805741, 14502.709945801236, 14635.268236588341, 14639.92680036593, 12563.18339307942, 12759.48962041508, 12965.740685186054, 13004.674883127998, 13019.218846869218, 11320.433978300887, 11371.943140284246, 11505.137114716263, 11531.481083351102, 11566.462249322589, 12147.331896745764, 12296.569620063256, 12359.69100772488, 12375.504979800708, 12419.542574040699], "value": 8672.13369573842, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1431.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 108.0, 109.0, 106.0, 97.0, 109.0, 108.0, 108.0, 106.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 120.0, 118.0, 120.0, 115.0, 117.0, 117.0, 146.0, 119.0, 125.0], "value": 121.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 164.0, 171.0, 168.0, 174.0, 163.0, 167.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 73.0, 75.0, 75.0, 73.0, 74.0, 74.0, 73.0, 75.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 79.0, 79.0, 78.0, 79.0, 79.0, 79.0, 80.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 115.0, 110.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 150.0, 150.0, 148.0, 149.0, 150.0, 147.0, 149.0, 148.0, 153.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 50.0, 53.0, 53.0, 52.0, 52.0, 53.0, 51.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 38.0, 37.0, 37.0, 37.0, 37.0, 38.0, 38.0], "value": 37.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 74.0, 76.0, 77.0, 75.0, 75.0, 73.0, 76.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 118.0, 118.0, 120.0, 116.0, 117.0, 120.0, 125.0, 122.0, 127.0], "value": 121.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 180.0, 171.0, 170.0, 180.0, 174.0, 184.0, 169.0, 174.0, 174.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 63.0, 63.0, 64.0, 68.0, 67.0, 63.0, 63.0, 65.0], "value": 65.3, "unit": "score"}]}]} 03:17:19 INFO - Return code: 0 03:17:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:17:19 INFO - # TBPL SUCCESS # 03:17:19 INFO - Running post-action listener: _package_coverage_data 03:17:19 INFO - Running post-action listener: _resource_record_post_action 03:17:19 INFO - [mozharness: 2017-09-08 10:17:19.567432Z] Finished run-tests step (success) 03:17:19 INFO - Running post-run listener: _resource_record_post_run 03:17:19 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 306237440; Read time: 20; Write time: 202172 03:17:19 INFO - TinderboxPrint: CPU usage
13.1% 03:17:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 03:17:19 INFO - TinderboxPrint: I/O write bytes / time
306,237,440 / 202,172 03:17:19 INFO - TinderboxPrint: CPU idle
8,224.2 (86.9%) 03:17:19 INFO - TinderboxPrint: CPU user
1,191.1 (12.6%) 03:17:19 INFO - TinderboxPrint: Swap in / out
0 / 0 03:17:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12836864; Read time: 0; Write time: 1324 03:17:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:17:19 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292786176; Read time: 20; Write time: 200832 03:17:20 INFO - Running post-run listener: _upload_blobber_files 03:17:20 INFO - Blob upload gear active. 03:17:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:17:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:17:20 INFO - (blobuploader) - INFO - Open directory for files ... 03:17:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:17:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:17:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:21 INFO - (blobuploader) - INFO - Done attempting. 03:17:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:17:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:17:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:24 INFO - (blobuploader) - INFO - Done attempting. 03:17:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:17:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:17:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:25 INFO - (blobuploader) - INFO - Done attempting. 03:17:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:17:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:17:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:32 INFO - (blobuploader) - INFO - Done attempting. 03:17:32 INFO - (blobuploader) - INFO - Iteration through files over. 03:17:32 INFO - Return code: 0 03:17:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:17:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:17:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bcff8560ad7d0288f7d9134a2507dd565e673bb095a65f3a0a8f1a4c4eb06ef6142828289dd9573b3405a777c770ad6078eb197386c8679181229e0b7812b43", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa6978f2189d7a4274ea067af7c8849e003f80eec1002963ef080cd6b0c798ffca18bfa1ba49de784c57397bad11e7ee18baf2869ebc9cb186e857ca79f3ea7c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f39a9750dd6c25fce7618e81e5d0e4540f363a4fd6eebc4e3ddb2c0a06bfeff9680f8a59b5c61af0cb9d3b3fc2ba4388b6136896aaf526516d670a9edb4e4b59", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1ebdbf5ab8c529d52890e3aa931b34b60f6aff5668bcb1c441274e76662faaebb6859012410eebf3effb9adafa5b392a4f27c9c12dd920ea2c1ab78eaa998d5"} 03:17:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:17:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:17:32 INFO - Contents: 03:17:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bcff8560ad7d0288f7d9134a2507dd565e673bb095a65f3a0a8f1a4c4eb06ef6142828289dd9573b3405a777c770ad6078eb197386c8679181229e0b7812b43", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa6978f2189d7a4274ea067af7c8849e003f80eec1002963ef080cd6b0c798ffca18bfa1ba49de784c57397bad11e7ee18baf2869ebc9cb186e857ca79f3ea7c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f39a9750dd6c25fce7618e81e5d0e4540f363a4fd6eebc4e3ddb2c0a06bfeff9680f8a59b5c61af0cb9d3b3fc2ba4388b6136896aaf526516d670a9edb4e4b59", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1ebdbf5ab8c529d52890e3aa931b34b60f6aff5668bcb1c441274e76662faaebb6859012410eebf3effb9adafa5b392a4f27c9c12dd920ea2c1ab78eaa998d5"} 03:17:32 INFO - Running post-run listener: copy_logs_to_upload_dir 03:17:32 INFO - Copying logs to upload dir... 03:17:32 INFO - mkdir: /builds/slave/test/build/upload/logs 03:17:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.410882 ========= master_lag: -0.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-08 03:17:32.221326) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 03:17:32.229207) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bcff8560ad7d0288f7d9134a2507dd565e673bb095a65f3a0a8f1a4c4eb06ef6142828289dd9573b3405a777c770ad6078eb197386c8679181229e0b7812b43", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa6978f2189d7a4274ea067af7c8849e003f80eec1002963ef080cd6b0c798ffca18bfa1ba49de784c57397bad11e7ee18baf2869ebc9cb186e857ca79f3ea7c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f39a9750dd6c25fce7618e81e5d0e4540f363a4fd6eebc4e3ddb2c0a06bfeff9680f8a59b5c61af0cb9d3b3fc2ba4388b6136896aaf526516d670a9edb4e4b59", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1ebdbf5ab8c529d52890e3aa931b34b60f6aff5668bcb1c441274e76662faaebb6859012410eebf3effb9adafa5b392a4f27c9c12dd920ea2c1ab78eaa998d5"} build_url:https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/HxFCvI-vRe6udwBtwR09eA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bcff8560ad7d0288f7d9134a2507dd565e673bb095a65f3a0a8f1a4c4eb06ef6142828289dd9573b3405a777c770ad6078eb197386c8679181229e0b7812b43", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa6978f2189d7a4274ea067af7c8849e003f80eec1002963ef080cd6b0c798ffca18bfa1ba49de784c57397bad11e7ee18baf2869ebc9cb186e857ca79f3ea7c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f39a9750dd6c25fce7618e81e5d0e4540f363a4fd6eebc4e3ddb2c0a06bfeff9680f8a59b5c61af0cb9d3b3fc2ba4388b6136896aaf526516d670a9edb4e4b59", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1ebdbf5ab8c529d52890e3aa931b34b60f6aff5668bcb1c441274e76662faaebb6859012410eebf3effb9adafa5b392a4f27c9c12dd920ea2c1ab78eaa998d5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 03:17:32.261107) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 03:17:32.261509) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1504864610.159154-370539357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 03:17:32.341787) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 03:17:32.342146) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 03:17:32.342475) ========= ========= Total master_lag: -0.15 =========