builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-081 starttime: 1506010578.93 results: success (0) revision: 835a92b19e3d7666890153a84bc635bc43a44cb2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 09:16:18.935111) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 09:16:18.935565) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 09:16:18.935917) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 09:16:18.969148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:16:18.972516) ========= 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=483e410453545d07cca6935c000001ab-1506008326.725708-285738623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-21 09:16:18-- 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% 219M=0s 2017-09-21 09:16:19 (219 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132455 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:16:19.138662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:16:19.139001) ========= 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=483e410453545d07cca6935c000001ab-1506008326.725708-285738623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022583 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:16:19.193410) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:16:19.196797) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 835a92b19e3d7666890153a84bc635bc43a44cb2 --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 835a92b19e3d7666890153a84bc635bc43a44cb2 --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=483e410453545d07cca6935c000001ab-1506008326.725708-285738623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-21 09:16:19,250 truncating revision to first 12 chars 2017-09-21 09:16:19,250 Setting DEBUG logging. 2017-09-21 09:16:19,250 attempt 1/10 2017-09-21 09:16:19,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/835a92b19e3d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-21 09:16:19,692 unpacking tar archive at: mozilla-central-835a92b19e3d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.741438 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:16:19.955618) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 09:16:19.955966) ========= script_repo_revision: 835a92b19e3d7666890153a84bc635bc43a44cb2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 09:16:19.956397) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 09:16:19.956734) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 09:16:19.970515) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-09-21 09:16:19.970958) ========= /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=483e410453545d07cca6935c000001ab-1506008326.725708-285738623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:16:20 INFO - MultiFileLogger online at 20170921 09:16:20 in /builds/slave/test 09:16:20 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 09:16:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:16:20 INFO - {'append_to_log': False, 09:16:20 INFO - 'base_work_dir': '/builds/slave/test', 09:16:20 INFO - 'blob_upload_branch': 'Firefox', 09:16:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:16:20 INFO - 'branch': 'Firefox', 09:16:20 INFO - 'buildbot_json_path': 'buildprops.json', 09:16:20 INFO - 'code_coverage': False, 09:16:20 INFO - 'config_files': ('talos/linux_config.py',), 09:16:20 INFO - 'default_actions': ('clobber', 09:16:20 INFO - 'read-buildbot-config', 09:16:20 INFO - 'download-and-extract', 09:16:20 INFO - 'populate-webroot', 09:16:20 INFO - 'create-virtualenv', 09:16:20 INFO - 'install', 09:16:20 INFO - 'setup-mitmproxy', 09:16:20 INFO - 'run-tests'), 09:16:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:16:20 INFO - 'disable_ccov_upload': False, 09:16:20 INFO - 'disable_stylo': False, 09:16:20 INFO - 'download_minidump_stackwalk': True, 09:16:20 INFO - 'download_symbols': 'ondemand', 09:16:20 INFO - 'enable_stylo': False, 09:16:20 INFO - 'enable_webrender': False, 09:16:20 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 09:16:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:16:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:16:20 INFO - 'gecko_profile': False, 09:16:20 INFO - 'gecko_profile_interval': 0, 09:16:20 INFO - 'installer_path': 'installer.exe', 09:16:20 INFO - 'log_level': 'info', 09:16:20 INFO - 'log_name': 'talos', 09:16:20 INFO - 'log_to_console': True, 09:16:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:16:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:16:20 INFO - 'opt_config_files': (), 09:16:20 INFO - 'pip_index': False, 09:16:20 INFO - 'suite': 'dromaeojs-e10s', 09:16:20 INFO - 'system_bits': '32', 09:16:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:16:20 INFO - 'title': 'talos-linux64-ix-081', 09:16:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:16:20 INFO - 'use_talos_json': True, 09:16:20 INFO - 'verify': 'False', 09:16:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:16:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:16:20 INFO - 'work_dir': 'build'} 09:16:20 INFO - [mozharness: 2017-09-21 16:16:20.170193Z] Running clobber step. 09:16:20 INFO - Running pre-action listener: _resource_record_pre_action 09:16:20 INFO - Running main action method: clobber 09:16:20 INFO - rmtree: /builds/slave/test/build 09:16:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:16:21 INFO - Running post-action listener: _resource_record_post_action 09:16:21 INFO - [mozharness: 2017-09-21 16:16:21.699820Z] Finished clobber step (success) 09:16:21 INFO - [mozharness: 2017-09-21 16:16:21.699917Z] Running read-buildbot-config step. 09:16:21 INFO - Running pre-action listener: _resource_record_pre_action 09:16:21 INFO - Running main action method: read_buildbot_config 09:16:21 INFO - Using buildbot properties: 09:16:21 INFO - { 09:16:21 INFO - "project": "", 09:16:21 INFO - "product": "firefox", 09:16:21 INFO - "who": "jlorenzo@mozilla.com", 09:16:21 INFO - "installer_path": "public/build/target.tar.bz2", 09:16:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:16:21 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 09:16:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 09:16:21 INFO - "stage_platform": "linux64-pgo", 09:16:21 INFO - "basedir": "/builds/slave/test", 09:16:21 INFO - "buildnumber": 198, 09:16:21 INFO - "platform": "ubuntu64_hw", 09:16:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:16:21 INFO - "slavebuilddir": "test", 09:16:21 INFO - "taskId": "W14vY6CqSXWAZdmP7725lA", 09:16:21 INFO - "branch": "mozilla-central", 09:16:21 INFO - "script_repo_revision": "production", 09:16:21 INFO - "revision": "835a92b19e3d7666890153a84bc635bc43a44cb2", 09:16:21 INFO - "slavename": "talos-linux64-ix-081", 09:16:21 INFO - "repo_path": "mozilla-central" 09:16:21 INFO - } 09:16:21 INFO - Finding installer, test and symbols from parent task. 09:16:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W14vY6CqSXWAZdmP7725lA'}, attempt #1 09:16:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W14vY6CqSXWAZdmP7725lA'}, attempt #1 09:16:22 INFO - Task dependencies: RdvTSP4wRdmQav5H4boEug 09:16:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug'}, attempt #1 09:16:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.tar.bz2 09:16:23 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.test_packages.json 09:16:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.crashreporter-symbols.zip 09:16:23 INFO - Running post-action listener: _resource_record_post_action 09:16:23 INFO - [mozharness: 2017-09-21 16:16:23.056076Z] Finished read-buildbot-config step (success) 09:16:23 INFO - [mozharness: 2017-09-21 16:16:23.056293Z] Running download-and-extract step. 09:16:23 INFO - Running pre-action listener: _resource_record_pre_action 09:16:23 INFO - Running main action method: download_and_extract 09:16:23 INFO - mkdir: /builds/slave/test/build/tests 09:16: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')]} 09:16:23 INFO - trying https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.test_packages.json 09:16:23 INFO - Downloading https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:16:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:16:23 INFO - Downloaded 989 bytes. 09:16:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:16:23 INFO - Using the following test package requirements: 09:16:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:16:23 INFO - u'common': [u'target.common.tests.zip'], 09:16:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:16:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:16:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:16:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:16:23 INFO - u'mozbase': [u'target.common.tests.zip'], 09:16:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:16:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:16:23 INFO - u'web-platform': [u'target.common.tests.zip', 09:16:23 INFO - u'target.web-platform.tests.tar.gz'], 09:16:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:16:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 09:16:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.common.tests.zip 09:16:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:16:23 INFO - Fetch https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.common.tests.zip into memory 09:16:24 INFO - Content-Length response header: 55331520 09:16:24 INFO - Bytes received: 55331520 09:16:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.talos.tests.zip 09:16:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:16:35 INFO - Fetch https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.talos.tests.zip into memory 09:16:36 INFO - Content-Length response header: 14509184 09:16:36 INFO - Bytes received: 14509184 09:16:36 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')]} 09:16:36 INFO - trying https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.tar.bz2 09:16:36 INFO - Downloading https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:16:37 INFO - Downloaded 62303908 bytes. 09:16:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.tar.bz2 09:16:38 INFO - mkdir: /builds/slave/test/properties 09:16:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:16:38 INFO - Writing to file /builds/slave/test/properties/build_url 09:16:38 INFO - Contents: 09:16:38 INFO - build_url:https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.tar.bz2 09:16:38 INFO - Running post-action listener: _resource_record_post_action 09:16:38 INFO - Running post-action listener: find_tests_for_verification 09:16:38 INFO - Running post-action listener: set_extra_try_arguments 09:16:38 INFO - [mozharness: 2017-09-21 16:16:38.157652Z] Finished download-and-extract step (success) 09:16:38 INFO - [mozharness: 2017-09-21 16:16:38.157882Z] Running populate-webroot step. 09:16:38 INFO - Running pre-action listener: _resource_record_pre_action 09:16:38 INFO - Running main action method: populate_webroot 09:16:38 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:16:38 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:16:38 INFO - 'tests': ['tresize', 09:16:38 INFO - 'tcanvasmark']}, 09:16:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:16:38 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:16:38 INFO - 'tests': ['dromaeo_css', 09:16:38 INFO - 'kraken']}, 09:16:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:16:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:38 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:16:38 INFO - 'talos_options': ['--disable-stylo'], 09:16:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:16:38 INFO - 'tests': ['damp', 'tps']}, 09:16:38 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:16:38 INFO - 'talos_options': ['--disable-stylo'], 09:16:38 INFO - 'tests': ['damp', 'tps']}, 09:16:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:16:38 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:16:38 INFO - 'tests': ['dromaeo_dom']}, 09:16:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:16:38 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:16:38 INFO - 'tests': ['basic_compositor_video', 09:16:38 INFO - 'glvideo']}, 09:16:38 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:16:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:16:38 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:16:38 INFO - 'talos_options': ['--disable-stylo'], 09:16:38 INFO - 'tests': ['ts_paint_webext', 09:16:38 INFO - 'tp5o_webext']}, 09:16:38 INFO - 'other-e10s': {'tests': ['a11yr', 09:16:38 INFO - 'ts_paint', 09:16:38 INFO - 'tpaint', 09:16:38 INFO - 'sessionrestore', 09:16:38 INFO - 'sessionrestore_many_windows', 09:16:38 INFO - 'sessionrestore_no_auto_restore', 09:16:38 INFO - 'tabpaint']}, 09:16:38 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:16:38 INFO - 'tests': ['a11yr', 09:16:38 INFO - 'ts_paint', 09:16:38 INFO - 'tpaint', 09:16:38 INFO - 'sessionrestore', 09:16:38 INFO - 'sessionrestore_many_windows', 09:16:38 INFO - 'sessionrestore_no_auto_restore', 09:16:38 INFO - 'tabpaint']}, 09:16:38 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:16:38 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 09:16:38 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:16:38 INFO - 'tests': ['perf_reftest_singletons']}, 09:16:38 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:16:38 INFO - 'tests': ['bloom_basic']}, 09:16:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:16:38 INFO - 'tsvgr_opacity', 09:16:38 INFO - 'tart', 09:16:38 INFO - 'tscrollx', 09:16:38 INFO - 'tsvg_static']}, 09:16:38 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:16:38 INFO - 'tests': ['tsvgx', 09:16:38 INFO - 'tsvgr_opacity', 09:16:38 INFO - 'tart', 09:16:38 INFO - 'tscrollx', 09:16:38 INFO - 'tsvg_static']}, 09:16:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:16:38 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:16:38 INFO - 'talos_options': ['--disable-stylo'], 09:16:38 INFO - 'tests': ['tp5o']}, 09:16:38 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:16:38 INFO - 'talos_options': ['--mitmproxy', 09:16:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:16:38 INFO - '--firstNonBlankPaint'], 09:16:38 INFO - 'tests': ['tp6_google', 09:16:38 INFO - 'tp6_youtube', 09:16:38 INFO - 'tp6_amazon', 09:16:38 INFO - 'tp6_facebook']}, 09:16:38 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:16:38 INFO - 'talos_options': ['--disable-stylo', 09:16:38 INFO - '--mitmproxy', 09:16:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:16:38 INFO - '--firstNonBlankPaint'], 09:16:38 INFO - 'tests': ['tp6_google', 09:16:38 INFO - 'tp6_youtube', 09:16:38 INFO - 'tp6_amazon', 09:16:38 INFO - 'tp6_facebook']}, 09:16:38 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:16:38 INFO - 'talos_options': ['--stylo-threads=1', 09:16:38 INFO - '--mitmproxy', 09:16:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:16:38 INFO - '--firstNonBlankPaint'], 09:16:38 INFO - 'tests': ['tp6_google', 09:16:38 INFO - 'tp6_youtube', 09:16:38 INFO - 'tp6_amazon', 09:16:38 INFO - 'tp6_facebook']}, 09:16:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:16:38 INFO - 'talos_options': ['--xperf_path', 09:16:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:38 INFO - 'tests': ['tp5n']}, 09:16:38 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:16:38 INFO - 'talos_options': ['--disable-stylo', 09:16:38 INFO - '--xperf_path', 09:16:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:38 INFO - 'tests': ['tp5n']}}} 09:16:38 INFO - Running post-action listener: _resource_record_post_action 09:16:38 INFO - [mozharness: 2017-09-21 16:16:38.183712Z] Finished populate-webroot step (success) 09:16:38 INFO - [mozharness: 2017-09-21 16:16:38.183801Z] Running create-virtualenv step. 09:16:38 INFO - Running pre-action listener: _resource_record_pre_action 09:16:38 INFO - Running main action method: create_virtualenv 09:16:38 INFO - Creating virtualenv /builds/slave/test/build/venv 09:16:38 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:16:38 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 09:16:38 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:16:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:16:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:16:38 INFO - Installing distribute.............................................................................................................................................................................................done. 09:16:39 INFO - Installing pip...............done. 09:16:39 INFO - Return code: 0 09:16:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:16:39 INFO - Reading from file tmpfile_stdout 09:16:39 INFO - Output received: 09:16:39 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 09:16:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:16:39 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')]} 09:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:39 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')]} 09:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:39 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eea090>, '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 0x1eead80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4f90>, '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': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', '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 09:16:39 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 09:16:39 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 09:16:39 INFO - Using env: {'DISPLAY': ':0', 09:16:39 INFO - 'HOME': '/home/cltbld', 09:16:39 INFO - 'LANG': 'en_US.UTF-8', 09:16:39 INFO - 'LANGUAGE': 'en_US:en', 09:16:39 INFO - 'LOGNAME': 'cltbld', 09:16:39 INFO - 'MAIL': '/var/mail/cltbld', 09:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:39 INFO - 'MOZ_NO_REMOTE': '1', 09:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:39 INFO - 'NO_EM_RESTART': '1', 09:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:39 INFO - 'PWD': '/builds/slave/test', 09:16:39 INFO - 'SHELL': '/bin/bash', 09:16:39 INFO - 'SHLVL': '1', 09:16:39 INFO - 'TERM': 'linux', 09:16:39 INFO - 'TMOUT': '86400', 09:16:39 INFO - 'USER': 'cltbld', 09:16:39 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', 09:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:39 INFO - '_': '/tools/buildbot/bin/python'} 09:16:40 INFO - Ignoring indexes: http://pypi.python.org/simple/ 09:16:40 INFO - Downloading/unpacking pip>=1.5 09:16:40 INFO - Running setup.py egg_info for package pip 09:16:40 INFO - warning: no files found matching 'pip/cacert.pem' 09:16:40 INFO - warning: no files found matching '*.html' under directory 'docs' 09:16:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:16:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:16:40 INFO - Installing collected packages: pip 09:16:40 INFO - Found existing installation: pip 1.1 09:16:40 INFO - Uninstalling pip: 09:16:40 INFO - Successfully uninstalled pip 09:16:40 INFO - Running setup.py install for pip 09:16:40 INFO - warning: no files found matching 'pip/cacert.pem' 09:16:40 INFO - warning: no files found matching '*.html' under directory 'docs' 09:16:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:16:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:16:40 INFO - Installing pip script to /builds/slave/test/build/venv/bin 09:16:40 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 09:16:40 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 09:16:40 INFO - Successfully installed pip 09:16:40 INFO - Cleaning up... 09:16:40 INFO - Return code: 0 09:16:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:40 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eea090>, '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 0x1eead80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4f90>, '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': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', '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 09:16:40 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 09:16:40 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 09:16:40 INFO - Using env: {'DISPLAY': ':0', 09:16:40 INFO - 'HOME': '/home/cltbld', 09:16:40 INFO - 'LANG': 'en_US.UTF-8', 09:16:40 INFO - 'LANGUAGE': 'en_US:en', 09:16:40 INFO - 'LOGNAME': 'cltbld', 09:16:40 INFO - 'MAIL': '/var/mail/cltbld', 09:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:40 INFO - 'MOZ_NO_REMOTE': '1', 09:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:40 INFO - 'NO_EM_RESTART': '1', 09:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:40 INFO - 'PWD': '/builds/slave/test', 09:16:40 INFO - 'SHELL': '/bin/bash', 09:16:40 INFO - 'SHLVL': '1', 09:16:40 INFO - 'TERM': 'linux', 09:16:40 INFO - 'TMOUT': '86400', 09:16:40 INFO - 'USER': 'cltbld', 09:16:40 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', 09:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:40 INFO - '_': '/tools/buildbot/bin/python'} 09:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:40 INFO - Downloading/unpacking psutil>=3.1.1 09:16:40 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 09:16:40 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 09:16:40 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 09:16:40 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 09:16:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:16:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:41 INFO - Installing collected packages: psutil 09:16:41 INFO - Running setup.py install for psutil 09:16:41 INFO - building 'psutil._psutil_linux' extension 09:16:41 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 09:16:42 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 09:16:42 INFO - building 'psutil._psutil_posix' extension 09:16:42 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 09:16:42 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 09:16:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:42 INFO - Successfully installed psutil 09:16:42 INFO - Cleaning up... 09:16:42 INFO - Return code: 0 09:16:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:16:42 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')]} 09:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:42 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')]} 09:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:42 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eea090>, '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 0x1eead80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4f90>, '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': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', '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 09:16:42 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 09:16:42 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 09:16:42 INFO - Using env: {'DISPLAY': ':0', 09:16:42 INFO - 'HOME': '/home/cltbld', 09:16:42 INFO - 'LANG': 'en_US.UTF-8', 09:16:42 INFO - 'LANGUAGE': 'en_US:en', 09:16:42 INFO - 'LOGNAME': 'cltbld', 09:16:42 INFO - 'MAIL': '/var/mail/cltbld', 09:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:42 INFO - 'MOZ_NO_REMOTE': '1', 09:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:42 INFO - 'NO_EM_RESTART': '1', 09:16:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:42 INFO - 'PWD': '/builds/slave/test', 09:16:42 INFO - 'SHELL': '/bin/bash', 09:16:42 INFO - 'SHLVL': '1', 09:16:42 INFO - 'TERM': 'linux', 09:16:42 INFO - 'TMOUT': '86400', 09:16:42 INFO - 'USER': 'cltbld', 09:16:42 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', 09:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:42 INFO - '_': '/tools/buildbot/bin/python'} 09:16:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:16:42 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 09:16:42 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 09:16:42 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 09:16:42 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 09:16:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:16:43 INFO - Installing collected packages: mozsystemmonitor 09:16:43 INFO - Running setup.py install for mozsystemmonitor 09:16:44 INFO - Successfully installed mozsystemmonitor 09:16:44 INFO - Cleaning up... 09:16:44 INFO - Return code: 0 09:16:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eea090>, '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 0x1eead80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4f90>, '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': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', '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 09:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:16:44 INFO - Using env: {'DISPLAY': ':0', 09:16:44 INFO - 'HOME': '/home/cltbld', 09:16:44 INFO - 'LANG': 'en_US.UTF-8', 09:16:44 INFO - 'LANGUAGE': 'en_US:en', 09:16:44 INFO - 'LOGNAME': 'cltbld', 09:16:44 INFO - 'MAIL': '/var/mail/cltbld', 09:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:44 INFO - 'MOZ_NO_REMOTE': '1', 09:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:44 INFO - 'NO_EM_RESTART': '1', 09:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:44 INFO - 'PWD': '/builds/slave/test', 09:16:44 INFO - 'SHELL': '/bin/bash', 09:16:44 INFO - 'SHLVL': '1', 09:16:44 INFO - 'TERM': 'linux', 09:16:44 INFO - 'TMOUT': '86400', 09:16:44 INFO - 'USER': 'cltbld', 09:16:44 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', 09:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:44 INFO - '_': '/tools/buildbot/bin/python'} 09:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:45 INFO - Downloading/unpacking jsonschema==2.5.1 09:16:45 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 09:16:45 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 09:16:45 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 09:16:45 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 09:16:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:16:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:46 INFO - Downloading functools32-3.2.3-2.tar.gz 09:16:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:16:46 INFO - warning: no files found matching '*.txt' 09:16:46 INFO - no previously-included directories found matching 'build' 09:16:46 INFO - no previously-included directories found matching 'dist' 09:16:46 INFO - no previously-included directories found matching '.git*' 09:16:46 INFO - Installing collected packages: jsonschema, functools32 09:16:46 INFO - Running setup.py install for functools32 09:16:46 INFO - warning: no files found matching '*.txt' 09:16:46 INFO - no previously-included directories found matching 'build' 09:16:46 INFO - no previously-included directories found matching 'dist' 09:16:46 INFO - no previously-included directories found matching '.git*' 09:16:46 INFO - Successfully installed jsonschema functools32 09:16:46 INFO - Cleaning up... 09:16:46 INFO - Return code: 0 09:16:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eea090>, '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 0x1eead80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4f90>, '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': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', '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 09:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:16:46 INFO - Using env: {'DISPLAY': ':0', 09:16:46 INFO - 'HOME': '/home/cltbld', 09:16:46 INFO - 'LANG': 'en_US.UTF-8', 09:16:46 INFO - 'LANGUAGE': 'en_US:en', 09:16:46 INFO - 'LOGNAME': 'cltbld', 09:16:46 INFO - 'MAIL': '/var/mail/cltbld', 09:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:46 INFO - 'MOZ_NO_REMOTE': '1', 09:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:46 INFO - 'NO_EM_RESTART': '1', 09:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:46 INFO - 'PWD': '/builds/slave/test', 09:16:46 INFO - 'SHELL': '/bin/bash', 09:16:46 INFO - 'SHLVL': '1', 09:16:46 INFO - 'TERM': 'linux', 09:16:46 INFO - 'TMOUT': '86400', 09:16:46 INFO - 'USER': 'cltbld', 09:16:46 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', 09:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:46 INFO - '_': '/tools/buildbot/bin/python'} 09:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:16:47 INFO - Cleaning up... 09:16:47 INFO - Return code: 0 09:16:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:16:47 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')]} 09:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:47 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')]} 09:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:47 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eea090>, '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 0x1eead80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4f90>, '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': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', '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 09:16:47 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 09:16:47 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 09:16:47 INFO - Using env: {'DISPLAY': ':0', 09:16:47 INFO - 'HOME': '/home/cltbld', 09:16:47 INFO - 'LANG': 'en_US.UTF-8', 09:16:47 INFO - 'LANGUAGE': 'en_US:en', 09:16:47 INFO - 'LOGNAME': 'cltbld', 09:16:47 INFO - 'MAIL': '/var/mail/cltbld', 09:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:47 INFO - 'MOZ_NO_REMOTE': '1', 09:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:47 INFO - 'NO_EM_RESTART': '1', 09:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:47 INFO - 'PWD': '/builds/slave/test', 09:16:47 INFO - 'SHELL': '/bin/bash', 09:16:47 INFO - 'SHLVL': '1', 09:16:47 INFO - 'TERM': 'linux', 09:16:47 INFO - 'TMOUT': '86400', 09:16:47 INFO - 'USER': 'cltbld', 09:16:47 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', 09:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:47 INFO - '_': '/tools/buildbot/bin/python'} 09:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:47 INFO - Downloading/unpacking blobuploader==1.2.4 09:16:47 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 09:16:47 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 09:16:47 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 09:16:47 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 09:16:48 INFO - Downloading blobuploader-1.2.4.tar.gz 09:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:16:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:16:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:48 INFO - Downloading docopt-0.6.1.tar.gz 09:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:16:49 INFO - Installing collected packages: blobuploader, requests, docopt 09:16:49 INFO - Running setup.py install for blobuploader 09:16:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:16:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:16:49 INFO - Running setup.py install for requests 09:16:49 INFO - Running setup.py install for docopt 09:16:49 INFO - Successfully installed blobuploader requests docopt 09:16:49 INFO - Cleaning up... 09:16:49 INFO - Return code: 0 09:16:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16: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')]} 09:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:49 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eea090>, '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 0x1eead80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4f90>, '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': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', '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 09:16:49 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 09:16:49 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 09:16:49 INFO - Using env: {'DISPLAY': ':0', 09:16:49 INFO - 'HOME': '/home/cltbld', 09:16:49 INFO - 'LANG': 'en_US.UTF-8', 09:16:49 INFO - 'LANGUAGE': 'en_US:en', 09:16:49 INFO - 'LOGNAME': 'cltbld', 09:16:49 INFO - 'MAIL': '/var/mail/cltbld', 09:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:49 INFO - 'MOZ_NO_REMOTE': '1', 09:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:49 INFO - 'NO_EM_RESTART': '1', 09:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:49 INFO - 'PWD': '/builds/slave/test', 09:16:49 INFO - 'SHELL': '/bin/bash', 09:16:49 INFO - 'SHLVL': '1', 09:16:49 INFO - 'TERM': 'linux', 09:16:49 INFO - 'TMOUT': '86400', 09:16:49 INFO - 'USER': 'cltbld', 09:16:49 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', 09:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:49 INFO - '_': '/tools/buildbot/bin/python'} 09:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:49 INFO - Running setup.py (path:/tmp/pip-0_UKgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:49 INFO - Running setup.py (path:/tmp/pip-eCPT0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:50 INFO - Running setup.py (path:/tmp/pip-WftTF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:50 INFO - Running setup.py (path:/tmp/pip-b_EBm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:50 INFO - Running setup.py (path:/tmp/pip-IOdY99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:50 INFO - Running setup.py (path:/tmp/pip-R9OdRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:50 INFO - Running setup.py (path:/tmp/pip-Gka1cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:50 INFO - Running setup.py (path:/tmp/pip-oWMhEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:50 INFO - Running setup.py (path:/tmp/pip-8gOe6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:50 INFO - Running setup.py (path:/tmp/pip-SUMXex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:50 INFO - Running setup.py (path:/tmp/pip-xMYHzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:50 INFO - Running setup.py (path:/tmp/pip-SkjO1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:50 INFO - Running setup.py (path:/tmp/pip-oeAoO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:50 INFO - Running setup.py (path:/tmp/pip-KaOlHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:50 INFO - Running setup.py (path:/tmp/pip-7DALQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:50 INFO - Running setup.py (path:/tmp/pip-q6LbNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:51 INFO - Running setup.py (path:/tmp/pip-IbZtoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:16:51 INFO - Running setup.py install for manifestparser 09:16:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Running setup.py install for mozcrash 09:16:51 INFO - Running setup.py install for mozdebug 09:16:51 INFO - Running setup.py install for mozdevice 09:16:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Running setup.py install for mozfile 09:16:51 INFO - Running setup.py install for mozhttpd 09:16:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Running setup.py install for mozinfo 09:16:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Running setup.py install for mozInstall 09:16:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Running setup.py install for mozleak 09:16:51 INFO - Running setup.py install for mozlog 09:16:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Running setup.py install for moznetwork 09:16:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Running setup.py install for mozprocess 09:16:52 INFO - Running setup.py install for mozprofile 09:16:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Running setup.py install for mozrunner 09:16:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Running setup.py install for mozscreenshot 09:16:52 INFO - Running setup.py install for moztest 09:16:52 INFO - Running setup.py install for mozversion 09:16:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:16:52 INFO - Cleaning up... 09:16:52 INFO - Return code: 0 09:16:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:52 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eea090>, '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 0x1eead80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4f90>, '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': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', '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 09:16:52 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 09:16:52 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 09:16:52 INFO - Using env: {'DISPLAY': ':0', 09:16:52 INFO - 'HOME': '/home/cltbld', 09:16:52 INFO - 'LANG': 'en_US.UTF-8', 09:16:52 INFO - 'LANGUAGE': 'en_US:en', 09:16:52 INFO - 'LOGNAME': 'cltbld', 09:16:52 INFO - 'MAIL': '/var/mail/cltbld', 09:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:52 INFO - 'MOZ_NO_REMOTE': '1', 09:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:52 INFO - 'NO_EM_RESTART': '1', 09:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:52 INFO - 'PWD': '/builds/slave/test', 09:16:52 INFO - 'SHELL': '/bin/bash', 09:16:52 INFO - 'SHLVL': '1', 09:16:52 INFO - 'TERM': 'linux', 09:16:52 INFO - 'TMOUT': '86400', 09:16:52 INFO - 'USER': 'cltbld', 09:16:52 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', 09:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:52 INFO - '_': '/tools/buildbot/bin/python'} 09:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:53 INFO - Running setup.py (path:/tmp/pip-4rqoMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:53 INFO - Running setup.py (path:/tmp/pip-NkVldv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:53 INFO - Running setup.py (path:/tmp/pip-VwxhHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:53 INFO - Running setup.py (path:/tmp/pip-8MphQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:53 INFO - Running setup.py (path:/tmp/pip-CUTNUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:53 INFO - Running setup.py (path:/tmp/pip-oy49pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:53 INFO - Running setup.py (path:/tmp/pip-eLBO2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:53 INFO - Running setup.py (path:/tmp/pip-TNEN0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:53 INFO - Running setup.py (path:/tmp/pip-QP4FAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:53 INFO - Running setup.py (path:/tmp/pip-evMy1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:53 INFO - Running setup.py (path:/tmp/pip-hWRTr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:53 INFO - Running setup.py (path:/tmp/pip-_nLJ4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:53 INFO - Running setup.py (path:/tmp/pip-lB0y7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:53 INFO - Running setup.py (path:/tmp/pip-43Ys4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:54 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)) 09:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:54 INFO - Running setup.py (path:/tmp/pip-zKMpuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:54 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)) 09:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:54 INFO - Running setup.py (path:/tmp/pip-ekciKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:54 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)) 09:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:54 INFO - Running setup.py (path:/tmp/pip-a7WWhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:54 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)) 09:16:54 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)) 09:16:54 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)) 09:16:54 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)) 09:16:54 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)) 09:16:54 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)) 09:16:54 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)) 09:16:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:55 INFO - Downloading blessings-1.6.tar.gz 09:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:16:55 INFO - Installing collected packages: blessings 09:16:55 INFO - Running setup.py install for blessings 09:16:55 INFO - Successfully installed blessings 09:16:55 INFO - Cleaning up... 09:16:55 INFO - Return code: 0 09:16:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:16:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:55 INFO - Reading from file tmpfile_stdout 09:16:55 INFO - Current package versions: 09:16:55 INFO - argparse == 1.2.1 09:16:55 INFO - blessings == 1.6 09:16:55 INFO - blobuploader == 1.2.4 09:16:55 INFO - docopt == 0.6.1 09:16:55 INFO - functools32 == 3.2.3-2 09:16:55 INFO - jsonschema == 2.5.1 09:16:55 INFO - manifestparser == 1.1 09:16:55 INFO - mozInstall == 1.13 09:16:55 INFO - mozcrash == 1.0 09:16:55 INFO - mozdebug == 0.1 09:16:55 INFO - mozdevice == 0.51 09:16:55 INFO - mozfile == 1.2 09:16:55 INFO - mozhttpd == 0.7 09:16:55 INFO - mozinfo == 0.10 09:16:55 INFO - mozleak == 0.1 09:16:55 INFO - mozlog == 3.5 09:16:55 INFO - moznetwork == 0.27 09:16:55 INFO - mozprocess == 0.25 09:16:55 INFO - mozprofile == 0.28 09:16:55 INFO - mozrunner == 6.13 09:16:55 INFO - mozscreenshot == 0.1 09:16:55 INFO - mozsystemmonitor == 0.3 09:16:55 INFO - moztest == 0.8 09:16:55 INFO - mozversion == 1.4 09:16:55 INFO - psutil == 3.1.1 09:16:55 INFO - requests == 1.2.3 09:16:55 INFO - wsgiref == 0.1.2 09:16:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16: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')]} 09:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:55 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 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eea090>, '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 0x1eead80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4f90>, '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': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', '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 09:16:55 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 09:16:55 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 09:16:55 INFO - Using env: {'DISPLAY': ':0', 09:16:55 INFO - 'HOME': '/home/cltbld', 09:16:55 INFO - 'LANG': 'en_US.UTF-8', 09:16:55 INFO - 'LANGUAGE': 'en_US:en', 09:16:55 INFO - 'LOGNAME': 'cltbld', 09:16:55 INFO - 'MAIL': '/var/mail/cltbld', 09:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:55 INFO - 'MOZ_NO_REMOTE': '1', 09:16:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:55 INFO - 'NO_EM_RESTART': '1', 09:16:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:55 INFO - 'PWD': '/builds/slave/test', 09:16:55 INFO - 'SHELL': '/bin/bash', 09:16:55 INFO - 'SHLVL': '1', 09:16:55 INFO - 'TERM': 'linux', 09:16:55 INFO - 'TMOUT': '86400', 09:16:55 INFO - 'USER': 'cltbld', 09:16:55 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', 09:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:55 INFO - '_': '/tools/buildbot/bin/python'} 09:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:56 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)) 09:16:56 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)) 09:16:56 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)) 09:16:56 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)) 09:16:56 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)) 09:16:56 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)) 09:16:56 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)) 09:16:56 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)) 09:16:56 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)) 09:16:56 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:16:57 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)) 09:16:57 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)) 09:16:57 INFO - Installing collected packages: simplejson 09:16:57 INFO - Running setup.py install for simplejson 09:16:57 INFO - building 'simplejson._speedups' extension 09:16:57 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 09:16:58 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 09:16:58 INFO - Successfully installed simplejson 09:16:58 INFO - Cleaning up... 09:16:58 INFO - Return code: 0 09:16:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eea090>, '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 0x1eead80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4f90>, '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': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', '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 09:16:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:16:58 INFO - Using env: {'DISPLAY': ':0', 09:16:58 INFO - 'HOME': '/home/cltbld', 09:16:58 INFO - 'LANG': 'en_US.UTF-8', 09:16:58 INFO - 'LANGUAGE': 'en_US:en', 09:16:58 INFO - 'LOGNAME': 'cltbld', 09:16:58 INFO - 'MAIL': '/var/mail/cltbld', 09:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:58 INFO - 'MOZ_NO_REMOTE': '1', 09:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:58 INFO - 'NO_EM_RESTART': '1', 09:16:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:58 INFO - 'PWD': '/builds/slave/test', 09:16:58 INFO - 'SHELL': '/bin/bash', 09:16:58 INFO - 'SHLVL': '1', 09:16:58 INFO - 'TERM': 'linux', 09:16:58 INFO - 'TMOUT': '86400', 09:16:58 INFO - 'USER': 'cltbld', 09:16:58 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', 09:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:58 INFO - '_': '/tools/buildbot/bin/python'} 09:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:16:58 INFO - Cleaning up... 09:16:58 INFO - Return code: 0 09:16:58 INFO - Running post-action listener: _resource_record_post_action 09:16:58 INFO - Running post-action listener: _start_resource_monitoring 09:16:58 INFO - Starting resource monitoring. 09:16:58 INFO - [mozharness: 2017-09-21 16:16:58.541204Z] Finished create-virtualenv step (success) 09:16:58 INFO - [mozharness: 2017-09-21 16:16:58.541674Z] Running install step. 09:16:58 INFO - Running pre-action listener: _resource_record_pre_action 09:16:58 INFO - Running main action method: install 09:16:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:58 INFO - Reading from file tmpfile_stdout 09:16:58 INFO - Detecting whether we're running mozinstall >=1.0... 09:16:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:16:58 INFO - Reading from file tmpfile_stdout 09:16:58 INFO - Output received: 09:16:58 INFO - Usage: mozinstall [options] installer 09:16:58 INFO - Options: 09:16:58 INFO - -h, --help show this help message and exit 09:16:58 INFO - -d DEST, --destination=DEST 09:16:58 INFO - Directory to install application into. [default: 09:16:58 INFO - "/builds/slave/test"] 09:16:58 INFO - --app=APP Application being installed. [default: firefox] 09:16:58 INFO - mkdir: /builds/slave/test/build/application 09:16:58 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'] 09:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:17:16 INFO - Reading from file tmpfile_stdout 09:17:16 INFO - Output received: 09:17:16 INFO - /builds/slave/test/build/application/firefox/firefox 09:17:16 INFO - Running post-action listener: _resource_record_post_action 09:17:16 INFO - [mozharness: 2017-09-21 16:17:16.487797Z] Finished install step (success) 09:17:16 INFO - [mozharness: 2017-09-21 16:17:16.488048Z] Running setup-mitmproxy step. 09:17:16 INFO - Running pre-action listener: _resource_record_pre_action 09:17:16 INFO - Running main action method: setup_mitmproxy 09:17:16 INFO - Skipping: mitmproxy is not required 09:17:16 INFO - Running post-action listener: _resource_record_post_action 09:17:16 INFO - [mozharness: 2017-09-21 16:17:16.489168Z] Finished setup-mitmproxy step (success) 09:17:16 INFO - [mozharness: 2017-09-21 16:17:16.489387Z] Running run-tests step. 09:17:16 INFO - Running pre-action listener: _resource_record_pre_action 09:17:16 INFO - Running pre-action listener: _set_gcov_prefix 09:17:16 INFO - Running main action method: run_tests 09:17:16 WARNING - Try message not found. 09:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:17:16 INFO - Python 2.7.3 09:17:16 INFO - Return code: 0 09:17:16 INFO - grabbing minidump binary from tooltool 09:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:16 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 0x1eea090>, '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 0x1eead80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:17:16 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 09:17:16 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 09:17:16 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 09:17:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:17:16 INFO - Return code: 0 09:17:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:17:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:17:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:17:16 INFO - ENV: RUST_BACKTRACE is now full 09:17:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:17:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:17:16 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/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--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 09:17:16 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/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-081 --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 09:17:16 INFO - Using env: {'DISPLAY': ':0', 09:17:16 INFO - 'HOME': '/home/cltbld', 09:17:16 INFO - 'LANG': 'en_US.UTF-8', 09:17:16 INFO - 'LANGUAGE': 'en_US:en', 09:17:16 INFO - 'LOGNAME': 'cltbld', 09:17:16 INFO - 'MAIL': '/var/mail/cltbld', 09:17:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:17:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:16 INFO - 'MOZ_NO_REMOTE': '1', 09:17:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:16 INFO - 'NO_EM_RESTART': '1', 09:17:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:16 INFO - 'PWD': '/builds/slave/test', 09:17:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:17:16 INFO - 'RUST_BACKTRACE': 'full', 09:17:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:17:16 INFO - 'SHELL': '/bin/bash', 09:17:16 INFO - 'SHLVL': '1', 09:17:16 INFO - 'TERM': 'linux', 09:17:16 INFO - 'TMOUT': '86400', 09:17:16 INFO - 'USER': 'cltbld', 09:17:16 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', 09:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:16 INFO - '_': '/tools/buildbot/bin/python'} 09:17:16 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/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--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 09:17:16 INFO - mozversion application_buildid: 20170921144305 09:17:16 INFO - mozversion application_changeset: 835a92b19e3d7666890153a84bc635bc43a44cb2 09:17:16 INFO - mozversion application_display_name: Nightly 09:17:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:17:16 INFO - mozversion application_name: Firefox 09:17:16 INFO - mozversion application_remotingname: firefox 09:17:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:17:16 INFO - mozversion application_vendor: Mozilla 09:17:16 INFO - mozversion application_version: 58.0a1 09:17:16 INFO - mozversion platform_buildid: 20170921144305 09:17:16 INFO - mozversion platform_changeset: 835a92b19e3d7666890153a84bc635bc43a44cb2 09:17:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:17:16 INFO - mozversion platform_version: 58.0a1 09:17:16 INFO - using testdate: 1506010636 09:17:16 INFO - actual date: 1506010636 09:17:16 INFO - starting webserver on 'localhost:40562' 09:17:16 INFO - SUITE-START | Running 2 tests 09:17:16 INFO - TEST-START | dromaeo_css 09:17:16 INFO - Initialising browser for dromaeo_css test... 09:17:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40562/getInfo.html -profile /tmp/tmpHdG7yj/profile 09:17:16 INFO - TEST-INFO | started process 17558 (/builds/slave/test/build/application/firefox/firefox http://localhost:40562/getInfo.html) 09:17:22 INFO - TEST-INFO | 17558: exit 0 09:17:22 INFO - Browser initialized. 09:17:22 INFO - Running cycle 1/1 for dromaeo_css test... 09:17:22 INFO - Using env: {'DISPLAY': ':0', 09:17:22 INFO - 'HOME': '/home/cltbld', 09:17:22 INFO - 'JSGC_DISABLE_POISONING': '1', 09:17:22 INFO - 'LANG': 'en_US.UTF-8', 09:17:22 INFO - 'LANGUAGE': 'en_US:en', 09:17:22 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:17:22 INFO - 'LOGNAME': 'cltbld', 09:17:22 INFO - 'MAIL': '/var/mail/cltbld', 09:17:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:17:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:17:22 INFO - 'MOZ_CRASHREPORTER': '1', 09:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:22 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:17:22 INFO - 'MOZ_NO_REMOTE': '1', 09:17:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:22 INFO - 'NO_EM_RESTART': '1', 09:17:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:22 INFO - 'PWD': '/builds/slave/test', 09:17:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:17:22 INFO - 'RUST_BACKTRACE': 'full', 09:17:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:17:22 INFO - 'SHELL': '/bin/bash', 09:17:22 INFO - 'SHLVL': '1', 09:17:22 INFO - 'TERM': 'linux', 09:17:22 INFO - 'TMOUT': '86400', 09:17:22 INFO - 'USER': 'cltbld', 09:17:22 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', 09:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:22 INFO - '_': '/tools/buildbot/bin/python'} 09:17:22 INFO - TEST-INFO | started process 17794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHdG7yj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:23 INFO - PID 17794 | 09:17:23 INFO - PID 17794 | (/builds/slave/test/build/application/firefox/firefox:17844): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:17:23 INFO - PID 17794 | 09:17:33 INFO - PID 17794 | RSS: Main: 143613952 09:17:33 INFO - PID 17794 | 09:20:30 INFO - PID 17794 | Cycle 1(1): loaded http://localhost:40562/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40562/tests/dromaeo/cssquery-ext.html) 09:20:31 INFO - PID 17794 | RSS: Main: 148353024 09:20:31 INFO - PID 17794 | 09:23:33 INFO - PID 17794 | Cycle 1(1): loaded http://localhost:40562/tests/dromaeo/cssquery-ext.html (next: http://localhost:40562/tests/dromaeo/cssquery-jquery.html) 09:23:33 INFO - PID 17794 | RSS: Main: 148480000 09:23:33 INFO - PID 17794 | 09:26:35 INFO - PID 17794 | Cycle 1(1): loaded http://localhost:40562/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40562/tests/dromaeo/cssquery-mootools.html) 09:26:36 INFO - PID 17794 | RSS: Main: 150224896 09:26:36 INFO - PID 17794 | 09:29:37 INFO - PID 17794 | Cycle 1(1): loaded http://localhost:40562/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40562/tests/dromaeo/cssquery-prototype.html) 09:29:38 INFO - PID 17794 | RSS: Main: 148189184 09:29:38 INFO - PID 17794 | 09:32:41 INFO - PID 17794 | Cycle 1(1): loaded http://localhost:40562/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40562/tests/dromaeo/cssquery-yui.html) 09:32:41 INFO - PID 17794 | RSS: Main: 150269952 09:32:41 INFO - PID 17794 | 09:35:43 INFO - PID 17794 | Cycle 1(1): loaded http://localhost:40562/tests/dromaeo/cssquery-yui.html (next: http://localhost:40562/tests/dromaeo/cssquery-dojo.html) 09:35:43 INFO - PID 17794 | RSS: Main: 152383488 09:35:43 INFO - PID 17794 | 09:35:43 INFO - PID 17794 | __start_tp_report 09:35:43 INFO - PID 17794 | _x_x_mozilla_page_load 09:35:43 INFO - PID 17794 | _x_x_mozilla_page_load_details 09:35:43 INFO - PID 17794 | |i|pagename|runs| 09:35:43 INFO - PID 17794 | |0;dojo.html;3777.18790460051;3825.483559719438;3827.961720382795;3835.2904712628156;3885.0870045539295;6244.157038799761;6257.843553911154;6340.4610608098255;6356.141920840691;6376.776812811552;6345.365463453652;6362.427381535661;6364.745410183587;6369.299377068519;6370.745170193199;5634.0703783875615;5654.745536450849;5657.66054036757;5699.145128230757;5718.399568045358;5752.108423194411;5796.159556864273;5797.130430435426;5822.272215973004;5846.2107615472005;104.34119570997166;5608.355039170507;5683.374828768832;5686.886262274752;5820.214271073414;5688.488036076773;5753.683547404891;5767.0772676372;5768.855778605526;5774.913376299359;5652.74562644682;5654.660720356751;5724.4561766632105;5727.713614319309;5731.627444216113;6237.40744629264;6278.560500764948;6304.527160462983;6391.424771770517;6417.550771446001;6860.931390686079;6895.448364130857;6954.547954382949;6959.373656370951;6968;6856.725730970755;6955.65221738911;6963.965180174117;6968.860622787566;7031.261717519638;6381.298057213703;6388.456981156607;6402.551821372505;6406.519511036644;6502.869942601169;7100.7869763907165;7134.714611415589;7144.785656430316;7148.857022859618;7216.8917466238045;6735.4274886635185;6738.393544581011;6738.561993470409;6807.4894382921475;6809;6762.357576030269;6823.93176068233;6851.691673874688;6898.965505172542;6966.721331146799;6828.5220034597105;6851.760188393482;6853.451723862079;6854.34883686049;6860.416864566568;6836.726530938806;6926.272741362185;6955.408790252784;6958.338957799001;7003.649817509104;4987.60099192071;5005.299258103868;5045.924311135336;5048.697078175322;5072.365954255718;4528.660350473728;4548.31775233711;4572.702774319659;4599.586037256596;4670.159371313128;6261.530385221126;6261.592996455216;6271.905921411182;6292.748290068437;6294.024426213944;6848.589084654936;6856;6861.142357205349;6949.235584085746;6969.2682268362105;6167.938320616826;6187.288461826947;6259.280182778948;6264.123022776815;6274.403931626488;5408.107662235766;5504.587155963319;5531.723413829292;5551.833444996657;5605.187247849039;6975.162980442379;7067.5052746307265;7089.184743754534;7093;7098.219195888448;6723.394894459424;6795.422389096982;6819;6903.240643529108;6911.343422374866;6910.896336555056;6966.303369663196;7065.116860392451;7079.22128565847;7081.964590177016;6745.291744366967;6795.218549866631;6821.727130914708;6831.385175334244;6846.863062738617;6911.516193866381;6914.896276555755;6922;6923.2038315594355;6936.271691472524;6578.177727784027;6670.266270710315;6683.131192944886;6737.494687898329;6754.696038678173;6585.111010013587;6618.602883826986;6689.364510371507;6695.09616201826;6701.363370479797;6501.382368674968;6544.869102618016;6554.80335589933;6567.802965911031;6568.540202185801;6768.9661551691925;6801.285864984304;6808.148981377328;6816.182058153054;6855.451563874978;6528.445082167879;6528.934710653023;6536.215654121535;6632.303608121078;6642 09:35:43 INFO - PID 17794 | |1;ext.html;964.6671898195123;991.7669347703288;993.9105480506755;997.067741661547;997.5660587644376;40675.59324406755;44417.33373999388;44480.77759611206;44572.33141502872;44631.77684111575;40940.181196376056;41180.14689338979;41256.38115428271;41257.174856502854;41258;7613.467057305991;7704.306612404883;8496.320294376435;8698.826023479527;8733.083026282244;8509.617067231959;8636.956815215946;8637.568121593895;8645.092265312145;8648.740537783877;8562.14378562145;8658.350623703216;8664.39349245553;8675.349348798834;8684.826303473927;8614.095519970408;8619.956900215522;8633.827323453526;8638.265747411446;8658.740237792876;8477.618507167192;8527.062023177508;8539.274161696263;8540.572971351408;8550.10223926485;40320;40386.39420408667;40515.59484405148;40699.59300407017;40805.79597102025;3792.051987003249;3835.983464381941;3836.1943991761486;3838.596947320519;3838.884833454973;33243.833780831184;33325;33932.32135357304;34026.82986585076;34058.14854628629;5362.1420572708175;5464.9180262296095;5570.303712035996;5582.86042848928;5602.467765562265;216015;216925.91537042373;217158;217548;218198;47673.52326476691;48446.27330590044;51386.48613513892;51410.228846567334;51515.7424212884;55824.72087639617;56757;57012.71493642505;57053.85892282131;57100.71449642725;17115.05867177317;17154.05652689089;17170.484885453458;17249;17294.827051729575;14022.649433764238;14078.71842563143;14188.219647919463;14210.431582736781;14231.288435578179;15137.318820653098;15219.239038048054;15241.542753717406;15244.542663720105;15343.07941523512;5987.31145918225;6049.8487537811025;6168.013117901114;6228.906566401508;6285.497160227171;1116.1740312168936;1120.9775804483866;1126.189143816451;1133.6145710458484;1145.9541618335172;25640.74359256421;25697.229083127535;25747;25893.223203303933;25939.870300648752;1191.1304747534348;1210.7275862930946;1221.7678641058171;1223.4127618742875;1242.3043095866344;13618.591442256748;13668;13688.726225475435;13762.449502020007;13894.58316250494;270130;270161;271180;271207;271557;57534.424655752904;57624.42375576274;57649.13526297109;57754.422455774904;57774.7111264441;1531.1731664901051;1555.3312075807512;1572.9842701572838;1587.476132876148;1589.6025993501626;24971;25334.239972800846;25337.746622533537;25358;25640.358991025372;41191.1761764769;41212.58787412087;41250.58749412587;41297.380539291335;41299.174016520104;234846;235012;235594;236086;236348;36374.271929605915;37560.624393755716;38074.238515228986;38193.80903095467;38217.80891095527;48571;49211.75394123006;50062;50249.24626130538;50399.49600503948;36138;36502.8174859124;36514.63485365112;36769.448458273684;36818.63181368152;36397.636023639425;36726.63273367339;36746.63253367432;36814.8159259202;36825.63174368329;41987.16025679408;42513.149737005704;42619.147617048104;42844.57155428531;42934.14131717411;35141;35294.47058294179;35326.47010294796;35461.46807797834;35555.64444355523;26358.472830542898;26856.462870742867;26953.460930780882;27013.59479607847;27141.321466963484 09:35:43 INFO - PID 17794 | |2;jquery.html;606.1544145916444;609.2627920216535;613.938606139386;615.452247499725;630.3916720364847;23519.41201469962;24230.51538969224;24320.148794792185;24349.26952191435;24369.634455483138;24566.631500527506;26225.868870655668;26438.20685379437;26446;26486.735132648668;6728.2935291794265;6798.5580937239165;6831.4534837212905;6836.0771295875165;6838.179418469791;6488.156539649839;6494.480441564687;6725.798226053202;6735.057092007123;6757.189137303506;6691.330866913294;6692.431143352821;6701.798946031627;6707.899381509281;6708.83227919301;6625.73497060117;6653.7005834737065;6677.599344039349;6685.0640910272605;6691.063251144844;6200.627962322275;6222.471089957314;6235.220597425322;6242.406971337761;6254.781082662131;28780.71219287822;29258;29803.105906822613;29992;30036.098917032523;2221.1115553778454;2229.5317983223545;2247.831412644042;2248.584011957793;2257.7742225777456;20306.883121428316;20945.581088378298;21053.052612632317;21058.2629607963;21065.47336316589;2511.7739403453775;2546.834455760388;2559.0403598650505;2612.0988259050596;2638.2349118755537;131769;136849;146675;154908;155400.99999999886;15542.611434714223;15810.762838557432;15833.762493562606;15930.761038584431;16359.91820040916;25278.368040799127;25289.114880979447;25307.355021923515;25334.746652533606;25345.112921048043;10499.265051446326;10748.355098694103;10788.568457261621;10806.459677016117;10970.780584388267;9833.901660983298;9854.359466634645;9867.753306167404;10017.449040302708;10040.849387259197;9665.178459830853;9747.512624368754;10016.449095299828;10131.645392411378;10168.33905796121;2931.299846089263;2937.9559306610417;2954.542045982876;2968.9703102968692;3009.0671891713637;1011.2415688233824;1038.7195457226508;1040.3653771199563;1049.6063976008998;1052.0741747262514;20652;20778.896105519678;21056.578868422544;21147.259845905628;21479;1074.2909679611419;1077.1221454514546;1095.3756358875364;1099.5272033025715;1114.7101753543975;11378.658640240807;11643.602767667764;11854.407279635983;11857.932786049298;11864.762704745857;521481;532561;537318.3134084382;545394;550918;122683.38658306829;126994;127955;128592.3570382142;128936;1090.7273181704575;1166.9474873630706;1210.1831263896834;1215.489494412349;1259.5528587351541;21483;21590;21820.563588728455;22026.669599956334;22178.00198991017;59359.40640593539;61147.694261528406;61267.693661531404;61654;63140.68429657822;77594;77791.2220877784;77810.6109469449;77854.610726946;78586;15035.097894126387;15097.54707358781;15220.315085820943;15220.923895380452;15242.314095865935;23355.76644233536;23422.531549368578;23785.167519136747;23786.40533986664;23852.761472385053;19243.711344330128;19401.902990484956;19756.703649444982;19768;19917.701234481203;16445.342186312413;16583;16611.335546578;16667.66664666724;16824.74762878533;19820.40538783839;19828;19836.10737516844;19883.801161988195;19913.800861991196;14885.106893586419;14905.701885962004;15139.772903406678;15143.242837858283;15163.62090947691;18870.433886983414;19060.809391905903;19159.233630654617;19314.517137071685;19319.13063912099 09:35:43 INFO - PID 17794 | |3;mootools.html;1365.6039748472942;1474.3586539855164;1475.9852401475982;1483.903546269493;1491.9254037298133;16774.41289554864;17513.56216094598;17535;17538.824611753895;17542.12289385532;17001.404950826724;17004.149792510358;17054.23255953482;17130.31478740852;17154.82845171548;2926.3708302714913;2942.573326867608;2991.536311871663;2998.3253767902156;3003.6395632524127;2891.8264904105718;2912.3738396244803;2914.5191043477803;2915.766738660902;2920.050983430383;2846.1177035119076;2862.7423531882127;2886;2972.6432828060665;2975.642922849261;2971.643402791657;2987.7012298770164;2990.312228187507;3002.084364268897;3005.8647360868704;2389.4026493376655;2452.9877350613133;2851.9714802851913;2857.7428031477266;2871.8851245950136;16035.91982040094;16446.259918303705;16493.83506164935;16534.83465165345;16562.17189140538;8871.778205544848;9074.455532667995;9102.908970910272;9120.179183873417;9139.451632902048;5857.062869940789;5907.438793314628;5956.463918247336;5997.4002599740115;6049.788257411014;2129.7346788479535;2160.12514931453;2165.2421652421685;2238.876861772602;2253.4028482452;31041.84479077613;31102.68897311043;31297.217569560715;31314.651401145005;31318.37363252745;7360.926390736024;7441.367483763941;7454.5836291104515;7533.227583081265;7614.390848732088;20322.695159572617;20330.49173770638;20336.389908302775;20349.186032558828;20361.083751231232;8510.191531804468;8611.655533778703;8638.95680521606;8643.697470588499;8675.479471231747;7558.811029724191;7754;7785.844283114306;7788.805279868048;7890.723824666109;5820.24336836217;5872.324682661463;5904.5571582131515;5969.462748352582;5987.880242395127;1709.598244412562;1752.9474115776547;1780.261191605495;1790.5076104071484;1819.0813639112428;966.6761634852403;990.895955924632;993.6373223773415;1001.4341896828269;1019.2101121630795;8579.053764725779;8624.741257762276;8676.175763302475;8727.694530691522;8763.649454021768;802.8795680647833;815.135955886762;815.5392203405057;817.4073796497611;836.0385556609947;5414.187871819258;5823.854403639858;5841.9192449397;5979.19280897082;5991.880162396815;24911.377215569755;25756.484870302487;25971.091011814497;25983.350416239744;26003.089891853695;23999.16002939889;25168.24495265145;25168.370790730012;25370.238892833244;25423.61864572033;12006.759864802654;12065.336406497552;12171.939140304241;12287.324197169242;12315.93842030802;9223.49270790113;9292.210162136023;9310.441373517611;9348.485833279236;9445.338826282368;20568.382948511568;21056.57886842224;21414;21453.57092858103;21490.785092149505;21884.124635015058;22292.21977230789;22682.319530414115;22824.543509130057;23203.187888423825;12555.183913045623;12780.808287875503;12784.74430511403;12799.360031998176;12801.10392272532;15690.529284121494;15997.600059998593;16076.598085047968;16078.43725469603;16125.354985800906;12624.87375126237;12811.103222774316;12900.935495322463;12919;13186.472541098632;12124.636260912186;12239.571614993432;12262.325572093263;12342.568010119603;12445.937770311091;10353.378797272188;10488.737781555523;10605.469726513798;10637.734056648645;10708.250422470352;8495.787605309917;8561.82876342482;8603.612837422455;8670.566471676264;8690.217880390795;8316.62575184106;8318.251357377865;8438.451500652438;8453.408261421888;8471.788205294917 09:35:43 INFO - PID 17794 | |4;prototype.html;546.551827501449;549.4532939724972;577.3274135631989;583.3845293215655;585.3297973819979;6240.687965601719;6269.404406581373;6291.842703932404;6308.653024083674;6331.398517140876;6098.4511393974535;6120.326764055962;6152.230971128609;6233.345498722637;6249.5000399968;5012.398512178544;5037.924431133536;5048.419431765339;5056.898862022757;5078.289039534468;4873.975630121862;4906.754662266891;4914.827981020665;4963.776630051656;5085.974570127163;4870.780814863322;4896.657233993622;4922.458529561745;4929.580985616209;4939.580135688453;4905.435874874382;4908.754562271872;4917.385326834145;4956.116675663261;4964.6276529260085;4521.480029796583;4532.206863798822;4532.388127602764;4553.931691024637;4564.292534657134;6123.755049798003;6150.708351246244;6194.380561943814;6197.845053873644;6252.874942501125;5720.170575266605;5726.828195154152;5737.254156959611;5747.281589801275;5830.329512106077;6607.405333520006;6653.2681405045405;6673.165854268216;6714.764983225564;6717.16035495563;4811.08589368019;5037.345145131109;5055.9241611375855;5063.164577844651;5065.797368105272;6539.673016349164;6744.325567443217;6789.796306110775;6865.949090036902;6943.409810166142;5096.337476128079;5138.254953031789;5148.58811295103;5173.810023694496;5174.689518628894;5172.405173405106;5200.6619569727845;5221.242919776611;5229.006488767122;5235.455540615451;5758.280214973129;5766.538676905838;5774.769009239583;5789.884202316014;5821.38875418075;6636;6643.634600097041;6673.265940746514;6678.732850686015;6718.0517649880985;1768.4606195110357;1783.973240401395;1795.4793109997954;1805.909704514769;1810;1234.2594443333928;1255.5605538061604;1276.585109839306;1277.8402699662543;1286.5625687266374;6005.498625343664;6052.848678783065;6055.424734650202;6058.787942421994;6087.421694938974;6686.632235227012;6716.529842910949;6762.647470505918;6782.491313151435;6800.217974932946;5896.380880007623;6046.425589568984;6074;6099.664518451527;6135.263768347827;3492.633273506296;3507.5618996211942;3510.3330367230656;3548.520949671761;3561.893143205708;6634.270230274666;6681.398674119353;6728.495362847708;6729.966350168218;6830.624315662686;6794;6866.450683945272;6946.305369463013;6973.430978030005;6978.127734033246;6780.966095169492;6829.8634027318185;6881.552699074544;6901.378875901193;6982;6642.634655094016;6727.764528241488;6758.324167583202;6806.9319306808275;6859.485538584726;6662.333766623493;6687.29164688302;6754.3921047106;6766.15423072116;6766.966165169143;6839.589624622339;6851.9657401712675;6922.965385173042;6937.826554336182;6951.548149370275;5111.083343746095;5126.282320475062;5128.410232823124;5146.665466744649;5153.793848246029;6433.485321174388;6624.271330153583;6655;6692.163479565054;6694.832629184115;6464.838379040561;6488.643124628002;6544.149260596282;6552.6068435894;6582.05829280373;6421.903671445026;6441.227052753699;6472.644004579794;6518.598501322239;6580.605163690002;6429.067785171217;6485.8702825944165;6501.934980650133;6503.934960650333;6522.380373864476;6528.706208220547;6608.7356505739235;6677.7295719455615;6678.899816502853;6695.230048544479;6415.550911436341;6432.163818703539;6450.967745161244;6454.935450645434;6470.902936455863 09:35:43 INFO - PID 17794 | |5;yui.html;964.9758756031094;978.4129522286629;982.9311948163629;988.649029594494;999.9000099989997;20535.28126515572;21334;21546;21549.030293636784;21571.352859414223;19476.805231947677;19838.30565930193;19874.304399346027;20045;20115.698264526043;1030.4796077980627;1050.4590136079887;1052.5421441672859;1052.8262836631945;1053.3469249065552;1057.6298295596519;1062.8777690565569;1063.5905176507063;1063.8191507443753;1064.6965614799783;1054.225144518778;1114.1309778372881;1117.3407689463215;1119.4123085380158;1122.9157813164004;1106.8837772033942;1108;1109.805783987807;1109.944502774858;1110.3670907582682;817.6647574494489;818.3289702443998;818.4843548564367;819.5902048975512;820.122468958215;21262.893685531628;21942.561148777095;21953;22008.229711960004;22013.66979495309;22912.885435572716;23586.292411227692;23754.64368034481;23893.641595376084;23895.163669271667;18502.167402466923;18699.906500467547;18849.717254241197;19041.7143742844;19045.0477476127;4047.5547689754103;4058.3100872851687;4058.959410405888;4067.857624983141;4081.6122468365456;152645;153468;154796;156591.21704391405;158554.99999999884;18286.085695715163;18449.907750461163;18589;18708.158132883782;18956;35148;35191.4721279181;35241.64758352384;35307.117322067155;35362.469562956576;9441.386309889973;9486.335956483117;9503.57233924475;9528.904710952802;9530.571124299424;4202.600752928467;4248.723832950848;4252.808623611945;4272.102858399709;4288.442502474658;5902.8819423611285;5931.970340148272;5954.612950158225;5960.821175364746;5990.490808281258;1052.4474650808233;1078.191356482638;1090.0407641275785;1094.6059418609295;1104.4864138175788;733.0653416893397;733.9119305683353;746.3394895517506;762.6872982077322;763.3320844261272;12377.381130943417;12951.287679177547;13376.732465350833;13975.231362275172;14105.224212668401;737.6574634165873;747.114669117098;750.1770697205733;753.4650398217218;758.2228216078564;5868.237129173265;5927.051671732502;5979.581429299994;6072.969635151796;6095.969520152371;138287;139487;139493;140545.297273513;141102.19689585446;105872;107494;125652.37173814072;130171.34914325368;134006.3299683515;111480;111665.44167279275;112886;115651.42174288907;116072.41963790127;12823.743525129632;12905.870941290466;13211.801822972471;14367.928160359132;14383.784243236569;53629.7318513405;54200.28998550135;54756.452435475134;55309.44690553043;55755.72122139364;91377.54311228401;92386.64330393281;93372;94606.52696736748;95201.52399237959;21684.34946951594;21686.6746998792;21692.891535542854;21737.021834017192;22019.339419817432;22827.543449131255;24190.395240119138;24434.755652443248;24468.877655611606;24511.264662060166;16261.674766504368;16472.258748356115;16738.58153546171;16762.58093547671;19705.704414434083;18494.907525462288;18687;18822.435326940213;19493.70759438638;19978.501612378837;19978.70031949493;20052.298169563994;20137.39587812368;21037;21297.467563311042;15180.392784288504;15290.923545382202;15307.15810630426;15377.923110384376;15483.148426836633;14658.340374683377;14690.779638305648;14994.325255363752;15108.622284442978;15380.846191538389 09:35:43 INFO - PID 17794 | __end_tp_report 09:35:43 INFO - PID 17794 | __start_cc_report 09:35:43 INFO - PID 17794 | _x_x_mozilla_cycle_collect,282 09:35:43 INFO - PID 17794 | __end_cc_report 09:35:43 INFO - PID 17794 | __startTimestamp1506011743747__endTimestamp 09:35:43 INFO - PID 17794 | 09:35:43 INFO - PID 17794 | ------- Summary: start ------- 09:35:43 INFO - PID 17794 | Number of tests: 6 09:35:43 INFO - PID 17794 | 09:35:43 INFO - PID 17794 | [#0] dojo.html Cycles:165 Average:6292.69 Median:6568.54 stddev:898.25 (13.7%) stddev-sans-first:879.06 09:35:43 INFO - PID 17794 | Values: 3777.2 3825.5 3828.0 3835.3 3885.1 6244.2 6257.8 6340.5 6356.1 6376.8 6345.4 6362.4 6364.7 6369.3 6370.7 5634.1 5654.7 5657.7 5699.1 5718.4 5752.1 5796.2 5797.1 5822.3 5846.2 104.3 5608.4 5683.4 5686.9 5820.2 5688.5 5753.7 5767.1 5768.9 5774.9 5652.7 5654.7 5724.5 5727.7 5731.6 6237.4 6278.6 6304.5 6391.4 6417.6 6860.9 6895.4 6954.5 6959.4 6968.0 6856.7 6955.7 6964.0 6968.9 7031.3 6381.3 6388.5 6402.6 6406.5 6502.9 7100.8 7134.7 7144.8 7148.9 7216.9 6735.4 6738.4 6738.6 6807.5 6809.0 6762.4 6823.9 6851.7 6899.0 6966.7 6828.5 6851.8 6853.5 6854.3 6860.4 6836.7 6926.3 6955.4 6958.3 7003.6 4987.6 5005.3 5045.9 5048.7 5072.4 4528.7 4548.3 4572.7 4599.6 4670.2 6261.5 6261.6 6271.9 6292.7 6294.0 6848.6 6856.0 6861.1 6949.2 6969.3 6167.9 6187.3 6259.3 6264.1 6274.4 5408.1 5504.6 5531.7 5551.8 5605.2 6975.2 7067.5 7089.2 7093.0 7098.2 6723.4 6795.4 6819.0 6903.2 6911.3 6910.9 6966.3 7065.1 7079.2 7082.0 6745.3 6795.2 6821.7 6831.4 6846.9 6911.5 6914.9 6922.0 6923.2 6936.3 6578.2 6670.3 6683.1 6737.5 6754.7 6585.1 6618.6 6689.4 6695.1 6701.4 6501.4 6544.9 6554.8 6567.8 6568.5 6769.0 6801.3 6808.1 6816.2 6855.5 6528.4 6528.9 6536.2 6632.3 6642.0 09:35:43 INFO - PID 17794 | 09:35:43 INFO - PID 17794 | [#1] ext.html Cycles:180 Average:42457.26 Median:21026.90 stddev:62827.31 (298.8%) stddev-sans-first:62926.31 09:35:43 INFO - PID 17794 | Values: 964.7 991.8 993.9 997.1 997.6 40675.6 44417.3 44480.8 44572.3 44631.8 40940.2 41180.1 41256.4 41257.2 41258.0 7613.5 7704.3 8496.3 8698.8 8733.1 8509.6 8637.0 8637.6 8645.1 8648.7 8562.1 8658.4 8664.4 8675.3 8684.8 8614.1 8620.0 8633.8 8638.3 8658.7 8477.6 8527.1 8539.3 8540.6 8550.1 40320.0 40386.4 40515.6 40699.6 40805.8 3792.1 3836.0 3836.2 3838.6 3838.9 33243.8 33325.0 33932.3 34026.8 34058.1 5362.1 5464.9 5570.3 5582.9 5602.5 216015.0 216925.9 217158.0 217548.0 218198.0 47673.5 48446.3 51386.5 51410.2 51515.7 55824.7 56757.0 57012.7 57053.9 57100.7 17115.1 17154.1 17170.5 17249.0 17294.8 14022.6 14078.7 14188.2 14210.4 14231.3 15137.3 15219.2 15241.5 15244.5 15343.1 5987.3 6049.8 6168.0 6228.9 6285.5 1116.2 1121.0 1126.2 1133.6 1146.0 25640.7 25697.2 25747.0 25893.2 25939.9 1191.1 1210.7 1221.8 1223.4 1242.3 13618.6 13668.0 13688.7 13762.4 13894.6 270130.0 270161.0 271180.0 271207.0 271557.0 57534.4 57624.4 57649.1 57754.4 57774.7 1531.2 1555.3 1573.0 1587.5 1589.6 24971.0 25334.2 25337.7 25358.0 25640.4 41191.2 41212.6 41250.6 41297.4 41299.2 234846.0 235012.0 235594.0 236086.0 236348.0 36374.3 37560.6 38074.2 38193.8 38217.8 48571.0 49211.8 50062.0 50249.2 50399.5 36138.0 36502.8 36514.6 36769.4 36818.6 36397.6 36726.6 36746.6 36814.8 36825.6 41987.2 42513.1 42619.1 42844.6 42934.1 35141.0 35294.5 35326.5 35461.5 35555.6 26358.5 26856.5 26953.5 27013.6 27141.3 09:35:43 INFO - PID 17794 | 09:35:43 INFO - PID 17794 | [#2] jquery.html Cycles:180 Average:37495.26 Median:2225.32 stddev:90479.44 (4065.9%) stddev-sans-first:90690.87 09:35:43 INFO - PID 17794 | Values: 606.2 609.3 613.9 615.5 630.4 23519.4 24230.5 24320.1 24349.3 24369.6 24566.6 26225.9 26438.2 26446.0 26486.7 6728.3 6798.6 6831.5 6836.1 6838.2 6488.2 6494.5 6725.8 6735.1 6757.2 6691.3 6692.4 6701.8 6707.9 6708.8 6625.7 6653.7 6677.6 6685.1 6691.1 6200.6 6222.5 6235.2 6242.4 6254.8 28780.7 29258.0 29803.1 29992.0 30036.1 2221.1 2229.5 2247.8 2248.6 2257.8 20306.9 20945.6 21053.1 21058.3 21065.5 2511.8 2546.8 2559.0 2612.1 2638.2 131769.0 136849.0 146675.0 154908.0 155401.0 15542.6 15810.8 15833.8 15930.8 16359.9 25278.4 25289.1 25307.4 25334.7 25345.1 10499.3 10748.4 10788.6 10806.5 10970.8 9833.9 9854.4 9867.8 10017.4 10040.8 9665.2 9747.5 10016.4 10131.6 10168.3 2931.3 2938.0 2954.5 2969.0 3009.1 1011.2 1038.7 1040.4 1049.6 1052.1 20652.0 20778.9 21056.6 21147.3 21479.0 1074.3 1077.1 1095.4 1099.5 1114.7 11378.7 11643.6 11854.4 11857.9 11864.8 521481.0 532561.0 537318.3 545394.0 550918.0 122683.4 126994.0 127955.0 128592.4 128936.0 1090.7 1166.9 1210.2 1215.5 1259.6 21483.0 21590.0 21820.6 22026.7 22178.0 59359.4 61147.7 61267.7 61654.0 63140.7 77594.0 77791.2 77810.6 77854.6 78586.0 15035.1 15097.5 15220.3 15220.9 15242.3 23355.8 23422.5 23785.2 23786.4 23852.8 19243.7 19401.9 19756.7 19768.0 19917.7 16445.3 16583.0 16611.3 16667.7 16824.7 19820.4 19828.0 19836.1 19883.8 19913.8 14885.1 14905.7 15139.8 15143.2 15163.6 18870.4 19060.8 19159.2 19314.5 19319.1 09:35:43 INFO - PID 17794 | 09:35:43 INFO - PID 17794 | [#3] mootools.html Cycles:180 Average:10579.77 Median:2854.86 stddev:7841.90 (274.7%) stddev-sans-first:7833.34 09:35:43 INFO - PID 17794 | Values: 1365.6 1474.4 1476.0 1483.9 1491.9 16774.4 17513.6 17535.0 17538.8 17542.1 17001.4 17004.1 17054.2 17130.3 17154.8 2926.4 2942.6 2991.5 2998.3 3003.6 2891.8 2912.4 2914.5 2915.8 2920.1 2846.1 2862.7 2886.0 2972.6 2975.6 2971.6 2987.7 2990.3 3002.1 3005.9 2389.4 2453.0 2852.0 2857.7 2871.9 16035.9 16446.3 16493.8 16534.8 16562.2 8871.8 9074.5 9102.9 9120.2 9139.5 5857.1 5907.4 5956.5 5997.4 6049.8 2129.7 2160.1 2165.2 2238.9 2253.4 31041.8 31102.7 31297.2 31314.7 31318.4 7360.9 7441.4 7454.6 7533.2 7614.4 20322.7 20330.5 20336.4 20349.2 20361.1 8510.2 8611.7 8639.0 8643.7 8675.5 7558.8 7754.0 7785.8 7788.8 7890.7 5820.2 5872.3 5904.6 5969.5 5987.9 1709.6 1752.9 1780.3 1790.5 1819.1 966.7 990.9 993.6 1001.4 1019.2 8579.1 8624.7 8676.2 8727.7 8763.6 802.9 815.1 815.5 817.4 836.0 5414.2 5823.9 5841.9 5979.2 5991.9 24911.4 25756.5 25971.1 25983.4 26003.1 23999.2 25168.2 25168.4 25370.2 25423.6 12006.8 12065.3 12171.9 12287.3 12315.9 9223.5 9292.2 9310.4 9348.5 9445.3 20568.4 21056.6 21414.0 21453.6 21490.8 21884.1 22292.2 22682.3 22824.5 23203.2 12555.2 12780.8 12784.7 12799.4 12801.1 15690.5 15997.6 16076.6 16078.4 16125.4 12624.9 12811.1 12900.9 12919.0 13186.5 12124.6 12239.6 12262.3 12342.6 12445.9 10353.4 10488.7 10605.5 10637.7 10708.3 8495.8 8561.8 8603.6 8670.6 8690.2 8316.6 8318.3 8438.5 8453.4 8471.8 09:35:43 INFO - PID 17794 | 09:35:43 INFO - PID 17794 | [#4] prototype.html Cycles:180 Average:5591.05 Median:6196.11 stddev:1563.24 (25.2%) stddev-sans-first:1521.08 09:35:43 INFO - PID 17794 | Values: 546.6 549.5 577.3 583.4 585.3 6240.7 6269.4 6291.8 6308.7 6331.4 6098.5 6120.3 6152.2 6233.3 6249.5 5012.4 5037.9 5048.4 5056.9 5078.3 4874.0 4906.8 4914.8 4963.8 5086.0 4870.8 4896.7 4922.5 4929.6 4939.6 4905.4 4908.8 4917.4 4956.1 4964.6 4521.5 4532.2 4532.4 4553.9 4564.3 6123.8 6150.7 6194.4 6197.8 6252.9 5720.2 5726.8 5737.3 5747.3 5830.3 6607.4 6653.3 6673.2 6714.8 6717.2 4811.1 5037.3 5055.9 5063.2 5065.8 6539.7 6744.3 6789.8 6865.9 6943.4 5096.3 5138.3 5148.6 5173.8 5174.7 5172.4 5200.7 5221.2 5229.0 5235.5 5758.3 5766.5 5774.8 5789.9 5821.4 6636.0 6643.6 6673.3 6678.7 6718.1 1768.5 1784.0 1795.5 1805.9 1810.0 1234.3 1255.6 1276.6 1277.8 1286.6 6005.5 6052.8 6055.4 6058.8 6087.4 6686.6 6716.5 6762.6 6782.5 6800.2 5896.4 6046.4 6074.0 6099.7 6135.3 3492.6 3507.6 3510.3 3548.5 3561.9 6634.3 6681.4 6728.5 6730.0 6830.6 6794.0 6866.5 6946.3 6973.4 6978.1 6781.0 6829.9 6881.6 6901.4 6982.0 6642.6 6727.8 6758.3 6806.9 6859.5 6662.3 6687.3 6754.4 6766.2 6767.0 6839.6 6852.0 6923.0 6937.8 6951.5 5111.1 5126.3 5128.4 5146.7 5153.8 6433.5 6624.3 6655.0 6692.2 6694.8 6464.8 6488.6 6544.1 6552.6 6582.1 6421.9 6441.2 6472.6 6518.6 6580.6 6429.1 6485.9 6501.9 6503.9 6522.4 6528.7 6608.7 6677.7 6678.9 6695.2 6415.6 6432.2 6451.0 6454.9 6470.9 09:35:43 INFO - PID 17794 | 09:35:43 INFO - PID 17794 | [#5] yui.html Cycles:180 Average:28746.80 Median:20084.00 stddev:41001.17 (204.1%) stddev-sans-first:41063.12 09:35:43 INFO - PID 17794 | Values: 965.0 978.4 982.9 988.6 999.9 20535.3 21334.0 21546.0 21549.0 21571.4 19476.8 19838.3 19874.3 20045.0 20115.7 1030.5 1050.5 1052.5 1052.8 1053.3 1057.6 1062.9 1063.6 1063.8 1064.7 1054.2 1114.1 1117.3 1119.4 1122.9 1106.9 1108.0 1109.8 1109.9 1110.4 817.7 818.3 818.5 819.6 820.1 21262.9 21942.6 21953.0 22008.2 22013.7 22912.9 23586.3 23754.6 23893.6 23895.2 18502.2 18699.9 18849.7 19041.7 19045.0 4047.6 4058.3 4059.0 4067.9 4081.6 152645.0 153468.0 154796.0 156591.2 158555.0 18286.1 18449.9 18589.0 18708.2 18956.0 35148.0 35191.5 35241.6 35307.1 35362.5 9441.4 9486.3 9503.6 9528.9 9530.6 4202.6 4248.7 4252.8 4272.1 4288.4 5902.9 5932.0 5954.6 5960.8 5990.5 1052.4 1078.2 1090.0 1094.6 1104.5 733.1 733.9 746.3 762.7 763.3 12377.4 12951.3 13376.7 13975.2 14105.2 737.7 747.1 750.2 753.5 758.2 5868.2 5927.1 5979.6 6073.0 6096.0 138287.0 139487.0 139493.0 140545.3 141102.2 105872.0 107494.0 125652.4 130171.3 134006.3 111480.0 111665.4 112886.0 115651.4 116072.4 12823.7 12905.9 13211.8 14367.9 14383.8 53629.7 54200.3 54756.5 55309.4 55755.7 91377.5 92386.6 93372.0 94606.5 95201.5 21684.3 21686.7 21692.9 21737.0 22019.3 22827.5 24190.4 24434.8 24468.9 24511.3 16261.7 16472.3 16738.6 16762.6 19705.7 18494.9 18687.0 18822.4 19493.7 19978.5 19978.7 20052.3 20137.4 21037.0 21297.5 15180.4 15290.9 15307.2 15377.9 15483.1 14658.3 14690.8 14994.3 15108.6 15380.8 09:35:43 INFO - PID 17794 | -------- Summary: end -------- 09:35:43 INFO - PID 17794 | 09:35:44 INFO - TEST-INFO | 17794: exit 0 09:35:44 INFO - TEST-OK | dromaeo_css | took 1107513ms 09:35:44 INFO - TEST-START | kraken 09:35:44 INFO - Initialising browser for kraken test... 09:35:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40562/getInfo.html -profile /tmp/tmpDnTSfN/profile 09:35:44 INFO - TEST-INFO | started process 18164 (/builds/slave/test/build/application/firefox/firefox http://localhost:40562/getInfo.html) 09:35:49 INFO - TEST-INFO | 18164: exit 0 09:35:49 INFO - Browser initialized. 09:35:49 INFO - Running cycle 1/1 for kraken test... 09:35:49 INFO - Using env: {'DISPLAY': ':0', 09:35:49 INFO - 'HOME': '/home/cltbld', 09:35:49 INFO - 'JSGC_DISABLE_POISONING': '1', 09:35:49 INFO - 'LANG': 'en_US.UTF-8', 09:35:49 INFO - 'LANGUAGE': 'en_US:en', 09:35:49 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:35:49 INFO - 'LOGNAME': 'cltbld', 09:35:49 INFO - 'MAIL': '/var/mail/cltbld', 09:35:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:35:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:35:49 INFO - 'MOZ_CRASHREPORTER': '1', 09:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:49 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:35:49 INFO - 'MOZ_NO_REMOTE': '1', 09:35:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:35:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:49 INFO - 'NO_EM_RESTART': '1', 09:35:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:49 INFO - 'PWD': '/builds/slave/test', 09:35:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:35:49 INFO - 'RUST_BACKTRACE': 'full', 09:35:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:35:49 INFO - 'SHELL': '/bin/bash', 09:35:49 INFO - 'SHLVL': '1', 09:35:49 INFO - 'TERM': 'linux', 09:35:49 INFO - 'TMOUT': '86400', 09:35:49 INFO - 'USER': 'cltbld', 09:35:49 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506008326.725708-285738623', 09:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:49 INFO - '_': '/tools/buildbot/bin/python'} 09:35:49 INFO - TEST-INFO | started process 18403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDnTSfN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:50 INFO - PID 18403 | 09:35:50 INFO - PID 18403 | (/builds/slave/test/build/application/firefox/firefox:18452): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:35:50 INFO - PID 18403 | 09:36:00 INFO - PID 18403 | RSS: Main: 147673088 09:36:00 INFO - PID 18403 | 09:36:03 INFO - PID 18403 | Cycle 1(1): loaded http://localhost:40562/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40562/tests/kraken/driver.html?testName=audio-beat-detection) 09:36:04 INFO - PID 18403 | RSS: Main: 152743936 09:36:04 INFO - PID 18403 | 09:36:06 INFO - PID 18403 | Cycle 1(1): loaded http://localhost:40562/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40562/tests/kraken/driver.html?testName=audio-dft) 09:36:07 INFO - PID 18403 | RSS: Main: 153341952 09:36:07 INFO - PID 18403 | 09:36:10 INFO - PID 18403 | Cycle 1(1): loaded http://localhost:40562/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40562/tests/kraken/driver.html?testName=audio-fft) 09:36:10 INFO - PID 18403 | RSS: Main: 149860352 09:36:10 INFO - PID 18403 | 09:36:12 INFO - PID 18403 | Cycle 1(1): loaded http://localhost:40562/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40562/tests/kraken/driver.html?testName=audio-oscillator) 09:36:13 INFO - PID 18403 | RSS: Main: 151404544 09:36:13 INFO - PID 18403 | 09:36:15 INFO - PID 18403 | Cycle 1(1): loaded http://localhost:40562/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40562/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:36:16 INFO - PID 18403 | RSS: Main: 150986752 09:36:16 INFO - PID 18403 | 09:36:19 INFO - PID 18403 | Cycle 1(1): loaded http://localhost:40562/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40562/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:19 INFO - PID 18403 | RSS: Main: 150913024 09:36:19 INFO - PID 18403 | 09:36:23 INFO - PID 18403 | Cycle 1(1): loaded http://localhost:40562/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40562/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:24 INFO - PID 18403 | RSS: Main: 152154112 09:36:24 INFO - PID 18403 | 09:36:27 INFO - PID 18403 | Cycle 1(1): loaded http://localhost:40562/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40562/tests/kraken/driver.html?testName=json-parse-financial) 09:36:27 INFO - PID 18403 | RSS: Main: 153645056 09:36:27 INFO - PID 18403 | 09:36:29 INFO - PID 18403 | Cycle 1(1): loaded http://localhost:40562/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40562/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:36:29 INFO - PID 18403 | RSS: Main: 153567232 09:36:29 INFO - PID 18403 | 09:36:31 INFO - PID 18403 | Cycle 1(1): loaded http://localhost:40562/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40562/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:36:31 INFO - PID 18403 | RSS: Main: 153460736 09:36:31 INFO - PID 18403 | 09:36:33 INFO - PID 18403 | Cycle 1(1): loaded http://localhost:40562/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40562/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:36:34 INFO - PID 18403 | RSS: Main: 150675456 09:36:34 INFO - PID 18403 | 09:36:37 INFO - PID 18403 | Cycle 1(1): loaded http://localhost:40562/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40562/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:36:37 INFO - PID 18403 | RSS: Main: 150843392 09:36:37 INFO - PID 18403 | 09:36:40 INFO - PID 18403 | Cycle 1(1): loaded http://localhost:40562/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40562/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:36:40 INFO - PID 18403 | RSS: Main: 151359488 09:36:40 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | Cycle 1(1): loaded http://localhost:40562/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40562/tests/kraken/driver.html?testName=ai-astar) 09:36:42 INFO - PID 18403 | RSS: Main: 153026560 09:36:42 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | __start_tp_report 09:36:42 INFO - PID 18403 | _x_x_mozilla_page_load 09:36:42 INFO - PID 18403 | _x_x_mozilla_page_load_details 09:36:42 INFO - PID 18403 | |i|pagename|runs| 09:36:42 INFO - PID 18403 | |0;ai-astar;105;105;106;106;107;107;108;106;104;104 09:36:42 INFO - PID 18403 | |1;audio-beat-detection;112;110;111;112;111;113;112;125;113;112 09:36:42 INFO - PID 18403 | |2;audio-dft;161;163;165;165;165;164;163;162;162;163 09:36:42 INFO - PID 18403 | |3;audio-fft;72;72;73;74;76;74;73;73;73;74 09:36:42 INFO - PID 18403 | |4;audio-oscillator;78;78;79;79;82;80;80;78;77;78 09:36:42 INFO - PID 18403 | |5;imaging-gaussian-blur;113;113;114;113;113;113;110;113;113;110 09:36:42 INFO - PID 18403 | |6;imaging-darkroom;149;149;149;150;148;150;150;149;149;149 09:36:42 INFO - PID 18403 | |7;imaging-desaturate;94;94;95;94;98;95;94;94;99;94 09:36:42 INFO - PID 18403 | |8;json-parse-financial;45;49;45;44;46;45;48;44;44;50 09:36:42 INFO - PID 18403 | |9;json-stringify-tinderbox;39;39;40;39;39;39;40;39;39;39 09:36:42 INFO - PID 18403 | |10;stanford-crypto-aes;76;76;71;78;74;76;73;76;71;71 09:36:42 INFO - PID 18403 | |11;stanford-crypto-ccm;108;104;107;105;106;104;102;111;108;103 09:36:42 INFO - PID 18403 | |12;stanford-crypto-pbkdf2;169;149;156;150;146;155;152;150;159;153 09:36:42 INFO - PID 18403 | |13;stanford-crypto-sha256-iterative;62;58;58;58;65;62;59;58;57;61 09:36:42 INFO - PID 18403 | __end_tp_report 09:36:42 INFO - PID 18403 | __start_cc_report 09:36:42 INFO - PID 18403 | _x_x_mozilla_cycle_collect,764 09:36:42 INFO - PID 18403 | __end_cc_report 09:36:42 INFO - PID 18403 | __startTimestamp1506011802878__endTimestamp 09:36:42 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | ------- Summary: start ------- 09:36:42 INFO - PID 18403 | Number of tests: 14 09:36:42 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | [#0] ai-astar Cycles:10 Average:105.80 Median:106.00 stddev:1.32 (1.2%) stddev-sans-first:1.36 09:36:42 INFO - PID 18403 | Values: 105.0 105.0 106.0 106.0 107.0 107.0 108.0 106.0 104.0 104.0 09:36:42 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | [#1] audio-beat-detection Cycles:10 Average:113.10 Median:112.00 stddev:4.28 (3.8%) stddev-sans-first:4.52 09:36:42 INFO - PID 18403 | Values: 112.0 110.0 111.0 112.0 111.0 113.0 112.0 125.0 113.0 112.0 09:36:42 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:1.42 (0.9%) stddev-sans-first:1.24 09:36:42 INFO - PID 18403 | Values: 161.0 163.0 165.0 165.0 165.0 164.0 163.0 162.0 162.0 163.0 09:36:42 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | [#3] audio-fft Cycles:10 Average:73.40 Median:73.50 stddev:1.17 (1.6%) stddev-sans-first:1.13 09:36:42 INFO - PID 18403 | Values: 72.0 72.0 73.0 74.0 76.0 74.0 73.0 73.0 73.0 74.0 09:36:42 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | [#4] audio-oscillator Cycles:10 Average:78.90 Median:79.00 stddev:1.45 (1.8%) stddev-sans-first:1.50 09:36:42 INFO - PID 18403 | Values: 78.0 78.0 79.0 79.0 82.0 80.0 80.0 78.0 77.0 78.0 09:36:42 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | [#5] imaging-gaussian-blur Cycles:10 Average:112.50 Median:113.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 09:36:42 INFO - PID 18403 | Values: 113.0 113.0 114.0 113.0 113.0 113.0 110.0 113.0 113.0 110.0 09:36:42 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 09:36:42 INFO - PID 18403 | Values: 149.0 149.0 149.0 150.0 148.0 150.0 150.0 149.0 149.0 149.0 09:36:42 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.50 stddev:1.85 (2.0%) stddev-sans-first:1.92 09:36:42 INFO - PID 18403 | Values: 94.0 94.0 95.0 94.0 98.0 95.0 94.0 94.0 99.0 94.0 09:36:42 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | [#8] json-parse-financial Cycles:10 Average:46.00 Median:45.50 stddev:2.21 (4.9%) stddev-sans-first:2.32 09:36:42 INFO - PID 18403 | Values: 45.0 49.0 45.0 44.0 46.0 45.0 48.0 44.0 44.0 50.0 09:36:42 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | [#9] json-stringify-tinderbox Cycles:10 Average:39.20 Median:39.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 09:36:42 INFO - PID 18403 | Values: 39.0 39.0 40.0 39.0 39.0 39.0 40.0 39.0 39.0 39.0 09:36:42 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:76.00 stddev:2.57 (3.4%) stddev-sans-first:2.65 09:36:42 INFO - PID 18403 | Values: 76.0 76.0 71.0 78.0 74.0 76.0 73.0 76.0 71.0 71.0 09:36:42 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | [#11] stanford-crypto-ccm Cycles:10 Average:105.80 Median:106.50 stddev:2.74 (2.6%) stddev-sans-first:2.79 09:36:42 INFO - PID 18403 | Values: 108.0 104.0 107.0 105.0 106.0 104.0 102.0 111.0 108.0 103.0 09:36:42 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:154.00 stddev:6.51 (4.2%) stddev-sans-first:3.99 09:36:42 INFO - PID 18403 | Values: 169.0 149.0 156.0 150.0 146.0 155.0 152.0 150.0 159.0 153.0 09:36:42 INFO - PID 18403 | 09:36:42 INFO - PID 18403 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.80 Median:60.00 stddev:2.57 (4.3%) stddev-sans-first:2.60 09:36:42 INFO - PID 18403 | Values: 62.0 58.0 58.0 58.0 65.0 62.0 59.0 58.0 57.0 61.0 09:36:42 INFO - PID 18403 | -------- Summary: end -------- 09:36:42 INFO - PID 18403 | 09:36:43 INFO - PID 18403 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:36:43 INFO - TEST-INFO | 18403: exit 0 09:36:43 INFO - TEST-OK | kraken | took 59133ms 09:36:43 INFO - SUITE-END | took 1166s 09:36:43 INFO - Completed test suite (00:19:26) 09:36:43 INFO - javascript benchmark 09:36:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9141.249037815518, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3777.18790460051, 3825.483559719438, 3827.961720382795, 3835.2904712628156, 3885.0870045539295, 6244.157038799761, 6257.843553911154, 6340.4610608098255, 6356.141920840691, 6376.776812811552, 6345.365463453652, 6362.427381535661, 6364.745410183587, 6369.299377068519, 6370.745170193199, 5634.0703783875615, 5654.745536450849, 5657.66054036757, 5699.145128230757, 5718.399568045358, 5752.108423194411, 5796.159556864273, 5797.130430435426, 5822.272215973004, 5846.2107615472005, 104.34119570997166, 5608.355039170507, 5683.374828768832, 5686.886262274752, 5820.214271073414, 5688.488036076773, 5753.683547404891, 5767.0772676372, 5768.855778605526, 5774.913376299359, 5652.74562644682, 5654.660720356751, 5724.4561766632105, 5727.713614319309, 5731.627444216113, 6237.40744629264, 6278.560500764948, 6304.527160462983, 6391.424771770517, 6417.550771446001, 6860.931390686079, 6895.448364130857, 6954.547954382949, 6959.373656370951, 6968.0, 6856.725730970755, 6955.65221738911, 6963.965180174117, 6968.860622787566, 7031.261717519638, 6381.298057213703, 6388.456981156607, 6402.551821372505, 6406.519511036644, 6502.869942601169, 7100.7869763907165, 7134.714611415589, 7144.785656430316, 7148.857022859618, 7216.8917466238045, 6735.4274886635185, 6738.393544581011, 6738.561993470409, 6807.4894382921475, 6809.0, 6762.357576030269, 6823.93176068233, 6851.691673874688, 6898.965505172542, 6966.721331146799, 6828.5220034597105, 6851.760188393482, 6853.451723862079, 6854.34883686049, 6860.416864566568, 6836.726530938806, 6926.272741362185, 6955.408790252784, 6958.338957799001, 7003.649817509104, 4987.60099192071, 5005.299258103868, 5045.924311135336, 5048.697078175322, 5072.365954255718, 4528.660350473728, 4548.31775233711, 4572.702774319659, 4599.586037256596, 4670.159371313128, 6261.530385221126, 6261.592996455216, 6271.905921411182, 6292.748290068437, 6294.024426213944, 6848.589084654936, 6856.0, 6861.142357205349, 6949.235584085746, 6969.2682268362105, 6167.938320616826, 6187.288461826947, 6259.280182778948, 6264.123022776815, 6274.403931626488, 5408.107662235766, 5504.587155963319, 5531.723413829292, 5551.833444996657, 5605.187247849039, 6975.162980442379, 7067.5052746307265, 7089.184743754534, 7093.0, 7098.219195888448, 6723.394894459424, 6795.422389096982, 6819.0, 6903.240643529108, 6911.343422374866, 6910.896336555056, 6966.303369663196, 7065.116860392451, 7079.22128565847, 7081.964590177016, 6745.291744366967, 6795.218549866631, 6821.727130914708, 6831.385175334244, 6846.863062738617, 6911.516193866381, 6914.896276555755, 6922.0, 6923.2038315594355, 6936.271691472524, 6578.177727784027, 6670.266270710315, 6683.131192944886, 6737.494687898329, 6754.696038678173, 6585.111010013587, 6618.602883826986, 6689.364510371507, 6695.09616201826, 6701.363370479797, 6501.382368674968, 6544.869102618016, 6554.80335589933, 6567.802965911031, 6568.540202185801, 6768.9661551691925, 6801.285864984304, 6808.148981377328, 6816.182058153054, 6855.451563874978, 6528.445082167879, 6528.934710653023, 6536.215654121535, 6632.303608121078, 6642.0], "value": 6232.79434497512, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [964.6671898195123, 991.7669347703288, 993.9105480506755, 997.067741661547, 997.5660587644376, 40675.59324406755, 44417.33373999388, 44480.77759611206, 44572.33141502872, 44631.77684111575, 40940.181196376056, 41180.14689338979, 41256.38115428271, 41257.174856502854, 41258.0, 7613.467057305991, 7704.306612404883, 8496.320294376435, 8698.826023479527, 8733.083026282244, 8509.617067231959, 8636.956815215946, 8637.568121593895, 8645.092265312145, 8648.740537783877, 8562.14378562145, 8658.350623703216, 8664.39349245553, 8675.349348798834, 8684.826303473927, 8614.095519970408, 8619.956900215522, 8633.827323453526, 8638.265747411446, 8658.740237792876, 8477.618507167192, 8527.062023177508, 8539.274161696263, 8540.572971351408, 8550.10223926485, 40320.0, 40386.39420408667, 40515.59484405148, 40699.59300407017, 40805.79597102025, 3792.051987003249, 3835.983464381941, 3836.1943991761486, 3838.596947320519, 3838.884833454973, 33243.833780831184, 33325.0, 33932.32135357304, 34026.82986585076, 34058.14854628629, 5362.1420572708175, 5464.9180262296095, 5570.303712035996, 5582.86042848928, 5602.467765562265, 216015.0, 216925.91537042373, 217158.0, 217548.0, 218198.0, 47673.52326476691, 48446.27330590044, 51386.48613513892, 51410.228846567334, 51515.7424212884, 55824.72087639617, 56757.0, 57012.71493642505, 57053.85892282131, 57100.71449642725, 17115.05867177317, 17154.05652689089, 17170.484885453458, 17249.0, 17294.827051729575, 14022.649433764238, 14078.71842563143, 14188.219647919463, 14210.431582736781, 14231.288435578179, 15137.318820653098, 15219.239038048054, 15241.542753717406, 15244.542663720105, 15343.07941523512, 5987.31145918225, 6049.8487537811025, 6168.013117901114, 6228.906566401508, 6285.497160227171, 1116.1740312168936, 1120.9775804483866, 1126.189143816451, 1133.6145710458484, 1145.9541618335172, 25640.74359256421, 25697.229083127535, 25747.0, 25893.223203303933, 25939.870300648752, 1191.1304747534348, 1210.7275862930946, 1221.7678641058171, 1223.4127618742875, 1242.3043095866344, 13618.591442256748, 13668.0, 13688.726225475435, 13762.449502020007, 13894.58316250494, 270130.0, 270161.0, 271180.0, 271207.0, 271557.0, 57534.424655752904, 57624.42375576274, 57649.13526297109, 57754.422455774904, 57774.7111264441, 1531.1731664901051, 1555.3312075807512, 1572.9842701572838, 1587.476132876148, 1589.6025993501626, 24971.0, 25334.239972800846, 25337.746622533537, 25358.0, 25640.358991025372, 41191.1761764769, 41212.58787412087, 41250.58749412587, 41297.380539291335, 41299.174016520104, 234846.0, 235012.0, 235594.0, 236086.0, 236348.0, 36374.271929605915, 37560.624393755716, 38074.238515228986, 38193.80903095467, 38217.80891095527, 48571.0, 49211.75394123006, 50062.0, 50249.24626130538, 50399.49600503948, 36138.0, 36502.8174859124, 36514.63485365112, 36769.448458273684, 36818.63181368152, 36397.636023639425, 36726.63273367339, 36746.63253367432, 36814.8159259202, 36825.63174368329, 41987.16025679408, 42513.149737005704, 42619.147617048104, 42844.57155428531, 42934.14131717411, 35141.0, 35294.47058294179, 35326.47010294796, 35461.46807797834, 35555.64444355523, 26358.472830542898, 26856.462870742867, 26953.460930780882, 27013.59479607847, 27141.321466963484], "value": 18945.589837215957, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.1544145916444, 609.2627920216535, 613.938606139386, 615.452247499725, 630.3916720364847, 23519.41201469962, 24230.51538969224, 24320.148794792185, 24349.26952191435, 24369.634455483138, 24566.631500527506, 26225.868870655668, 26438.20685379437, 26446.0, 26486.735132648668, 6728.2935291794265, 6798.5580937239165, 6831.4534837212905, 6836.0771295875165, 6838.179418469791, 6488.156539649839, 6494.480441564687, 6725.798226053202, 6735.057092007123, 6757.189137303506, 6691.330866913294, 6692.431143352821, 6701.798946031627, 6707.899381509281, 6708.83227919301, 6625.73497060117, 6653.7005834737065, 6677.599344039349, 6685.0640910272605, 6691.063251144844, 6200.627962322275, 6222.471089957314, 6235.220597425322, 6242.406971337761, 6254.781082662131, 28780.71219287822, 29258.0, 29803.105906822613, 29992.0, 30036.098917032523, 2221.1115553778454, 2229.5317983223545, 2247.831412644042, 2248.584011957793, 2257.7742225777456, 20306.883121428316, 20945.581088378298, 21053.052612632317, 21058.2629607963, 21065.47336316589, 2511.7739403453775, 2546.834455760388, 2559.0403598650505, 2612.0988259050596, 2638.2349118755537, 131769.0, 136849.0, 146675.0, 154908.0, 155400.99999999886, 15542.611434714223, 15810.762838557432, 15833.762493562606, 15930.761038584431, 16359.91820040916, 25278.368040799127, 25289.114880979447, 25307.355021923515, 25334.746652533606, 25345.112921048043, 10499.265051446326, 10748.355098694103, 10788.568457261621, 10806.459677016117, 10970.780584388267, 9833.901660983298, 9854.359466634645, 9867.753306167404, 10017.449040302708, 10040.849387259197, 9665.178459830853, 9747.512624368754, 10016.449095299828, 10131.645392411378, 10168.33905796121, 2931.299846089263, 2937.9559306610417, 2954.542045982876, 2968.9703102968692, 3009.0671891713637, 1011.2415688233824, 1038.7195457226508, 1040.3653771199563, 1049.6063976008998, 1052.0741747262514, 20652.0, 20778.896105519678, 21056.578868422544, 21147.259845905628, 21479.0, 1074.2909679611419, 1077.1221454514546, 1095.3756358875364, 1099.5272033025715, 1114.7101753543975, 11378.658640240807, 11643.602767667764, 11854.407279635983, 11857.932786049298, 11864.762704745857, 521481.0, 532561.0, 537318.3134084382, 545394.0, 550918.0, 122683.38658306829, 126994.0, 127955.0, 128592.3570382142, 128936.0, 1090.7273181704575, 1166.9474873630706, 1210.1831263896834, 1215.489494412349, 1259.5528587351541, 21483.0, 21590.0, 21820.563588728455, 22026.669599956334, 22178.00198991017, 59359.40640593539, 61147.694261528406, 61267.693661531404, 61654.0, 63140.68429657822, 77594.0, 77791.2220877784, 77810.6109469449, 77854.610726946, 78586.0, 15035.097894126387, 15097.54707358781, 15220.315085820943, 15220.923895380452, 15242.314095865935, 23355.76644233536, 23422.531549368578, 23785.167519136747, 23786.40533986664, 23852.761472385053, 19243.711344330128, 19401.902990484956, 19756.703649444982, 19768.0, 19917.701234481203, 16445.342186312413, 16583.0, 16611.335546578, 16667.66664666724, 16824.74762878533, 19820.40538783839, 19828.0, 19836.10737516844, 19883.801161988195, 19913.800861991196, 14885.106893586419, 14905.701885962004, 15139.772903406678, 15143.242837858283, 15163.62090947691, 18870.433886983414, 19060.809391905903, 19159.233630654617, 19314.517137071685, 19319.13063912099], "value": 12673.103691019383, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.6039748472942, 1474.3586539855164, 1475.9852401475982, 1483.903546269493, 1491.9254037298133, 16774.41289554864, 17513.56216094598, 17535.0, 17538.824611753895, 17542.12289385532, 17001.404950826724, 17004.149792510358, 17054.23255953482, 17130.31478740852, 17154.82845171548, 2926.3708302714913, 2942.573326867608, 2991.536311871663, 2998.3253767902156, 3003.6395632524127, 2891.8264904105718, 2912.3738396244803, 2914.5191043477803, 2915.766738660902, 2920.050983430383, 2846.1177035119076, 2862.7423531882127, 2886.0, 2972.6432828060665, 2975.642922849261, 2971.643402791657, 2987.7012298770164, 2990.312228187507, 3002.084364268897, 3005.8647360868704, 2389.4026493376655, 2452.9877350613133, 2851.9714802851913, 2857.7428031477266, 2871.8851245950136, 16035.91982040094, 16446.259918303705, 16493.83506164935, 16534.83465165345, 16562.17189140538, 8871.778205544848, 9074.455532667995, 9102.908970910272, 9120.179183873417, 9139.451632902048, 5857.062869940789, 5907.438793314628, 5956.463918247336, 5997.4002599740115, 6049.788257411014, 2129.7346788479535, 2160.12514931453, 2165.2421652421685, 2238.876861772602, 2253.4028482452, 31041.84479077613, 31102.68897311043, 31297.217569560715, 31314.651401145005, 31318.37363252745, 7360.926390736024, 7441.367483763941, 7454.5836291104515, 7533.227583081265, 7614.390848732088, 20322.695159572617, 20330.49173770638, 20336.389908302775, 20349.186032558828, 20361.083751231232, 8510.191531804468, 8611.655533778703, 8638.95680521606, 8643.697470588499, 8675.479471231747, 7558.811029724191, 7754.0, 7785.844283114306, 7788.805279868048, 7890.723824666109, 5820.24336836217, 5872.324682661463, 5904.5571582131515, 5969.462748352582, 5987.880242395127, 1709.598244412562, 1752.9474115776547, 1780.261191605495, 1790.5076104071484, 1819.0813639112428, 966.6761634852403, 990.895955924632, 993.6373223773415, 1001.4341896828269, 1019.2101121630795, 8579.053764725779, 8624.741257762276, 8676.175763302475, 8727.694530691522, 8763.649454021768, 802.8795680647833, 815.135955886762, 815.5392203405057, 817.4073796497611, 836.0385556609947, 5414.187871819258, 5823.854403639858, 5841.9192449397, 5979.19280897082, 5991.880162396815, 24911.377215569755, 25756.484870302487, 25971.091011814497, 25983.350416239744, 26003.089891853695, 23999.16002939889, 25168.24495265145, 25168.370790730012, 25370.238892833244, 25423.61864572033, 12006.759864802654, 12065.336406497552, 12171.939140304241, 12287.324197169242, 12315.93842030802, 9223.49270790113, 9292.210162136023, 9310.441373517611, 9348.485833279236, 9445.338826282368, 20568.382948511568, 21056.57886842224, 21414.0, 21453.57092858103, 21490.785092149505, 21884.124635015058, 22292.21977230789, 22682.319530414115, 22824.543509130057, 23203.187888423825, 12555.183913045623, 12780.808287875503, 12784.74430511403, 12799.360031998176, 12801.10392272532, 15690.529284121494, 15997.600059998593, 16076.598085047968, 16078.43725469603, 16125.354985800906, 12624.87375126237, 12811.103222774316, 12900.935495322463, 12919.0, 13186.472541098632, 12124.636260912186, 12239.571614993432, 12262.325572093263, 12342.568010119603, 12445.937770311091, 10353.378797272188, 10488.737781555523, 10605.469726513798, 10637.734056648645, 10708.250422470352, 8495.787605309917, 8561.82876342482, 8603.612837422455, 8670.566471676264, 8690.217880390795, 8316.62575184106, 8318.251357377865, 8438.451500652438, 8453.408261421888, 8471.788205294917], "value": 7403.334512086503, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.551827501449, 549.4532939724972, 577.3274135631989, 583.3845293215655, 585.3297973819979, 6240.687965601719, 6269.404406581373, 6291.842703932404, 6308.653024083674, 6331.398517140876, 6098.4511393974535, 6120.326764055962, 6152.230971128609, 6233.345498722637, 6249.5000399968, 5012.398512178544, 5037.924431133536, 5048.419431765339, 5056.898862022757, 5078.289039534468, 4873.975630121862, 4906.754662266891, 4914.827981020665, 4963.776630051656, 5085.974570127163, 4870.780814863322, 4896.657233993622, 4922.458529561745, 4929.580985616209, 4939.580135688453, 4905.435874874382, 4908.754562271872, 4917.385326834145, 4956.116675663261, 4964.6276529260085, 4521.480029796583, 4532.206863798822, 4532.388127602764, 4553.931691024637, 4564.292534657134, 6123.755049798003, 6150.708351246244, 6194.380561943814, 6197.845053873644, 6252.874942501125, 5720.170575266605, 5726.828195154152, 5737.254156959611, 5747.281589801275, 5830.329512106077, 6607.405333520006, 6653.2681405045405, 6673.165854268216, 6714.764983225564, 6717.16035495563, 4811.08589368019, 5037.345145131109, 5055.9241611375855, 5063.164577844651, 5065.797368105272, 6539.673016349164, 6744.325567443217, 6789.796306110775, 6865.949090036902, 6943.409810166142, 5096.337476128079, 5138.254953031789, 5148.58811295103, 5173.810023694496, 5174.689518628894, 5172.405173405106, 5200.6619569727845, 5221.242919776611, 5229.006488767122, 5235.455540615451, 5758.280214973129, 5766.538676905838, 5774.769009239583, 5789.884202316014, 5821.38875418075, 6636.0, 6643.634600097041, 6673.265940746514, 6678.732850686015, 6718.0517649880985, 1768.4606195110357, 1783.973240401395, 1795.4793109997954, 1805.909704514769, 1810.0, 1234.2594443333928, 1255.5605538061604, 1276.585109839306, 1277.8402699662543, 1286.5625687266374, 6005.498625343664, 6052.848678783065, 6055.424734650202, 6058.787942421994, 6087.421694938974, 6686.632235227012, 6716.529842910949, 6762.647470505918, 6782.491313151435, 6800.217974932946, 5896.380880007623, 6046.425589568984, 6074.0, 6099.664518451527, 6135.263768347827, 3492.633273506296, 3507.5618996211942, 3510.3330367230656, 3548.520949671761, 3561.893143205708, 6634.270230274666, 6681.398674119353, 6728.495362847708, 6729.966350168218, 6830.624315662686, 6794.0, 6866.450683945272, 6946.305369463013, 6973.430978030005, 6978.127734033246, 6780.966095169492, 6829.8634027318185, 6881.552699074544, 6901.378875901193, 6982.0, 6642.634655094016, 6727.764528241488, 6758.324167583202, 6806.9319306808275, 6859.485538584726, 6662.333766623493, 6687.29164688302, 6754.3921047106, 6766.15423072116, 6766.966165169143, 6839.589624622339, 6851.9657401712675, 6922.965385173042, 6937.826554336182, 6951.548149370275, 5111.083343746095, 5126.282320475062, 5128.410232823124, 5146.665466744649, 5153.793848246029, 6433.485321174388, 6624.271330153583, 6655.0, 6692.163479565054, 6694.832629184115, 6464.838379040561, 6488.643124628002, 6544.149260596282, 6552.6068435894, 6582.05829280373, 6421.903671445026, 6441.227052753699, 6472.644004579794, 6518.598501322239, 6580.605163690002, 6429.067785171217, 6485.8702825944165, 6501.934980650133, 6503.934960650333, 6522.380373864476, 6528.706208220547, 6608.7356505739235, 6677.7295719455615, 6678.899816502853, 6695.230048544479, 6415.550911436341, 6432.163818703539, 6450.967745161244, 6454.935450645434, 6470.902936455863], "value": 5142.4533654016805, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [964.9758756031094, 978.4129522286629, 982.9311948163629, 988.649029594494, 999.9000099989997, 20535.28126515572, 21334.0, 21546.0, 21549.030293636784, 21571.352859414223, 19476.805231947677, 19838.30565930193, 19874.304399346027, 20045.0, 20115.698264526043, 1030.4796077980627, 1050.4590136079887, 1052.5421441672859, 1052.8262836631945, 1053.3469249065552, 1057.6298295596519, 1062.8777690565569, 1063.5905176507063, 1063.8191507443753, 1064.6965614799783, 1054.225144518778, 1114.1309778372881, 1117.3407689463215, 1119.4123085380158, 1122.9157813164004, 1106.8837772033942, 1108.0, 1109.805783987807, 1109.944502774858, 1110.3670907582682, 817.6647574494489, 818.3289702443998, 818.4843548564367, 819.5902048975512, 820.122468958215, 21262.893685531628, 21942.561148777095, 21953.0, 22008.229711960004, 22013.66979495309, 22912.885435572716, 23586.292411227692, 23754.64368034481, 23893.641595376084, 23895.163669271667, 18502.167402466923, 18699.906500467547, 18849.717254241197, 19041.7143742844, 19045.0477476127, 4047.5547689754103, 4058.3100872851687, 4058.959410405888, 4067.857624983141, 4081.6122468365456, 152645.0, 153468.0, 154796.0, 156591.21704391405, 158554.99999999884, 18286.085695715163, 18449.907750461163, 18589.0, 18708.158132883782, 18956.0, 35148.0, 35191.4721279181, 35241.64758352384, 35307.117322067155, 35362.469562956576, 9441.386309889973, 9486.335956483117, 9503.57233924475, 9528.904710952802, 9530.571124299424, 4202.600752928467, 4248.723832950848, 4252.808623611945, 4272.102858399709, 4288.442502474658, 5902.8819423611285, 5931.970340148272, 5954.612950158225, 5960.821175364746, 5990.490808281258, 1052.4474650808233, 1078.191356482638, 1090.0407641275785, 1094.6059418609295, 1104.4864138175788, 733.0653416893397, 733.9119305683353, 746.3394895517506, 762.6872982077322, 763.3320844261272, 12377.381130943417, 12951.287679177547, 13376.732465350833, 13975.231362275172, 14105.224212668401, 737.6574634165873, 747.114669117098, 750.1770697205733, 753.4650398217218, 758.2228216078564, 5868.237129173265, 5927.051671732502, 5979.581429299994, 6072.969635151796, 6095.969520152371, 138287.0, 139487.0, 139493.0, 140545.297273513, 141102.19689585446, 105872.0, 107494.0, 125652.37173814072, 130171.34914325368, 134006.3299683515, 111480.0, 111665.44167279275, 112886.0, 115651.42174288907, 116072.41963790127, 12823.743525129632, 12905.870941290466, 13211.801822972471, 14367.928160359132, 14383.784243236569, 53629.7318513405, 54200.28998550135, 54756.452435475134, 55309.44690553043, 55755.72122139364, 91377.54311228401, 92386.64330393281, 93372.0, 94606.52696736748, 95201.52399237959, 21684.34946951594, 21686.6746998792, 21692.891535542854, 21737.021834017192, 22019.339419817432, 22827.543449131255, 24190.395240119138, 24434.755652443248, 24468.877655611606, 24511.264662060166, 16261.674766504368, 16472.258748356115, 16738.58153546171, 16762.58093547671, 19705.704414434083, 18494.907525462288, 18687.0, 18822.435326940213, 19493.70759438638, 19978.501612378837, 19978.70031949493, 20052.298169563994, 20137.39587812368, 21037.0, 21297.467563311042, 15180.392784288504, 15290.923545382202, 15307.15810630426, 15377.923110384376, 15483.148426836633, 14658.340374683377, 14690.779638305648, 14994.325255363752, 15108.622284442978, 15380.846191538389], "value": 10240.808873865033, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1370.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 106.0, 106.0, 107.0, 107.0, 108.0, 106.0, 104.0, 104.0], "value": 105.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 111.0, 112.0, 111.0, 113.0, 112.0, 125.0, 113.0, 112.0], "value": 113.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 165.0, 165.0, 165.0, 164.0, 163.0, 162.0, 162.0, 163.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 74.0, 76.0, 74.0, 73.0, 73.0, 73.0, 74.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 79.0, 82.0, 80.0, 80.0, 78.0, 77.0, 78.0], "value": 78.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 110.0, 113.0, 113.0, 110.0], "value": 112.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 150.0, 148.0, 150.0, 150.0, 149.0, 149.0, 149.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 98.0, 95.0, 94.0, 94.0, 99.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 49.0, 45.0, 44.0, 46.0, 45.0, 48.0, 44.0, 44.0, 50.0], "value": 46.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 40.0, 39.0, 39.0, 39.0, 40.0, 39.0, 39.0, 39.0], "value": 39.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 71.0, 78.0, 74.0, 76.0, 73.0, 76.0, 71.0, 71.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 104.0, 107.0, 105.0, 106.0, 104.0, 102.0, 111.0, 108.0, 103.0], "value": 105.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 149.0, 156.0, 150.0, 146.0, 155.0, 152.0, 150.0, 159.0, 153.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 58.0, 58.0, 58.0, 65.0, 62.0, 59.0, 58.0, 57.0, 61.0], "value": 59.8, "unit": "score"}]}]} 09:36:43 INFO - Return code: 0 09:36:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:36:43 INFO - # TBPL SUCCESS # 09:36:43 INFO - Running post-action listener: _package_coverage_data 09:36:43 INFO - Running post-action listener: _resource_record_post_action 09:36:43 INFO - [mozharness: 2017-09-21 16:36:43.687933Z] Finished run-tests step (success) 09:36:43 INFO - Running post-run listener: _resource_record_post_run 09:36:43 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 331182080; Read time: 4; Write time: 166280 09:36:43 INFO - TinderboxPrint: CPU usage
13.1% 09:36:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 09:36:43 INFO - TinderboxPrint: I/O write bytes / time
331,182,080 / 166,280 09:36:43 INFO - TinderboxPrint: CPU idle
8,213.3 (86.9%) 09:36:43 INFO - TinderboxPrint: CPU user
1,186.1 (12.6%) 09:36:43 INFO - TinderboxPrint: Swap in / out
0 / 0 09:36:43 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13406208; Read time: 0; Write time: 1028 09:36:43 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:36:43 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 4096; Write bytes: 317775872; Read time: 4; Write time: 165252 09:36:44 INFO - Running post-run listener: _upload_blobber_files 09:36:44 INFO - Blob upload gear active. 09:36:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:36:44 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 09:36:44 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'] 09:36:44 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 09:36:44 INFO - (blobuploader) - INFO - Open directory for files ... 09:36:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:36:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:36:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:45 INFO - (blobuploader) - INFO - Done attempting. 09:36:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:36:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:36:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:46 INFO - (blobuploader) - INFO - Done attempting. 09:36:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:36:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:36:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:53 INFO - (blobuploader) - INFO - Done attempting. 09:36:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:36:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:36:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:54 INFO - (blobuploader) - INFO - Done attempting. 09:36:54 INFO - (blobuploader) - INFO - Iteration through files over. 09:36:54 INFO - Return code: 0 09:36:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:36:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:36:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33f353f46d16f372dde17c3caf81ed11e6cac9c0f29a5e7ba4177fd2bb3f595999111ff0c85b92f286b66f5f00f45cb8e29bf429781993de83e59a563cabb858", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92d18b404392d8a13cd84506c8e27cf82aadc4ec8aa6d367275d6c480cae9d64aa771af2d7341d05834a5d68a0087face2631e3eaf0a4eff7e96178ef7f0cead", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afd78dc4dc95a3019f439f70156caa9ef90450b1e6a4dd1e747c6288efbed12b6f7b963af0526d25b0434609e0d767c07c5b2a7b39fc084ee0aa44d1883adb6a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9463d662184a99b8df3960e12d9f63cdb6bc3273f8b0661dac70c8bcd01b3b9af2ad5b87d52d7fec3fb8805ea13369c88194b56e65bb5dadc7495101e722e4c8"} 09:36:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:36:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:36:54 INFO - Contents: 09:36:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33f353f46d16f372dde17c3caf81ed11e6cac9c0f29a5e7ba4177fd2bb3f595999111ff0c85b92f286b66f5f00f45cb8e29bf429781993de83e59a563cabb858", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92d18b404392d8a13cd84506c8e27cf82aadc4ec8aa6d367275d6c480cae9d64aa771af2d7341d05834a5d68a0087face2631e3eaf0a4eff7e96178ef7f0cead", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afd78dc4dc95a3019f439f70156caa9ef90450b1e6a4dd1e747c6288efbed12b6f7b963af0526d25b0434609e0d767c07c5b2a7b39fc084ee0aa44d1883adb6a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9463d662184a99b8df3960e12d9f63cdb6bc3273f8b0661dac70c8bcd01b3b9af2ad5b87d52d7fec3fb8805ea13369c88194b56e65bb5dadc7495101e722e4c8"} 09:36:54 INFO - Running post-run listener: copy_logs_to_upload_dir 09:36:54 INFO - Copying logs to upload dir... 09:36:54 INFO - mkdir: /builds/slave/test/build/upload/logs 09:36:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.708027 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-09-21 09:36:54.713959) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 09:36:54.717997) ========= 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=483e410453545d07cca6935c000001ab-1506008326.725708-285738623 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/33f353f46d16f372dde17c3caf81ed11e6cac9c0f29a5e7ba4177fd2bb3f595999111ff0c85b92f286b66f5f00f45cb8e29bf429781993de83e59a563cabb858", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92d18b404392d8a13cd84506c8e27cf82aadc4ec8aa6d367275d6c480cae9d64aa771af2d7341d05834a5d68a0087face2631e3eaf0a4eff7e96178ef7f0cead", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afd78dc4dc95a3019f439f70156caa9ef90450b1e6a4dd1e747c6288efbed12b6f7b963af0526d25b0434609e0d767c07c5b2a7b39fc084ee0aa44d1883adb6a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9463d662184a99b8df3960e12d9f63cdb6bc3273f8b0661dac70c8bcd01b3b9af2ad5b87d52d7fec3fb8805ea13369c88194b56e65bb5dadc7495101e722e4c8"} build_url:https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011385 build_url: 'https://queue.taskcluster.net/v1/task/RdvTSP4wRdmQav5H4boEug/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33f353f46d16f372dde17c3caf81ed11e6cac9c0f29a5e7ba4177fd2bb3f595999111ff0c85b92f286b66f5f00f45cb8e29bf429781993de83e59a563cabb858", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92d18b404392d8a13cd84506c8e27cf82aadc4ec8aa6d367275d6c480cae9d64aa771af2d7341d05834a5d68a0087face2631e3eaf0a4eff7e96178ef7f0cead", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afd78dc4dc95a3019f439f70156caa9ef90450b1e6a4dd1e747c6288efbed12b6f7b963af0526d25b0434609e0d767c07c5b2a7b39fc084ee0aa44d1883adb6a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9463d662184a99b8df3960e12d9f63cdb6bc3273f8b0661dac70c8bcd01b3b9af2ad5b87d52d7fec3fb8805ea13369c88194b56e65bb5dadc7495101e722e4c8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 09:36:54.747139) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:36:54.747578) ========= 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=483e410453545d07cca6935c000001ab-1506008326.725708-285738623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:36:54.829997) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 09:36:54.830360) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 09:36:54.830856) ========= ========= Total master_lag: 0.21 =========