builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1506106644.97 results: success (0) revision: 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:24.968141) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:24.968792) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:24.969083) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:25.020149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:25.020538) ========= 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=5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-22 11:57:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-09-22 11:57:24 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.075319 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:25.128787) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:25.129148) ========= 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=5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019709 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:25.189479) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:25.189963) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 --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 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 --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=5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-22 11:57:25,075 truncating revision to first 12 chars 2017-09-22 11:57:25,075 Setting DEBUG logging. 2017-09-22 11:57:25,075 attempt 1/10 2017-09-22 11:57:25,075 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/14db7c0bcf9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-22 11:57:25,494 unpacking tar archive at: mozilla-central-14db7c0bcf9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716357 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:25.925814) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:25.926170) ========= script_repo_revision: 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:25.926602) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:25.926872) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:25.940616) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-22 11:57:25.941017) ========= /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=5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:57:25 INFO - MultiFileLogger online at 20170922 11:57:25 in /builds/slave/test 11:57:25 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 11:57:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:57:25 INFO - {'append_to_log': False, 11:57:25 INFO - 'base_work_dir': '/builds/slave/test', 11:57:25 INFO - 'blob_upload_branch': 'Firefox', 11:57:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:57:25 INFO - 'branch': 'Firefox', 11:57:25 INFO - 'buildbot_json_path': 'buildprops.json', 11:57:25 INFO - 'code_coverage': False, 11:57:25 INFO - 'config_files': ('talos/linux_config.py',), 11:57:25 INFO - 'default_actions': ('clobber', 11:57:25 INFO - 'read-buildbot-config', 11:57:25 INFO - 'download-and-extract', 11:57:25 INFO - 'populate-webroot', 11:57:25 INFO - 'create-virtualenv', 11:57:25 INFO - 'install', 11:57:25 INFO - 'setup-mitmproxy', 11:57:25 INFO - 'run-tests'), 11:57:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:57:25 INFO - 'disable_ccov_upload': False, 11:57:25 INFO - 'disable_stylo': False, 11:57:25 INFO - 'download_minidump_stackwalk': True, 11:57:25 INFO - 'download_symbols': 'ondemand', 11:57:25 INFO - 'enable_stylo': False, 11:57:25 INFO - 'enable_webrender': False, 11:57:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:57:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:57:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:57:25 INFO - 'gecko_profile': False, 11:57:25 INFO - 'gecko_profile_interval': 0, 11:57:25 INFO - 'installer_path': 'installer.exe', 11:57:25 INFO - 'log_level': 'info', 11:57:25 INFO - 'log_name': 'talos', 11:57:25 INFO - 'log_to_console': True, 11:57:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:57:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:57:25 INFO - 'opt_config_files': (), 11:57:25 INFO - 'pip_index': False, 11:57:25 INFO - 'suite': 'dromaeojs-e10s', 11:57:25 INFO - 'system_bits': '32', 11:57:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:57:25 INFO - 'title': 'talos-linux64-ix-039', 11:57:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:57:25 INFO - 'use_talos_json': True, 11:57:25 INFO - 'verify': 'False', 11:57:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:57:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:57:25 INFO - 'work_dir': 'build'} 11:57:25 INFO - [mozharness: 2017-09-22 18:57:25.961499Z] Running clobber step. 11:57:25 INFO - Running pre-action listener: _resource_record_pre_action 11:57:25 INFO - Running main action method: clobber 11:57:25 INFO - rmtree: /builds/slave/test/build 11:57:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:57:27 INFO - Running post-action listener: _resource_record_post_action 11:57:27 INFO - [mozharness: 2017-09-22 18:57:27.490487Z] Finished clobber step (success) 11:57:27 INFO - [mozharness: 2017-09-22 18:57:27.490585Z] Running read-buildbot-config step. 11:57:27 INFO - Running pre-action listener: _resource_record_pre_action 11:57:27 INFO - Running main action method: read_buildbot_config 11:57:27 INFO - Using buildbot properties: 11:57:27 INFO - { 11:57:27 INFO - "project": "", 11:57:27 INFO - "product": "firefox", 11:57:27 INFO - "who": "ffxbld@noreply.mozilla.org", 11:57:27 INFO - "installer_path": "public/build/target.tar.bz2", 11:57:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:57:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:57:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:57:27 INFO - "stage_platform": "linux64-pgo", 11:57:27 INFO - "basedir": "/builds/slave/test", 11:57:27 INFO - "buildnumber": 195, 11:57:27 INFO - "platform": "ubuntu64_hw", 11:57:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:57:27 INFO - "slavebuilddir": "test", 11:57:27 INFO - "taskId": "RdNE8OiWTVuJoXGoUTCwFQ", 11:57:27 INFO - "branch": "mozilla-central", 11:57:27 INFO - "script_repo_revision": "production", 11:57:27 INFO - "revision": "14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9", 11:57:27 INFO - "slavename": "talos-linux64-ix-039", 11:57:27 INFO - "repo_path": "mozilla-central" 11:57:27 INFO - } 11:57:27 INFO - Finding installer, test and symbols from parent task. 11:57:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RdNE8OiWTVuJoXGoUTCwFQ'}, attempt #1 11:57:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RdNE8OiWTVuJoXGoUTCwFQ'}, attempt #1 11:57:28 INFO - Task dependencies: eHaD7yk7Raabj2tPqEg75A 11:57:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A'}, attempt #1 11:57:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.tar.bz2 11:57:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.test_packages.json 11:57:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.crashreporter-symbols.zip 11:57:28 INFO - Running post-action listener: _resource_record_post_action 11:57:28 INFO - [mozharness: 2017-09-22 18:57:28.877211Z] Finished read-buildbot-config step (success) 11:57:28 INFO - [mozharness: 2017-09-22 18:57:28.877429Z] Running download-and-extract step. 11:57:28 INFO - Running pre-action listener: _resource_record_pre_action 11:57:28 INFO - Running main action method: download_and_extract 11:57:28 INFO - mkdir: /builds/slave/test/build/tests 11:57:28 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')]} 11:57:28 INFO - trying https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.test_packages.json 11:57:28 INFO - Downloading https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:57:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:57:29 INFO - Downloaded 989 bytes. 11:57:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:57:29 INFO - Using the following test package requirements: 11:57:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:57:29 INFO - u'common': [u'target.common.tests.zip'], 11:57:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:57:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:57:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:57:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:57:29 INFO - u'mozbase': [u'target.common.tests.zip'], 11:57:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:57:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:57:29 INFO - u'web-platform': [u'target.common.tests.zip', 11:57:29 INFO - u'target.web-platform.tests.tar.gz'], 11:57:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:57:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:57:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.common.tests.zip 11:57:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:57:29 INFO - Fetch https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.common.tests.zip into memory 11:57:31 INFO - Content-Length response header: 55280041 11:57:31 INFO - Bytes received: 55280041 11:57:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.talos.tests.zip 11:57:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:57:42 INFO - Fetch https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.talos.tests.zip into memory 11:57:43 INFO - Content-Length response header: 14513414 11:57:43 INFO - Bytes received: 14513414 11:57: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')]} 11:57:44 INFO - trying https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.tar.bz2 11:57:44 INFO - Downloading https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:57:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:57:46 INFO - Downloaded 62319854 bytes. 11:57:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.tar.bz2 11:57:47 INFO - mkdir: /builds/slave/test/properties 11:57:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:57:47 INFO - Writing to file /builds/slave/test/properties/build_url 11:57:47 INFO - Contents: 11:57:47 INFO - build_url:https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.tar.bz2 11:57:47 INFO - Running post-action listener: _resource_record_post_action 11:57:47 INFO - Running post-action listener: find_tests_for_verification 11:57:47 INFO - Running post-action listener: set_extra_try_arguments 11:57:47 INFO - [mozharness: 2017-09-22 18:57:47.206704Z] Finished download-and-extract step (success) 11:57:47 INFO - [mozharness: 2017-09-22 18:57:47.206936Z] Running populate-webroot step. 11:57:47 INFO - Running pre-action listener: _resource_record_pre_action 11:57:47 INFO - Running main action method: populate_webroot 11:57:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:57:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:47 INFO - 'tests': ['tresize', 11:57:47 INFO - 'tcanvasmark']}, 11:57:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:57:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:47 INFO - 'tests': ['dromaeo_css', 11:57:47 INFO - 'kraken']}, 11:57:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:57:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:57:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:57:47 INFO - 'talos_options': ['--disable-stylo'], 11:57:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:57:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:57:47 INFO - 'tests': ['damp', 'tps']}, 11:57:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:57:47 INFO - 'talos_options': ['--disable-stylo'], 11:57:47 INFO - 'tests': ['damp', 'tps']}, 11:57:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:57:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:47 INFO - 'tests': ['dromaeo_dom']}, 11:57:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:57:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:47 INFO - 'tests': ['basic_compositor_video', 11:57:47 INFO - 'glvideo']}, 11:57:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:57:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:57:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:57:47 INFO - 'talos_options': ['--disable-stylo'], 11:57:47 INFO - 'tests': ['ts_paint_webext', 11:57:47 INFO - 'tp5o_webext']}, 11:57:47 INFO - 'other-e10s': {'tests': ['a11yr', 11:57:47 INFO - 'ts_paint', 11:57:47 INFO - 'tpaint', 11:57:47 INFO - 'sessionrestore', 11:57:47 INFO - 'sessionrestore_many_windows', 11:57:47 INFO - 'sessionrestore_no_auto_restore', 11:57:47 INFO - 'tabpaint']}, 11:57:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:47 INFO - 'tests': ['a11yr', 11:57:47 INFO - 'ts_paint', 11:57:47 INFO - 'tpaint', 11:57:47 INFO - 'sessionrestore', 11:57:47 INFO - 'sessionrestore_many_windows', 11:57:47 INFO - 'sessionrestore_no_auto_restore', 11:57:47 INFO - 'tabpaint']}, 11:57:47 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:57:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:57:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:47 INFO - 'tests': ['perf_reftest_singletons']}, 11:57:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:47 INFO - 'tests': ['perf_reftest']}, 11:57:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:57:47 INFO - 'tsvgr_opacity', 11:57:47 INFO - 'tart', 11:57:47 INFO - 'tscrollx', 11:57:47 INFO - 'tsvg_static']}, 11:57:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:47 INFO - 'tests': ['tsvgx', 11:57:47 INFO - 'tsvgr_opacity', 11:57:47 INFO - 'tart', 11:57:47 INFO - 'tscrollx', 11:57:47 INFO - 'tsvg_static']}, 11:57:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:57:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:57:47 INFO - 'talos_options': ['--disable-stylo'], 11:57:47 INFO - 'tests': ['tp5o']}, 11:57:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:57:47 INFO - 'talos_options': ['--mitmproxy', 11:57:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:57:47 INFO - '--firstNonBlankPaint'], 11:57:47 INFO - 'tests': ['tp6_google', 11:57:47 INFO - 'tp6_youtube', 11:57:47 INFO - 'tp6_amazon', 11:57:47 INFO - 'tp6_facebook']}, 11:57:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:57:47 INFO - 'talos_options': ['--disable-stylo', 11:57:47 INFO - '--mitmproxy', 11:57:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:57:47 INFO - '--firstNonBlankPaint'], 11:57:47 INFO - 'tests': ['tp6_google', 11:57:47 INFO - 'tp6_youtube', 11:57:47 INFO - 'tp6_amazon', 11:57:47 INFO - 'tp6_facebook']}, 11:57:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:57:47 INFO - 'talos_options': ['--stylo-threads=1', 11:57:47 INFO - '--mitmproxy', 11:57:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:57:47 INFO - '--firstNonBlankPaint'], 11:57:47 INFO - 'tests': ['tp6_google', 11:57:47 INFO - 'tp6_youtube', 11:57:47 INFO - 'tp6_amazon', 11:57:47 INFO - 'tp6_facebook']}, 11:57:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:57:47 INFO - 'talos_options': ['--xperf_path', 11:57:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:57:47 INFO - 'tests': ['tp5n']}, 11:57:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:57:47 INFO - 'talos_options': ['--disable-stylo', 11:57:47 INFO - '--xperf_path', 11:57:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:57:47 INFO - 'tests': ['tp5n']}}} 11:57:47 INFO - Running post-action listener: _resource_record_post_action 11:57:47 INFO - [mozharness: 2017-09-22 18:57:47.228376Z] Finished populate-webroot step (success) 11:57:47 INFO - [mozharness: 2017-09-22 18:57:47.228467Z] Running create-virtualenv step. 11:57:47 INFO - Running pre-action listener: _resource_record_pre_action 11:57:47 INFO - Running main action method: create_virtualenv 11:57:47 INFO - Creating virtualenv /builds/slave/test/build/venv 11:57:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:57:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:57:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:57:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:57:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:57:47 INFO - Installing distribute.............................................................................................................................................................................................done. 11:57:48 INFO - Installing pip...............done. 11:57:48 INFO - Return code: 0 11:57:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:57:48 INFO - Reading from file tmpfile_stdout 11:57:48 INFO - Output received: 11:57:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:57:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1922a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9090>, '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 0x1ac9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', '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 11:57:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:57:48 INFO - Using env: {'DISPLAY': ':0', 11:57:48 INFO - 'HOME': '/home/cltbld', 11:57:48 INFO - 'LANG': 'en_US.UTF-8', 11:57:48 INFO - 'LANGUAGE': 'en_US:en', 11:57:48 INFO - 'LOGNAME': 'cltbld', 11:57:48 INFO - 'MAIL': '/var/mail/cltbld', 11:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:48 INFO - 'MOZ_NO_REMOTE': '1', 11:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:48 INFO - 'NO_EM_RESTART': '1', 11:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:48 INFO - 'PWD': '/builds/slave/test', 11:57:48 INFO - 'SHELL': '/bin/bash', 11:57:48 INFO - 'SHLVL': '1', 11:57:48 INFO - 'TERM': 'linux', 11:57:48 INFO - 'TMOUT': '86400', 11:57:48 INFO - 'USER': 'cltbld', 11:57:48 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', 11:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:48 INFO - '_': '/tools/buildbot/bin/python'} 11:57:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:57:49 INFO - Downloading/unpacking pip>=1.5 11:57:49 INFO - Running setup.py egg_info for package pip 11:57:49 INFO - warning: no files found matching 'pip/cacert.pem' 11:57:49 INFO - warning: no files found matching '*.html' under directory 'docs' 11:57:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:57:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:57:49 INFO - Installing collected packages: pip 11:57:49 INFO - Found existing installation: pip 1.1 11:57:49 INFO - Uninstalling pip: 11:57:49 INFO - Successfully uninstalled pip 11:57:49 INFO - Running setup.py install for pip 11:57:49 INFO - warning: no files found matching 'pip/cacert.pem' 11:57:49 INFO - warning: no files found matching '*.html' under directory 'docs' 11:57:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:57:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:57:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:57:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:57:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:57:49 INFO - Successfully installed pip 11:57:49 INFO - Cleaning up... 11:57:49 INFO - Return code: 0 11:57:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:49 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 0x17591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1922a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9090>, '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 0x1ac9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', '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 11:57:49 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 11:57:49 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 11:57:49 INFO - Using env: {'DISPLAY': ':0', 11:57:49 INFO - 'HOME': '/home/cltbld', 11:57:49 INFO - 'LANG': 'en_US.UTF-8', 11:57:49 INFO - 'LANGUAGE': 'en_US:en', 11:57:49 INFO - 'LOGNAME': 'cltbld', 11:57:49 INFO - 'MAIL': '/var/mail/cltbld', 11:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:49 INFO - 'MOZ_NO_REMOTE': '1', 11:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:49 INFO - 'NO_EM_RESTART': '1', 11:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:49 INFO - 'PWD': '/builds/slave/test', 11:57:49 INFO - 'SHELL': '/bin/bash', 11:57:49 INFO - 'SHLVL': '1', 11:57:49 INFO - 'TERM': 'linux', 11:57:49 INFO - 'TMOUT': '86400', 11:57:49 INFO - 'USER': 'cltbld', 11:57:49 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', 11:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:49 INFO - '_': '/tools/buildbot/bin/python'} 11:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:49 INFO - Downloading/unpacking psutil>=3.1.1 11:57:49 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 11:57:49 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 11:57:49 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 11:57:49 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 11:57:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:57:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:57:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:57:50 INFO - Installing collected packages: psutil 11:57:50 INFO - Running setup.py install for psutil 11:57:50 INFO - building 'psutil._psutil_linux' extension 11:57:50 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 11:57:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:57:51 INFO - building 'psutil._psutil_posix' extension 11:57:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:57:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:57:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:57:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:57:51 INFO - Successfully installed psutil 11:57:51 INFO - Cleaning up... 11:57:51 INFO - Return code: 0 11:57:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1922a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9090>, '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 0x1ac9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', '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 11:57:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:57:51 INFO - Using env: {'DISPLAY': ':0', 11:57:51 INFO - 'HOME': '/home/cltbld', 11:57:51 INFO - 'LANG': 'en_US.UTF-8', 11:57:51 INFO - 'LANGUAGE': 'en_US:en', 11:57:51 INFO - 'LOGNAME': 'cltbld', 11:57:51 INFO - 'MAIL': '/var/mail/cltbld', 11:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:51 INFO - 'MOZ_NO_REMOTE': '1', 11:57:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:51 INFO - 'NO_EM_RESTART': '1', 11:57:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:51 INFO - 'PWD': '/builds/slave/test', 11:57:51 INFO - 'SHELL': '/bin/bash', 11:57:51 INFO - 'SHLVL': '1', 11:57:51 INFO - 'TERM': 'linux', 11:57:51 INFO - 'TMOUT': '86400', 11:57:51 INFO - 'USER': 'cltbld', 11:57:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', 11:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:51 INFO - '_': '/tools/buildbot/bin/python'} 11:57:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:57:52 INFO - Installing collected packages: mozsystemmonitor 11:57:52 INFO - Running setup.py install for mozsystemmonitor 11:57:52 INFO - Successfully installed mozsystemmonitor 11:57:52 INFO - Cleaning up... 11:57:53 INFO - Return code: 0 11:57:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1922a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9090>, '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 0x1ac9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', '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 11:57:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:57:53 INFO - Using env: {'DISPLAY': ':0', 11:57:53 INFO - 'HOME': '/home/cltbld', 11:57:53 INFO - 'LANG': 'en_US.UTF-8', 11:57:53 INFO - 'LANGUAGE': 'en_US:en', 11:57:53 INFO - 'LOGNAME': 'cltbld', 11:57:53 INFO - 'MAIL': '/var/mail/cltbld', 11:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:53 INFO - 'MOZ_NO_REMOTE': '1', 11:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:53 INFO - 'NO_EM_RESTART': '1', 11:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:53 INFO - 'PWD': '/builds/slave/test', 11:57:53 INFO - 'SHELL': '/bin/bash', 11:57:53 INFO - 'SHLVL': '1', 11:57:53 INFO - 'TERM': 'linux', 11:57:53 INFO - 'TMOUT': '86400', 11:57:53 INFO - 'USER': 'cltbld', 11:57:53 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', 11:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:53 INFO - '_': '/tools/buildbot/bin/python'} 11:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:53 INFO - Downloading/unpacking jsonschema==2.5.1 11:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:57:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:55 INFO - Downloading functools32-3.2.3-2.tar.gz 11:57:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:57:55 INFO - warning: no files found matching '*.txt' 11:57:55 INFO - no previously-included directories found matching 'build' 11:57:55 INFO - no previously-included directories found matching 'dist' 11:57:55 INFO - no previously-included directories found matching '.git*' 11:57:55 INFO - Installing collected packages: jsonschema, functools32 11:57:55 INFO - Running setup.py install for functools32 11:57:56 INFO - warning: no files found matching '*.txt' 11:57:56 INFO - no previously-included directories found matching 'build' 11:57:56 INFO - no previously-included directories found matching 'dist' 11:57:56 INFO - no previously-included directories found matching '.git*' 11:57:57 INFO - Successfully installed jsonschema functools32 11:57:57 INFO - Cleaning up... 11:57:57 INFO - Return code: 0 11:57:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:57:57 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')]} 11:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:57 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')]} 11:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:57 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 0x17591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1922a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9090>, '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 0x1ac9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', '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 11:57:57 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 11:57:57 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 11:57:57 INFO - Using env: {'DISPLAY': ':0', 11:57:57 INFO - 'HOME': '/home/cltbld', 11:57:57 INFO - 'LANG': 'en_US.UTF-8', 11:57:57 INFO - 'LANGUAGE': 'en_US:en', 11:57:57 INFO - 'LOGNAME': 'cltbld', 11:57:57 INFO - 'MAIL': '/var/mail/cltbld', 11:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:57 INFO - 'MOZ_NO_REMOTE': '1', 11:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:57 INFO - 'NO_EM_RESTART': '1', 11:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:57 INFO - 'PWD': '/builds/slave/test', 11:57:57 INFO - 'SHELL': '/bin/bash', 11:57:57 INFO - 'SHLVL': '1', 11:57:57 INFO - 'TERM': 'linux', 11:57:57 INFO - 'TMOUT': '86400', 11:57:57 INFO - 'USER': 'cltbld', 11:57:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', 11:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:57 INFO - '_': '/tools/buildbot/bin/python'} 11:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:57:57 INFO - Cleaning up... 11:57:57 INFO - Return code: 0 11:57:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:57:57 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')]} 11:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:57 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')]} 11:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:57 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 0x17591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1922a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9090>, '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 0x1ac9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', '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 11:57:57 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 11:57:57 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 11:57:57 INFO - Using env: {'DISPLAY': ':0', 11:57:57 INFO - 'HOME': '/home/cltbld', 11:57:57 INFO - 'LANG': 'en_US.UTF-8', 11:57:57 INFO - 'LANGUAGE': 'en_US:en', 11:57:57 INFO - 'LOGNAME': 'cltbld', 11:57:57 INFO - 'MAIL': '/var/mail/cltbld', 11:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:57 INFO - 'MOZ_NO_REMOTE': '1', 11:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:57 INFO - 'NO_EM_RESTART': '1', 11:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:57 INFO - 'PWD': '/builds/slave/test', 11:57:57 INFO - 'SHELL': '/bin/bash', 11:57:57 INFO - 'SHLVL': '1', 11:57:57 INFO - 'TERM': 'linux', 11:57:57 INFO - 'TMOUT': '86400', 11:57:57 INFO - 'USER': 'cltbld', 11:57:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', 11:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:57 INFO - '_': '/tools/buildbot/bin/python'} 11:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:57 INFO - Downloading/unpacking blobuploader==1.2.4 11:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:58 INFO - Downloading blobuploader-1.2.4.tar.gz 11:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:57:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:57:59 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 11:57:59 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 11:57:59 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 11:57:59 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 11:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:57:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:57:59 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 11:57:59 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 11:57:59 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 11:57:59 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 11:57:59 INFO - Downloading docopt-0.6.1.tar.gz 11:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:57:59 INFO - Installing collected packages: blobuploader, requests, docopt 11:57:59 INFO - Running setup.py install for blobuploader 11:57:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:57:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:57:59 INFO - Running setup.py install for requests 11:58:00 INFO - Running setup.py install for docopt 11:58:00 INFO - Successfully installed blobuploader requests docopt 11:58:00 INFO - Cleaning up... 11:58:00 INFO - Return code: 0 11:58:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:00 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')]} 11:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:00 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')]} 11:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:00 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 0x17591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1922a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9090>, '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 0x1ac9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', '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 11:58:00 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 11:58:00 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 11:58:00 INFO - Using env: {'DISPLAY': ':0', 11:58:00 INFO - 'HOME': '/home/cltbld', 11:58:00 INFO - 'LANG': 'en_US.UTF-8', 11:58:00 INFO - 'LANGUAGE': 'en_US:en', 11:58:00 INFO - 'LOGNAME': 'cltbld', 11:58:00 INFO - 'MAIL': '/var/mail/cltbld', 11:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:00 INFO - 'MOZ_NO_REMOTE': '1', 11:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:00 INFO - 'NO_EM_RESTART': '1', 11:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:00 INFO - 'PWD': '/builds/slave/test', 11:58:00 INFO - 'SHELL': '/bin/bash', 11:58:00 INFO - 'SHLVL': '1', 11:58:00 INFO - 'TERM': 'linux', 11:58:00 INFO - 'TMOUT': '86400', 11:58:00 INFO - 'USER': 'cltbld', 11:58:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', 11:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:00 INFO - '_': '/tools/buildbot/bin/python'} 11:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:00 INFO - Running setup.py (path:/tmp/pip-aMoLhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:00 INFO - Running setup.py (path:/tmp/pip-qbjTZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:00 INFO - Running setup.py (path:/tmp/pip-oagtXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:00 INFO - Running setup.py (path:/tmp/pip-BITG39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:00 INFO - Running setup.py (path:/tmp/pip-f9GVEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:00 INFO - Running setup.py (path:/tmp/pip-qArnzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:00 INFO - Running setup.py (path:/tmp/pip-LGp6fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:00 INFO - Running setup.py (path:/tmp/pip-8t9Zp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:00 INFO - Running setup.py (path:/tmp/pip-G6KyGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:01 INFO - Running setup.py (path:/tmp/pip-9JdEOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:01 INFO - Running setup.py (path:/tmp/pip-lhKTWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:01 INFO - Running setup.py (path:/tmp/pip-0ZX4xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:01 INFO - Running setup.py (path:/tmp/pip-rS_VxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:01 INFO - Running setup.py (path:/tmp/pip-SLmKOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:01 INFO - Running setup.py (path:/tmp/pip-gFARd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:01 INFO - Running setup.py (path:/tmp/pip-yIMBeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:01 INFO - Running setup.py (path:/tmp/pip-lqfzZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:58:01 INFO - Running setup.py install for manifestparser 11:58:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:58:01 INFO - Running setup.py install for mozcrash 11:58:01 INFO - Running setup.py install for mozdebug 11:58:01 INFO - Running setup.py install for mozdevice 11:58:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:58:01 INFO - Running setup.py install for mozfile 11:58:02 INFO - Running setup.py install for mozhttpd 11:58:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Running setup.py install for mozinfo 11:58:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Running setup.py install for mozInstall 11:58:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Running setup.py install for mozleak 11:58:02 INFO - Running setup.py install for mozlog 11:58:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Running setup.py install for moznetwork 11:58:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Running setup.py install for mozprocess 11:58:02 INFO - Running setup.py install for mozprofile 11:58:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Running setup.py install for mozrunner 11:58:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:58:03 INFO - Running setup.py install for mozscreenshot 11:58:03 INFO - Running setup.py install for moztest 11:58:03 INFO - Running setup.py install for mozversion 11:58:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:58:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:58:03 INFO - Cleaning up... 11:58:03 INFO - Return code: 0 11:58:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:03 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')]} 11:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:03 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')]} 11:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:03 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 0x17591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1922a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9090>, '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 0x1ac9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', '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 11:58:03 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 11:58:03 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 11:58:03 INFO - Using env: {'DISPLAY': ':0', 11:58:03 INFO - 'HOME': '/home/cltbld', 11:58:03 INFO - 'LANG': 'en_US.UTF-8', 11:58:03 INFO - 'LANGUAGE': 'en_US:en', 11:58:03 INFO - 'LOGNAME': 'cltbld', 11:58:03 INFO - 'MAIL': '/var/mail/cltbld', 11:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:03 INFO - 'MOZ_NO_REMOTE': '1', 11:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:03 INFO - 'NO_EM_RESTART': '1', 11:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:03 INFO - 'PWD': '/builds/slave/test', 11:58:03 INFO - 'SHELL': '/bin/bash', 11:58:03 INFO - 'SHLVL': '1', 11:58:03 INFO - 'TERM': 'linux', 11:58:03 INFO - 'TMOUT': '86400', 11:58:03 INFO - 'USER': 'cltbld', 11:58:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', 11:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:03 INFO - '_': '/tools/buildbot/bin/python'} 11:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:03 INFO - Running setup.py (path:/tmp/pip-1mLa74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:03 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)) 11:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:03 INFO - Running setup.py (path:/tmp/pip-2UhwGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:03 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)) 11:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:03 INFO - Running setup.py (path:/tmp/pip-Dmzjt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:03 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)) 11:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:03 INFO - Running setup.py (path:/tmp/pip-0adRKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:03 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)) 11:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:03 INFO - Running setup.py (path:/tmp/pip-zNRKrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:03 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)) 11:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:03 INFO - Running setup.py (path:/tmp/pip-OFinSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:03 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)) 11:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:03 INFO - Running setup.py (path:/tmp/pip-6NKyBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:04 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)) 11:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:04 INFO - Running setup.py (path:/tmp/pip-blIzfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:04 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)) 11:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:04 INFO - Running setup.py (path:/tmp/pip-P6V1WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58:04 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)) 11:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:04 INFO - Running setup.py (path:/tmp/pip-bzTo0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58:04 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)) 11:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:04 INFO - Running setup.py (path:/tmp/pip-Ib8F6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:04 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)) 11:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:04 INFO - Running setup.py (path:/tmp/pip-2Mg74q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:04 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)) 11:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:04 INFO - Running setup.py (path:/tmp/pip-m4OKsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:04 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)) 11:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:04 INFO - Running setup.py (path:/tmp/pip-H0VxdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:04 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)) 11:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:04 INFO - Running setup.py (path:/tmp/pip-hFekyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:04 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)) 11:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:04 INFO - Running setup.py (path:/tmp/pip-pn5WMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:04 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)) 11:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:04 INFO - Running setup.py (path:/tmp/pip-wLaX4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:04 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)) 11:58:04 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)) 11:58:04 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)) 11:58:04 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)) 11:58:04 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)) 11:58:04 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)) 11:58:04 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)) 11:58:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:58:04 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 11:58:04 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 11:58:04 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 11:58:04 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 11:58:05 INFO - Downloading blessings-1.6.tar.gz 11:58:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:58:05 INFO - Installing collected packages: blessings 11:58:05 INFO - Running setup.py install for blessings 11:58:06 INFO - Successfully installed blessings 11:58:06 INFO - Cleaning up... 11:58:06 INFO - Return code: 0 11:58:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:58:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:06 INFO - Reading from file tmpfile_stdout 11:58:06 INFO - Current package versions: 11:58:06 INFO - argparse == 1.2.1 11:58:06 INFO - blessings == 1.6 11:58:06 INFO - blobuploader == 1.2.4 11:58:06 INFO - docopt == 0.6.1 11:58:06 INFO - functools32 == 3.2.3-2 11:58:06 INFO - jsonschema == 2.5.1 11:58:06 INFO - manifestparser == 1.1 11:58:06 INFO - mozInstall == 1.13 11:58:06 INFO - mozcrash == 1.0 11:58:06 INFO - mozdebug == 0.1 11:58:06 INFO - mozdevice == 0.51 11:58:06 INFO - mozfile == 1.2 11:58:06 INFO - mozhttpd == 0.7 11:58:06 INFO - mozinfo == 0.10 11:58:06 INFO - mozleak == 0.1 11:58:06 INFO - mozlog == 3.5 11:58:06 INFO - moznetwork == 0.27 11:58:06 INFO - mozprocess == 0.25 11:58:06 INFO - mozprofile == 0.28 11:58:06 INFO - mozrunner == 6.13 11:58:06 INFO - mozscreenshot == 0.1 11:58:06 INFO - mozsystemmonitor == 0.3 11:58:06 INFO - moztest == 0.8 11:58:06 INFO - mozversion == 1.4 11:58:06 INFO - psutil == 3.1.1 11:58:06 INFO - requests == 1.2.3 11:58:06 INFO - wsgiref == 0.1.2 11:58:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:06 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 0x17591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1922a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9090>, '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 0x1ac9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', '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 11:58:06 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 11:58:06 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 11:58:06 INFO - Using env: {'DISPLAY': ':0', 11:58:06 INFO - 'HOME': '/home/cltbld', 11:58:06 INFO - 'LANG': 'en_US.UTF-8', 11:58:06 INFO - 'LANGUAGE': 'en_US:en', 11:58:06 INFO - 'LOGNAME': 'cltbld', 11:58:06 INFO - 'MAIL': '/var/mail/cltbld', 11:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:06 INFO - 'MOZ_NO_REMOTE': '1', 11:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:06 INFO - 'NO_EM_RESTART': '1', 11:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:06 INFO - 'PWD': '/builds/slave/test', 11:58:06 INFO - 'SHELL': '/bin/bash', 11:58:06 INFO - 'SHLVL': '1', 11:58:06 INFO - 'TERM': 'linux', 11:58:06 INFO - 'TMOUT': '86400', 11:58:06 INFO - 'USER': 'cltbld', 11:58:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', 11:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:06 INFO - '_': '/tools/buildbot/bin/python'} 11:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:06 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)) 11:58:06 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)) 11:58:06 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)) 11:58:06 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)) 11:58:06 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)) 11:58:06 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)) 11:58:06 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)) 11:58:06 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)) 11:58:06 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)) 11:58:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:58:06 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 11:58:06 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 11:58:06 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 11:58:06 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 11:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:58:07 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)) 11:58:07 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)) 11:58:07 INFO - Installing collected packages: simplejson 11:58:07 INFO - Running setup.py install for simplejson 11:58:07 INFO - building 'simplejson._speedups' extension 11:58:07 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 11:58:08 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 11:58:08 INFO - Successfully installed simplejson 11:58:08 INFO - Cleaning up... 11:58:08 INFO - Return code: 0 11:58:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:58:08 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')]} 11:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:08 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')]} 11:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:08 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 0x17591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1922a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9090>, '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 0x1ac9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', '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 11:58:08 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 11:58:08 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 11:58:08 INFO - Using env: {'DISPLAY': ':0', 11:58:08 INFO - 'HOME': '/home/cltbld', 11:58:08 INFO - 'LANG': 'en_US.UTF-8', 11:58:08 INFO - 'LANGUAGE': 'en_US:en', 11:58:08 INFO - 'LOGNAME': 'cltbld', 11:58:08 INFO - 'MAIL': '/var/mail/cltbld', 11:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:08 INFO - 'MOZ_NO_REMOTE': '1', 11:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:08 INFO - 'NO_EM_RESTART': '1', 11:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:08 INFO - 'PWD': '/builds/slave/test', 11:58:08 INFO - 'SHELL': '/bin/bash', 11:58:08 INFO - 'SHLVL': '1', 11:58:08 INFO - 'TERM': 'linux', 11:58:08 INFO - 'TMOUT': '86400', 11:58:08 INFO - 'USER': 'cltbld', 11:58:08 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', 11:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:08 INFO - '_': '/tools/buildbot/bin/python'} 11:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:58:09 INFO - Cleaning up... 11:58:09 INFO - Return code: 0 11:58:09 INFO - Running post-action listener: _resource_record_post_action 11:58:09 INFO - Running post-action listener: _start_resource_monitoring 11:58:09 INFO - Starting resource monitoring. 11:58:09 INFO - [mozharness: 2017-09-22 18:58:09.058992Z] Finished create-virtualenv step (success) 11:58:09 INFO - [mozharness: 2017-09-22 18:58:09.059556Z] Running install step. 11:58:09 INFO - Running pre-action listener: _resource_record_pre_action 11:58:09 INFO - Running main action method: install 11:58:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:09 INFO - Reading from file tmpfile_stdout 11:58:09 INFO - Detecting whether we're running mozinstall >=1.0... 11:58:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:58:09 INFO - Reading from file tmpfile_stdout 11:58:09 INFO - Output received: 11:58:09 INFO - Usage: mozinstall [options] installer 11:58:09 INFO - Options: 11:58:09 INFO - -h, --help show this help message and exit 11:58:09 INFO - -d DEST, --destination=DEST 11:58:09 INFO - Directory to install application into. [default: 11:58:09 INFO - "/builds/slave/test"] 11:58:09 INFO - --app=APP Application being installed. [default: firefox] 11:58:09 INFO - mkdir: /builds/slave/test/build/application 11:58:09 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'] 11:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:58:27 INFO - Reading from file tmpfile_stdout 11:58:27 INFO - Output received: 11:58:27 INFO - /builds/slave/test/build/application/firefox/firefox 11:58:27 INFO - Running post-action listener: _resource_record_post_action 11:58:27 INFO - [mozharness: 2017-09-22 18:58:27.014698Z] Finished install step (success) 11:58:27 INFO - [mozharness: 2017-09-22 18:58:27.014844Z] Running setup-mitmproxy step. 11:58:27 INFO - Running pre-action listener: _resource_record_pre_action 11:58:27 INFO - Running main action method: setup_mitmproxy 11:58:27 INFO - Skipping: mitmproxy is not required 11:58:27 INFO - Running post-action listener: _resource_record_post_action 11:58:27 INFO - [mozharness: 2017-09-22 18:58:27.015529Z] Finished setup-mitmproxy step (success) 11:58:27 INFO - [mozharness: 2017-09-22 18:58:27.015752Z] Running run-tests step. 11:58:27 INFO - Running pre-action listener: _resource_record_pre_action 11:58:27 INFO - Running pre-action listener: _set_gcov_prefix 11:58:27 INFO - Running main action method: run_tests 11:58:27 WARNING - Try message not found. 11:58:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:58:27 INFO - Python 2.7.3 11:58:27 INFO - Return code: 0 11:58:27 INFO - grabbing minidump binary from tooltool 11:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:27 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 0x1ac9090>, '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 0x1ac9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:58:27 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 11:58:27 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 11:58:27 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 11:58:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:58:27 INFO - Return code: 0 11:58:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:58:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:58:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:58:27 INFO - ENV: RUST_BACKTRACE is now full 11:58:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:58:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:58:27 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/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 11:58:27 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/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 11:58:27 INFO - Using env: {'DISPLAY': ':0', 11:58:27 INFO - 'HOME': '/home/cltbld', 11:58:27 INFO - 'LANG': 'en_US.UTF-8', 11:58:27 INFO - 'LANGUAGE': 'en_US:en', 11:58:27 INFO - 'LOGNAME': 'cltbld', 11:58:27 INFO - 'MAIL': '/var/mail/cltbld', 11:58:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:58:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:27 INFO - 'MOZ_NO_REMOTE': '1', 11:58:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:27 INFO - 'NO_EM_RESTART': '1', 11:58:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:27 INFO - 'PWD': '/builds/slave/test', 11:58:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:58:27 INFO - 'RUST_BACKTRACE': 'full', 11:58:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:58:27 INFO - 'SHELL': '/bin/bash', 11:58:27 INFO - 'SHLVL': '1', 11:58:27 INFO - 'TERM': 'linux', 11:58:27 INFO - 'TMOUT': '86400', 11:58:27 INFO - 'USER': 'cltbld', 11:58:27 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', 11:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:27 INFO - '_': '/tools/buildbot/bin/python'} 11:58:27 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/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 11:58:27 INFO - mozversion application_buildid: 20170922173423 11:58:27 INFO - mozversion application_changeset: 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 11:58:27 INFO - mozversion application_display_name: Nightly 11:58:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:58:27 INFO - mozversion application_name: Firefox 11:58:27 INFO - mozversion application_remotingname: firefox 11:58:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:58:27 INFO - mozversion application_vendor: Mozilla 11:58:27 INFO - mozversion application_version: 58.0a1 11:58:27 INFO - mozversion platform_buildid: 20170922173423 11:58:27 INFO - mozversion platform_changeset: 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 11:58:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:58:27 INFO - mozversion platform_version: 58.0a1 11:58:27 INFO - using testdate: 1506106707 11:58:27 INFO - actual date: 1506106707 11:58:27 INFO - starting webserver on 'localhost:41223' 11:58:27 INFO - SUITE-START | Running 2 tests 11:58:27 INFO - TEST-START | dromaeo_css 11:58:27 INFO - Initialising browser for dromaeo_css test... 11:58:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41223/getInfo.html -profile /tmp/tmpEBvkuk/profile 11:58:27 INFO - TEST-INFO | started process 19785 (/builds/slave/test/build/application/firefox/firefox http://localhost:41223/getInfo.html) 11:58:33 INFO - TEST-INFO | 19785: exit 0 11:58:33 INFO - Browser initialized. 11:58:33 INFO - Running cycle 1/1 for dromaeo_css test... 11:58:33 INFO - Using env: {'DISPLAY': ':0', 11:58:33 INFO - 'HOME': '/home/cltbld', 11:58:33 INFO - 'JSGC_DISABLE_POISONING': '1', 11:58:33 INFO - 'LANG': 'en_US.UTF-8', 11:58:33 INFO - 'LANGUAGE': 'en_US:en', 11:58:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:58:33 INFO - 'LOGNAME': 'cltbld', 11:58:33 INFO - 'MAIL': '/var/mail/cltbld', 11:58:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:58:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:58:33 INFO - 'MOZ_CRASHREPORTER': '1', 11:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:58:33 INFO - 'MOZ_NO_REMOTE': '1', 11:58:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:58:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:33 INFO - 'NO_EM_RESTART': '1', 11:58:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:33 INFO - 'PWD': '/builds/slave/test', 11:58:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:58:33 INFO - 'RUST_BACKTRACE': 'full', 11:58:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:58:33 INFO - 'SHELL': '/bin/bash', 11:58:33 INFO - 'SHLVL': '1', 11:58:33 INFO - 'TERM': 'linux', 11:58:33 INFO - 'TMOUT': '86400', 11:58:33 INFO - 'USER': 'cltbld', 11:58:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', 11:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:33 INFO - '_': '/tools/buildbot/bin/python'} 11:58:33 INFO - TEST-INFO | started process 20025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEBvkuk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:58:34 INFO - PID 20025 | 11:58:34 INFO - PID 20025 | (/builds/slave/test/build/application/firefox/firefox:20075): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:58:34 INFO - PID 20025 | 11:58:44 INFO - PID 20025 | RSS: Main: 144437248 11:58:44 INFO - PID 20025 | 12:01:42 INFO - PID 20025 | Cycle 1(1): loaded http://localhost:41223/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41223/tests/dromaeo/cssquery-ext.html) 12:01:43 INFO - PID 20025 | RSS: Main: 146579456 12:01:43 INFO - PID 20025 | 12:04:45 INFO - PID 20025 | Cycle 1(1): loaded http://localhost:41223/tests/dromaeo/cssquery-ext.html (next: http://localhost:41223/tests/dromaeo/cssquery-jquery.html) 12:04:45 INFO - PID 20025 | RSS: Main: 146255872 12:04:45 INFO - PID 20025 | 12:07:47 INFO - PID 20025 | Cycle 1(1): loaded http://localhost:41223/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41223/tests/dromaeo/cssquery-mootools.html) 12:07:47 INFO - PID 20025 | RSS: Main: 148082688 12:07:47 INFO - PID 20025 | 12:10:49 INFO - PID 20025 | Cycle 1(1): loaded http://localhost:41223/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41223/tests/dromaeo/cssquery-prototype.html) 12:10:49 INFO - PID 20025 | RSS: Main: 146001920 12:10:49 INFO - PID 20025 | 12:13:52 INFO - PID 20025 | Cycle 1(1): loaded http://localhost:41223/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41223/tests/dromaeo/cssquery-yui.html) 12:13:53 INFO - PID 20025 | RSS: Main: 146493440 12:13:53 INFO - PID 20025 | 12:16:54 INFO - PID 20025 | Cycle 1(1): loaded http://localhost:41223/tests/dromaeo/cssquery-yui.html (next: http://localhost:41223/tests/dromaeo/cssquery-dojo.html) 12:16:55 INFO - PID 20025 | RSS: Main: 148103168 12:16:55 INFO - PID 20025 | 12:16:55 INFO - PID 20025 | __start_tp_report 12:16:55 INFO - PID 20025 | _x_x_mozilla_page_load 12:16:55 INFO - PID 20025 | _x_x_mozilla_page_load_details 12:16:55 INFO - PID 20025 | |i|pagename|runs| 12:16:55 INFO - PID 20025 | |0;dojo.html;3880.1269714314285;3903.5315762108553;3904.121572646155;3928.8624898128573;3944.1125746706994;6186.2885768136675;6198.876022479548;6260.092286618444;6269.373062693729;6368.649724265169;6162.661053642048;6231.626102433857;6248.84377890553;6264.310925798159;6292.370762923717;5402.810901618424;5584.050711379055;5622.269105016342;5623.831285061445;5642.238297829802;5616.831495055155;5659.660420374791;5709.486146246837;5767.682777447239;5776.306843178824;5493.313335833021;5605.663660180382;5633.32400111985;5712.057510510761;5732.770689172449;5596.468335508161;5669.6314739541795;5677.9495793278375;5683.403242659502;5692.117721753135;5559.9444005559835;5583.860403489945;5620.747066382022;5672;5712.1431785232135;6243.282022567372;6257.155284036688;6297;6316.242050953915;6331.14529538511;6759.729610815611;6773.62745049027;6774.187097548276;6844.8973265401055;6872.450203983669;6734;6812.216595091579;6814.557053791487;6891.138607674041;6913.5506192097855;6330.936690633081;6411.96794016027;6415.775447859302;6419.679016049179;6451.806445806634;6937.965310173417;6942.271061538567;7024.789256322319;7026.051483049825;7060.223375428699;6614.933850661528;6688.498362622823;6693.765718199937;6749.291324410964;6764.898526522106;6752.932470675329;6797.422219111332;6866.896996545056;6895.172579290517;6906.482013848981;6708.2956289589865;6713.328667133248;6805.421539169127;6808.319168083152;6809.3871551559605;6529.2817790043055;6672.199336079701;6713.530052896251;6814.352636499525;6848.623325717133;5009.248612708123;5019.42276638184;5034.345535080416;5038.118329292359;5038.496150385005;4548.56788605082;4562.475315338778;4585.358049873021;4606.262997920384;4640.976795116003;6288.968555157195;6318.557700960981;6375.139356186948;6400.871982560323;6443.838904027437;6580.9470484722215;6660.500462465335;6679.365460281266;6714.429273511806;6755.493337999571;6316.4315211630255;6352;6352.968235158887;6353.555251132469;6364.809055728336;5460.808871689472;5473.343198816167;5475.72621368938;5478.150886612581;5479.205515200274;6926.376626103574;6982.825429364205;7058.964705176441;7084.397826184729;7129.7861064168155;6756.88511395624;6784.3894049535775;6785.117934668363;6793.6942837573415;6806.82982925411;7137.10786151731;7163.31948464895;7163.928360716326;7258.45561582894;7260;6572.868542629216;6578.342165783575;6611.570247933869;6630.668466576555;6677.9332206679255;6822.727090916506;6840.31596840312;6852.040714300102;6859.4512439003765;6866.6566671667215;6375.1712277405495;6572.7042283098335;6663.5002374821115;6665.66671666405;6675;6528.543001989815;6541.509386795914;6622.07290979273;6625.635590042401;6628.204615446178;6288.434040936338;6407.807765767035;6429.517786165963;6519;6533.18335208099;6627.105340778933;6637.236717777518;6650.268470468342;6671.966640166768;6695.4308883745425;6347.17486726741;6382.393672601095;6406.5515413920575;6489;6492.805215843532 12:16:55 INFO - PID 20025 | |1;ext.html;938.7418459923521;939.66641842146;965.7489052846261;994.0655783563454;994.2493417469809;42251.57748422515;44090.779546102305;44251.33622995658;44310.77844610777;44452.33321500172;41560.37659435103;41570.584294157125;41756.37365439521;41765.37351939716;41778.791106044504;7724.845503089935;7816.101148367954;7853.175416581234;7875.684972601089;7918.604069796516;7713.884291735629;7830.491018083806;7850.568218747967;7855.489393189453;7863.606819659023;7767.922320776805;8471.788205294855;8631.95684021579;8637.870431943526;8654.264387527068;8545.786355341135;8597.699080532151;8598.269147122503;8616.353773467015;8631.093735157812;8416;8463.23830855226;8535.231829135346;8550.52972086535;8558.61486233121;39108;39112.608873911464;39525.60474395248;39544.40683389751;39596;3735.6077611850906;3772.3775577029755;3781.810909454544;3787.8484860605545;3807.1814559869763;33863.153421164425;33903.321933561194;33913.32173356544;33930.151746206546;34021;5484.424135465799;5518.696471694056;5519.475649813261;5556.972215138939;5610.354809196913;210021;210415;210620;211968.9401552998;212465;51530;51801.48198518042;51817.7409112952;52028.739856300475;52919.735401322745;55533.44466555364;55669;55706.72146639322;55733;55741.442585574434;16514.174291285388;16685.33258669664;16766.413175538797;16795.328186872634;16824.158792060593;13334.933325333504;13398.397072131778;13408.195508269535;13419.396127174301;13429.194248345131;15515.526025027604;15702.9214853925;15719.528414147593;15725.528234152765;15774.60563485899;5886.58793884424;5980.8803823924145;6068.241469816273;6097.390260973867;6218.06728990655;1087.374759513283;1097.9615713449991;1102.8841971593029;1108.4070022537903;1114.0419239454063;25642.871785640953;25903.870480647474;25937.870310648326;25991.870040649676;26077.217683469527;1191.666333426642;1206.4269472000906;1215.9027277817754;1217.4643157010887;1228.8279640850287;13716.794248086288;13811.930940345435;13873.861261387257;13897.722045559032;13979.37092830825;288458;291436;293673;293918;294690;57523.71238143783;58004.12993805012;61359;61503;61785.382146177966;1447.7683570628649;1473.0940471609883;1481.9703605928037;1484.2133669155364;1495.439210296139;30770.613524809098;30848.53727194049;30931.84534077315;30969.8451507741;31187.53218701676;40086;40342.39486407647;40488.79755601321;40495;40508.1898362037;240073;240174;240255;240604;242194;36409.45385819162;37040;37072.07319817026;37182.76903385806;37571.24857502889;46834;46841.53158468508;46996.7650161747;47242.76378618085;47331.526684732715;34197.316053679286;34331.485027724106;34572.654273456945;34685.826570866986;35261.47107793334;33690.83154584211;33720.83139584286;33918.321633567684;34287.14282142966;34447;39422.60577394189;40315.1936961265;40595.188096238504;40632.796836016816;40847.183056338115;32691.673083268863;33047;33203.50194747129;33350;33496.33007339888;25108.372290692147;25457.363565911;25729.485410292065;25792.067824400117;25956.35109122287 12:16:55 INFO - PID 20025 | |2;jquery.html;611.9357467465919;612.7916508387148;618.5731845026932;618.6628287583264;631.7536160897249;22851.42871428213;23274.41813954652;23370.649440258367;23461.178858739946;23462.64806027911;25581.488370232582;26215.475690486226;26473.27923684959;26543.336416589595;26655.600165997526;6629.105070815451;6709.127813384253;6789.117414736077;6794.558353707018;6804.829879253009;6400;6622.304658010912;6668.199816022084;6712.328767123297;6804.217514985766;6589.802305930806;6621.73513059477;6632.1709786276715;6635.867282654344;6638;6472.417482426581;6585.57193782405;6745.527813053063;6761.966190169067;6775;6327.5570710050315;6332.430081292706;6335.651539165344;6336.493080553545;6339.651319177444;29751.702482975325;29981.10056698281;30178.54732179019;30227.244318891982;30267;2222.866628002325;2228.9331320060423;2255.0979608156704;2261.197274967379;2263.2418139923147;20272.797272027237;21386.46533836651;21489.355319340444;21533.24633637815;21569.568608627895;2517.3958250020046;2594.818362714611;2627.605859121128;2634.499445105424;2638.6833579970335;134799.32600337034;143132;148932;154419.22790386088;155758;15826.68346633084;15888.682226355639;15917.840821591868;15934.964227325187;17117.828821711624;25618.48763024729;25658.871705641726;25676.358091047874;25701;25763.613545796827;10209.86500467297;10388.272820902615;10524.894751052392;10576;10594.4702764863;9309.534523273946;9426.104520070583;9456.101670341444;9534.570944307523;9582.185514231369;9721.4653194075;9779.168770654433;9786.902130978742;9844.212463002943;9993.950030249802;2864.8567571621334;2896.406236721467;2927.1218634409593;2935.544990526472;2950.3214260720156;1017.0897047142765;1018.2057994764095;1045.529511719714;1054.678323111443;1061.1828891753307;20870.26954056601;21343.35969920905;21432.464188395104;21621.027053782618;21811.127554897626;1106.253279036647;1107.4739498738036;1115.2360632966445;1123.6741345009855;1126.8535090438354;11621.593244236412;11752.529898804123;11895.405229738479;11915.940420298017;12036.157468977262;551640;576780;586087;605687;607974;123002.38498807448;125054.37472812578;127583;127697;127964;1212.860521040074;1214.2896405602821;1244.4524409259898;1247.5758242197696;1247.7816382133271;18689.25242990265;19092.23631054742;19141.90429047846;19302.613947720685;19313.03434828281;61539.692301538205;62251;63593;64483.677581611795;65153.348466514726;78967.21032789598;79009.60495197488;79531.20468795238;79953;80784.59607701923;15428.9228553861;15591;15630.609234769221;15778.13220272896;15915.522534323989;24118.758812411652;24254.15110471125;24396;24487;24503.877480612482;19480.902595486932;19813;20155.496112597302;20163.193472260944;20180.091895865015;17594.208260628046;17829.821701782817;18035.458936231935;18068;18254.17856196501;18847.15187816524;18895.244190232235;19213.03934803282;19324.32364867279;19456;15369.615759606098;15381.3078411474;15400.383984640488;15415.229238538253;15423.768643470132;17566.560835978693;18189.54526136857;19288.71066933969;19349.61300774005;19570.80429195747 12:16:55 INFO - PID 20025 | |3;mootools.html;1385.4942945824773;1443.328852083781;1459.489178787424;1467.6917847252078;1472.3595236072315;16406.34374625015;17207.483775486726;17218.39735609254;17245.568860778454;17258.309667613295;16925.322987080533;16955.406560770374;16992.74510882338;17062.658746825087;17067.82932170678;2805.523061079616;2919.5912572239904;2921.123662901121;2925.488039593073;2928.31184671602;2758.1174024312227;2768.695443501213;2809.1151287344524;2809.9157025289173;2811.732885375886;2790.2745286225627;2904.3320036391538;2934.031769516065;2935.6183696119583;2935.779816513759;2836.3334616365137;2843.9857800710865;2860.156253905103;2876.6548014238215;2883.1350594821574;2713.6879258885087;2720.4967081089862;2739.0824073935255;2739.465804168188;2741.0817376179;16437.753433698505;16481.34074637013;16726.330946762115;16727.749083763752;16737.581560460963;8438.789030274293;8651.091635378258;8797.076306987738;8814.735557933209;8830.381873268874;5165.173572228463;5344.599155063347;5452.291202143696;5483.095289277265;5516.972415137939;2104.968425473619;2112.757032941216;2118.2691971269887;2147.1304121830685;2148.2481131603968;30019.849900750574;30072;30275.394492110256;30396.69603303983;30413.543796843063;6715.865682686319;6753;6994.5803251805055;7001.229864714877;7121.501494895308;19493.415197544095;19528.12123454448;19616.21535138607;19625.116869740898;19644.3124490645;8459.323254139654;8463.365247606454;8472.576371181416;8492.830143397221;8502.489850608983;7609.923900761032;7649.541027538366;7747.070351557736;7831.2560306770765;7842.333401660809;5556.91664625031;5820.767169313265;5824.825255242349;5870.236869206976;5885;1557.4393218441353;1595.3698289175943;1697.9575510612087;1725.7411388291605;1802.7836659600932;951.9143277105094;964.5081008685621;974.8391515400021;977.6822532676908;988.17981075707;9771.951140244253;10057.99420058003;10119.595216191417;10169.186465082776;10277.383356998604;1041.4116024446164;1061.6496556136456;1067.2315932528568;1070.6627412365235;1074.1353210665334;5581.776728930798;6030.366811484819;6078.179445774764;6209.6895155242055;6305.180326557518;24109.879450602635;24356.756432435803;24540.754592454203;24875.378115546893;24882.751172488406;24271.271861844172;24381.756182437948;24638.87680561586;24661.26016219516;24924.626130608056;12043.397830108459;12188.634340969786;12195.817062744067;12439;12443.315617641116;9026.052264512131;9129.726108216764;9178.67874624385;9209.125133112344;9215.308851836005;20020.099095540445;20097.995100244636;20407.8979605101;20689.482762931046;20790.68813967822;20901.790982089984;20941.89529052345;21019.369418917457;21154;21287.8935605321;11910.404479776149;11959.162858599815;11969.042476602026;11974.64076077719;12092;13994.230317332644;15115.546533604009;15276.847231527543;15280.235988200324;15282.083075015535;12200.816987745013;12319.137660364047;12319.815202771786;12536.561220357244;12735.745285094432;11950.521979120738;12060.51757929708;12169.878301217228;12179.96470299999;12374.13381063317;10915.39965301916;11038.50326735315;11124.499397527292;11143.888561114285;11232.66302010941;8442.535660538484;8506.319494440553;8520.914790852012;8522.74431767048;8693.130686931256;8255.587220638823;8282.378821588525;8332.916670833214;8338.082810890675;8356.791080223044 12:16:55 INFO - PID 20025 | |4;prototype.html;506.74662668665667;546.8851541176352;548.0463992652783;576.4782871501291;578.2309528327324;6195.442410183083;6202.5037996960245;6227.501799856001;6277.372262773721;6321.209848768904;6165.229346331708;6206.4002878330575;6223.408776166269;6223.471004964572;6272.905906411407;4182.53992060873;5017.799288028475;5101.387833459971;5111.51440613143;5121.974390128044;4910.165271903785;4964;4975.825846095369;5012.52381023804;5016.598672106241;4953.257011448293;5000.549950504454;5004.674696144739;5022.799088036474;5034.949650503485;4950.108980383529;5020.347354843883;5050.747462626854;5060.114479966028;5063.797448102072;4652.209124448818;4668.953310466886;4680.555347242007;4692.483826779086;4705.976470117662;5971.4327138921735;6059.969700151515;6073.817785466443;6075.483583895374;6210.96894515529;5914.231149950522;5929.1995580596495;5956.120680613898;5995.430434108796;6015.939840601582;6610.3720146586;6630.303818099078;6661.866762664768;6706.530542862001;6740.056392105109;5232.843014709565;5236.502532259429;5245.842624721265;5255.316808814868;5292.497212764782;6633.336666333376;6716.966415167893;6845.691943862538;6981.616011119438;6987.790366289019;5550.333959924835;5559.9444005560235;5573.442655734475;5582.441755824466;5615.971920140373;5596.720163991866;5644.488202749737;5679.517241034476;5714.542836573064;5736.483716465538;6129.1419201311855;6150.292716337589;6153.107799369066;6153.2000839890525;6178.69106544671;6636.402723754885;6685.6322902240845;6721.899171512334;6739.932600674028;6755.1556055493065;1963.1264087480934;1968.911398987049;1971.8816870987787;1975.07171629334;2001.2795393658562;1416.3343228682502;1448.1962510806393;1457.4097490516358;1471.42557463513;1483.5920121966547;6091.42131497507;6160.907586386208;6165.414285642857;6195.504359651217;6215.539348253157;6480.269403335591;6542.695938551001;6589.80230593083;6597.47220222381;6679.365460281266;6059.575829691879;6202.472789812826;6247.437730604177;6277.435030847246;6333.493320534346;3476.478528220787;3499.9825000875344;3518.3491054155065;3523.3657941570764;3529.5588051493564;7070.469714771412;7071.752488662975;7115.252898445692;7120.181179164359;7139.535930164523;6677.76627818024;6788.796336109925;6799.694013769392;6889.517733758589;6907.447404207652;6953.20038195614;6976.825579360557;6977.720891164398;7034.507584469038;7075.6815943281645;6539.4768418525455;6574.868502630016;6588.571742836701;6615.402295404648;6676.429574613711;6562.245341785756;6574.022716256787;6600.702968366339;6639.3692599203;6661.467082633475;6956.582605043714;6975.581465112109;7006.671830880291;7051.541649792747;7108.431325494052;5393.6224464287125;5497.120460726264;5511.53151982086;5545.72271386421;5571.8885622288135;6473.676316184266;6573.408393244631;6609.669516524058;6615.338466153346;6682.763688717603;6410.45511131559;6474.708638111202;6491.188601424822;6534.8366290843105;6538.673066346759;6441.323661015714;6450.322716114741;6472.126262954441;6498;6513.804585862432;6266.248050234001;6376.266729326187;6389.87220255583;6395.968020159869;6475;6498.155239818793;6535.810503481197;6540.8364790880605;6561.967190164019;6611.404973552403;6359.109724638647;6373.458256048288;6380.521460890544;6388.584741991942;6411.198600174978 12:16:55 INFO - PID 20025 | |5;yui.html;961.2982522758386;963.7856301060662;965.4352203960684;970.0445061614308;976.8876579193391;19991.600167996632;20327;20493.692594611093;20626.89686551569;20684.48288792781;19695.704564431508;20032.399028029184;20110.9944502775;20141.697874531892;20196.798032019677;999.4053538144792;1005.7988402319529;1006.0543089495887;1009.9091081802636;1010.5301035018715;1001.3140998416072;1029.4749677664408;1039.1167507618502;1041.2398948767404;1041.4272150317333;1104.1056744037355;1106.6458733205377;1106.6956586938575;1106.8727096383898;1107.224942540221;1039.153090231459;1075.0378411321824;1080.168270431771;1093.1145771924726;1102.691246450995;790.6995341770148;791.4736700094488;791.5369508837337;791.7387262203459;791.9168487308865;21477.785222147733;21611;21617.67573486399;21625.783742162534;21678.132874684994;23237.7676223239;23654.69899155546;23690.40773980647;23852.880735596384;23904.282871513882;18443.815561844345;18583.256669733193;18657.906710466497;18713.81286187148;18721.344752933717;3869.8839034829;3921.509811273591;3952.071263253133;3966.6430021297933;3974.324364857981;152821.23589382094;156651.21674391668;156941.21529392395;157055;159357;17428.302867885144;17704.911475442797;17771.466855994342;17989.550261243574;18245.36141235077;33468.330633387195;34106.65893341035;34226.82886585551;34608.82695586506;35004.47493287603;8667.479951202948;8682.088380719933;8714.259287960467;8771.517566533774;8788.516631585324;4304.268274393361;4332.566743325642;4344.978275108604;4368.497622773358;4387.780610969438;5889.587728858939;6063.423974722395;6071.089336599545;6092.45167934888;6103.1455596216565;990.4948476277151;1001.1240164855751;1018.3126389686931;1024.9743756406149;1026.225199974015;747.2154238050026;756.485589798931;759.6733404635949;776.6970881356276;779.8752199648029;12891.613251602466;13207.40566674502;13325.73348533024;14165.71668566623;14167.645808854655;740.134043169493;741.9443541734391;751.3876190904396;760.5740785160217;765.663108232376;6142.201513803177;6355.777547785898;6365.267994180728;6375.922725774387;6463.030545418225;148147;150395;150814;153274;158990;117608.41195793966;120343.39828300802;122723.3863830693;125016.37491812483;126374;114335.42832285786;114437.42781286206;116994.41502792432;117248;117480;14634.268286585415;14895.553133406016;15007.624809379853;15053.096814191184;15239.238038097828;52519.21221181609;52804.73597631987;53297.73351133375;53386.73306633442;53986.73006634942;70627;72551.63724181557;72951.27048729445;73917;74868.62565687137;20460.590788183854;20592.382228533166;21185;21222;21253.574928501035;22745.317640470814;22944.196953106562;23131.306060818202;23212.071517139124;23287.650685240074;21637.35087947364;21679.566408672054;22137;22162;22317.995690194304;18988.24047038103;19047.333343332917;19103.235870565022;19163.712544312126;19179.041047947267;20877.478063048544;21186;21257;21376.358709238746;21468.35594932092;14229.217393043482;14392.496262631177;14509.331426885621;14682.265886705409;14848.183349915858;15079.293970074506;15216.163111029;15381.461648842236;15440.768388473956;15491.84508154904 12:16:55 INFO - PID 20025 | __end_tp_report 12:16:55 INFO - PID 20025 | __start_cc_report 12:16:55 INFO - PID 20025 | _x_x_mozilla_cycle_collect,267 12:16:55 INFO - PID 20025 | __end_cc_report 12:16:55 INFO - PID 20025 | __startTimestamp1506107815143__endTimestamp 12:16:55 INFO - PID 20025 | 12:16:55 INFO - PID 20025 | ------- Summary: start ------- 12:16:55 INFO - PID 20025 | Number of tests: 6 12:16:55 INFO - PID 20025 | 12:16:55 INFO - PID 20025 | [#0] dojo.html Cycles:165 Average:6261.78 Median:6489.00 stddev:730.80 (11.3%) stddev-sans-first:708.76 12:16:55 INFO - PID 20025 | Values: 3880.1 3903.5 3904.1 3928.9 3944.1 6186.3 6198.9 6260.1 6269.4 6368.6 6162.7 6231.6 6248.8 6264.3 6292.4 5402.8 5584.1 5622.3 5623.8 5642.2 5616.8 5659.7 5709.5 5767.7 5776.3 5493.3 5605.7 5633.3 5712.1 5732.8 5596.5 5669.6 5677.9 5683.4 5692.1 5559.9 5583.9 5620.7 5672.0 5712.1 6243.3 6257.2 6297.0 6316.2 6331.1 6759.7 6773.6 6774.2 6844.9 6872.5 6734.0 6812.2 6814.6 6891.1 6913.6 6330.9 6412.0 6415.8 6419.7 6451.8 6938.0 6942.3 7024.8 7026.1 7060.2 6614.9 6688.5 6693.8 6749.3 6764.9 6752.9 6797.4 6866.9 6895.2 6906.5 6708.3 6713.3 6805.4 6808.3 6809.4 6529.3 6672.2 6713.5 6814.4 6848.6 5009.2 5019.4 5034.3 5038.1 5038.5 4548.6 4562.5 4585.4 4606.3 4641.0 6289.0 6318.6 6375.1 6400.9 6443.8 6580.9 6660.5 6679.4 6714.4 6755.5 6316.4 6352.0 6353.0 6353.6 6364.8 5460.8 5473.3 5475.7 5478.2 5479.2 6926.4 6982.8 7059.0 7084.4 7129.8 6756.9 6784.4 6785.1 6793.7 6806.8 7137.1 7163.3 7163.9 7258.5 7260.0 6572.9 6578.3 6611.6 6630.7 6677.9 6822.7 6840.3 6852.0 6859.5 6866.7 6375.2 6572.7 6663.5 6665.7 6675.0 6528.5 6541.5 6622.1 6625.6 6628.2 6288.4 6407.8 6429.5 6519.0 6533.2 6627.1 6637.2 6650.3 6672.0 6695.4 6347.2 6382.4 6406.6 6489.0 6492.8 12:16:55 INFO - PID 20025 | 12:16:55 INFO - PID 20025 | [#1] ext.html Cycles:180 Average:42801.52 Median:20671.81 stddev:65104.77 (314.9%) stddev-sans-first:65211.53 12:16:55 INFO - PID 20025 | Values: 938.7 939.7 965.7 994.1 994.2 42251.6 44090.8 44251.3 44310.8 44452.3 41560.4 41570.6 41756.4 41765.4 41778.8 7724.8 7816.1 7853.2 7875.7 7918.6 7713.9 7830.5 7850.6 7855.5 7863.6 7767.9 8471.8 8632.0 8637.9 8654.3 8545.8 8597.7 8598.3 8616.4 8631.1 8416.0 8463.2 8535.2 8550.5 8558.6 39108.0 39112.6 39525.6 39544.4 39596.0 3735.6 3772.4 3781.8 3787.8 3807.2 33863.2 33903.3 33913.3 33930.2 34021.0 5484.4 5518.7 5519.5 5557.0 5610.4 210021.0 210415.0 210620.0 211968.9 212465.0 51530.0 51801.5 51817.7 52028.7 52919.7 55533.4 55669.0 55706.7 55733.0 55741.4 16514.2 16685.3 16766.4 16795.3 16824.2 13334.9 13398.4 13408.2 13419.4 13429.2 15515.5 15702.9 15719.5 15725.5 15774.6 5886.6 5980.9 6068.2 6097.4 6218.1 1087.4 1098.0 1102.9 1108.4 1114.0 25642.9 25903.9 25937.9 25991.9 26077.2 1191.7 1206.4 1215.9 1217.5 1228.8 13716.8 13811.9 13873.9 13897.7 13979.4 288458.0 291436.0 293673.0 293918.0 294690.0 57523.7 58004.1 61359.0 61503.0 61785.4 1447.8 1473.1 1482.0 1484.2 1495.4 30770.6 30848.5 30931.8 30969.8 31187.5 40086.0 40342.4 40488.8 40495.0 40508.2 240073.0 240174.0 240255.0 240604.0 242194.0 36409.5 37040.0 37072.1 37182.8 37571.2 46834.0 46841.5 46996.8 47242.8 47331.5 34197.3 34331.5 34572.7 34685.8 35261.5 33690.8 33720.8 33918.3 34287.1 34447.0 39422.6 40315.2 40595.2 40632.8 40847.2 32691.7 33047.0 33203.5 33350.0 33496.3 25108.4 25457.4 25729.5 25792.1 25956.4 12:16:55 INFO - PID 20025 | 12:16:55 INFO - PID 20025 | [#2] jquery.html Cycles:180 Average:38979.34 Median:23062.92 stddev:98071.69 (425.2%) stddev-sans-first:98304.50 12:16:55 INFO - PID 20025 | Values: 611.9 612.8 618.6 618.7 631.8 22851.4 23274.4 23370.6 23461.2 23462.6 25581.5 26215.5 26473.3 26543.3 26655.6 6629.1 6709.1 6789.1 6794.6 6804.8 6400.0 6622.3 6668.2 6712.3 6804.2 6589.8 6621.7 6632.2 6635.9 6638.0 6472.4 6585.6 6745.5 6762.0 6775.0 6327.6 6332.4 6335.7 6336.5 6339.7 29751.7 29981.1 30178.5 30227.2 30267.0 2222.9 2228.9 2255.1 2261.2 2263.2 20272.8 21386.5 21489.4 21533.2 21569.6 2517.4 2594.8 2627.6 2634.5 2638.7 134799.3 143132.0 148932.0 154419.2 155758.0 15826.7 15888.7 15917.8 15935.0 17117.8 25618.5 25658.9 25676.4 25701.0 25763.6 10209.9 10388.3 10524.9 10576.0 10594.5 9309.5 9426.1 9456.1 9534.6 9582.2 9721.5 9779.2 9786.9 9844.2 9994.0 2864.9 2896.4 2927.1 2935.5 2950.3 1017.1 1018.2 1045.5 1054.7 1061.2 20870.3 21343.4 21432.5 21621.0 21811.1 1106.3 1107.5 1115.2 1123.7 1126.9 11621.6 11752.5 11895.4 11915.9 12036.2 551640.0 576780.0 586087.0 605687.0 607974.0 123002.4 125054.4 127583.0 127697.0 127964.0 1212.9 1214.3 1244.5 1247.6 1247.8 18689.3 19092.2 19141.9 19302.6 19313.0 61539.7 62251.0 63593.0 64483.7 65153.3 78967.2 79009.6 79531.2 79953.0 80784.6 15428.9 15591.0 15630.6 15778.1 15915.5 24118.8 24254.2 24396.0 24487.0 24503.9 19480.9 19813.0 20155.5 20163.2 20180.1 17594.2 17829.8 18035.5 18068.0 18254.2 18847.2 18895.2 19213.0 19324.3 19456.0 15369.6 15381.3 15400.4 15415.2 15423.8 17566.6 18189.5 19288.7 19349.6 19570.8 12:16:55 INFO - PID 20025 | 12:16:55 INFO - PID 20025 | [#3] mootools.html Cycles:180 Average:10350.00 Median:24768.32 stddev:7553.21 (30.5%) stddev-sans-first:7544.36 12:16:55 INFO - PID 20025 | Values: 1385.5 1443.3 1459.5 1467.7 1472.4 16406.3 17207.5 17218.4 17245.6 17258.3 16925.3 16955.4 16992.7 17062.7 17067.8 2805.5 2919.6 2921.1 2925.5 2928.3 2758.1 2768.7 2809.1 2809.9 2811.7 2790.3 2904.3 2934.0 2935.6 2935.8 2836.3 2844.0 2860.2 2876.7 2883.1 2713.7 2720.5 2739.1 2739.5 2741.1 16437.8 16481.3 16726.3 16727.7 16737.6 8438.8 8651.1 8797.1 8814.7 8830.4 5165.2 5344.6 5452.3 5483.1 5517.0 2105.0 2112.8 2118.3 2147.1 2148.2 30019.8 30072.0 30275.4 30396.7 30413.5 6715.9 6753.0 6994.6 7001.2 7121.5 19493.4 19528.1 19616.2 19625.1 19644.3 8459.3 8463.4 8472.6 8492.8 8502.5 7609.9 7649.5 7747.1 7831.3 7842.3 5556.9 5820.8 5824.8 5870.2 5885.0 1557.4 1595.4 1698.0 1725.7 1802.8 951.9 964.5 974.8 977.7 988.2 9772.0 10058.0 10119.6 10169.2 10277.4 1041.4 1061.6 1067.2 1070.7 1074.1 5581.8 6030.4 6078.2 6209.7 6305.2 24109.9 24356.8 24540.8 24875.4 24882.8 24271.3 24381.8 24638.9 24661.3 24924.6 12043.4 12188.6 12195.8 12439.0 12443.3 9026.1 9129.7 9178.7 9209.1 9215.3 20020.1 20098.0 20407.9 20689.5 20790.7 20901.8 20941.9 21019.4 21154.0 21287.9 11910.4 11959.2 11969.0 11974.6 12092.0 13994.2 15115.5 15276.8 15280.2 15282.1 12200.8 12319.1 12319.8 12536.6 12735.7 11950.5 12060.5 12169.9 12180.0 12374.1 10915.4 11038.5 11124.5 11143.9 11232.7 8442.5 8506.3 8520.9 8522.7 8693.1 8255.6 8282.4 8332.9 8338.1 8356.8 12:16:55 INFO - PID 20025 | 12:16:55 INFO - PID 20025 | [#4] prototype.html Cycles:180 Average:5665.13 Median:6219.47 stddev:1533.54 (24.7%) stddev-sans-first:1488.17 12:16:55 INFO - PID 20025 | Values: 506.7 546.9 548.0 576.5 578.2 6195.4 6202.5 6227.5 6277.4 6321.2 6165.2 6206.4 6223.4 6223.5 6272.9 4182.5 5017.8 5101.4 5111.5 5122.0 4910.2 4964.0 4975.8 5012.5 5016.6 4953.3 5000.5 5004.7 5022.8 5034.9 4950.1 5020.3 5050.7 5060.1 5063.8 4652.2 4669.0 4680.6 4692.5 4706.0 5971.4 6060.0 6073.8 6075.5 6211.0 5914.2 5929.2 5956.1 5995.4 6015.9 6610.4 6630.3 6661.9 6706.5 6740.1 5232.8 5236.5 5245.8 5255.3 5292.5 6633.3 6717.0 6845.7 6981.6 6987.8 5550.3 5559.9 5573.4 5582.4 5616.0 5596.7 5644.5 5679.5 5714.5 5736.5 6129.1 6150.3 6153.1 6153.2 6178.7 6636.4 6685.6 6721.9 6739.9 6755.2 1963.1 1968.9 1971.9 1975.1 2001.3 1416.3 1448.2 1457.4 1471.4 1483.6 6091.4 6160.9 6165.4 6195.5 6215.5 6480.3 6542.7 6589.8 6597.5 6679.4 6059.6 6202.5 6247.4 6277.4 6333.5 3476.5 3500.0 3518.3 3523.4 3529.6 7070.5 7071.8 7115.3 7120.2 7139.5 6677.8 6788.8 6799.7 6889.5 6907.4 6953.2 6976.8 6977.7 7034.5 7075.7 6539.5 6574.9 6588.6 6615.4 6676.4 6562.2 6574.0 6600.7 6639.4 6661.5 6956.6 6975.6 7006.7 7051.5 7108.4 5393.6 5497.1 5511.5 5545.7 5571.9 6473.7 6573.4 6609.7 6615.3 6682.8 6410.5 6474.7 6491.2 6534.8 6538.7 6441.3 6450.3 6472.1 6498.0 6513.8 6266.2 6376.3 6389.9 6396.0 6475.0 6498.2 6535.8 6540.8 6562.0 6611.4 6359.1 6373.5 6380.5 6388.6 6411.2 12:16:55 INFO - PID 20025 | 12:16:55 INFO - PID 20025 | [#5] yui.html Cycles:180 Average:28684.60 Median:21031.24 stddev:41532.26 (197.5%) stddev-sans-first:41596.60 12:16:55 INFO - PID 20025 | Values: 961.3 963.8 965.4 970.0 976.9 19991.6 20327.0 20493.7 20626.9 20684.5 19695.7 20032.4 20111.0 20141.7 20196.8 999.4 1005.8 1006.1 1009.9 1010.5 1001.3 1029.5 1039.1 1041.2 1041.4 1104.1 1106.6 1106.7 1106.9 1107.2 1039.2 1075.0 1080.2 1093.1 1102.7 790.7 791.5 791.5 791.7 791.9 21477.8 21611.0 21617.7 21625.8 21678.1 23237.8 23654.7 23690.4 23852.9 23904.3 18443.8 18583.3 18657.9 18713.8 18721.3 3869.9 3921.5 3952.1 3966.6 3974.3 152821.2 156651.2 156941.2 157055.0 159357.0 17428.3 17704.9 17771.5 17989.6 18245.4 33468.3 34106.7 34226.8 34608.8 35004.5 8667.5 8682.1 8714.3 8771.5 8788.5 4304.3 4332.6 4345.0 4368.5 4387.8 5889.6 6063.4 6071.1 6092.5 6103.1 990.5 1001.1 1018.3 1025.0 1026.2 747.2 756.5 759.7 776.7 779.9 12891.6 13207.4 13325.7 14165.7 14167.6 740.1 741.9 751.4 760.6 765.7 6142.2 6355.8 6365.3 6375.9 6463.0 148147.0 150395.0 150814.0 153274.0 158990.0 117608.4 120343.4 122723.4 125016.4 126374.0 114335.4 114437.4 116994.4 117248.0 117480.0 14634.3 14895.6 15007.6 15053.1 15239.2 52519.2 52804.7 53297.7 53386.7 53986.7 70627.0 72551.6 72951.3 73917.0 74868.6 20460.6 20592.4 21185.0 21222.0 21253.6 22745.3 22944.2 23131.3 23212.1 23287.7 21637.4 21679.6 22137.0 22162.0 22318.0 18988.2 19047.3 19103.2 19163.7 19179.0 20877.5 21186.0 21257.0 21376.4 21468.4 14229.2 14392.5 14509.3 14682.3 14848.2 15079.3 15216.2 15381.5 15440.8 15491.8 12:16:55 INFO - PID 20025 | -------- Summary: end -------- 12:16:55 INFO - PID 20025 | 12:16:55 INFO - TEST-INFO | 20025: exit 0 12:16:55 INFO - TEST-OK | dromaeo_css | took 1108420ms 12:16:55 INFO - TEST-START | kraken 12:16:55 INFO - Initialising browser for kraken test... 12:16:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41223/getInfo.html -profile /tmp/tmpR0CVrT/profile 12:16:55 INFO - TEST-INFO | started process 20395 (/builds/slave/test/build/application/firefox/firefox http://localhost:41223/getInfo.html) 12:17:01 INFO - TEST-INFO | 20395: exit 0 12:17:01 INFO - Browser initialized. 12:17:01 INFO - Running cycle 1/1 for kraken test... 12:17:01 INFO - Using env: {'DISPLAY': ':0', 12:17:01 INFO - 'HOME': '/home/cltbld', 12:17:01 INFO - 'JSGC_DISABLE_POISONING': '1', 12:17:01 INFO - 'LANG': 'en_US.UTF-8', 12:17:01 INFO - 'LANGUAGE': 'en_US:en', 12:17:01 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:17:01 INFO - 'LOGNAME': 'cltbld', 12:17:01 INFO - 'MAIL': '/var/mail/cltbld', 12:17:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:17:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:17:01 INFO - 'MOZ_CRASHREPORTER': '1', 12:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:01 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:17:01 INFO - 'MOZ_NO_REMOTE': '1', 12:17:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:01 INFO - 'NO_EM_RESTART': '1', 12:17:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:01 INFO - 'PWD': '/builds/slave/test', 12:17:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:17:01 INFO - 'RUST_BACKTRACE': 'full', 12:17:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:17:01 INFO - 'SHELL': '/bin/bash', 12:17:01 INFO - 'SHLVL': '1', 12:17:01 INFO - 'TERM': 'linux', 12:17:01 INFO - 'TMOUT': '86400', 12:17:01 INFO - 'USER': 'cltbld', 12:17:01 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858', 12:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:01 INFO - '_': '/tools/buildbot/bin/python'} 12:17:01 INFO - TEST-INFO | started process 20637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR0CVrT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:17:02 INFO - PID 20637 | 12:17:02 INFO - PID 20637 | (/builds/slave/test/build/application/firefox/firefox:20689): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:17:02 INFO - PID 20637 | 12:17:12 INFO - PID 20637 | RSS: Main: 144363520 12:17:12 INFO - PID 20637 | 12:17:15 INFO - PID 20637 | Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41223/tests/kraken/driver.html?testName=audio-beat-detection) 12:17:16 INFO - PID 20637 | RSS: Main: 150503424 12:17:16 INFO - PID 20637 | 12:17:18 INFO - PID 20637 | Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41223/tests/kraken/driver.html?testName=audio-dft) 12:17:19 INFO - PID 20637 | RSS: Main: 150839296 12:17:19 INFO - PID 20637 | 12:17:22 INFO - PID 20637 | Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41223/tests/kraken/driver.html?testName=audio-fft) 12:17:22 INFO - PID 20637 | RSS: Main: 147816448 12:17:22 INFO - PID 20637 | 12:17:24 INFO - PID 20637 | Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41223/tests/kraken/driver.html?testName=audio-oscillator) 12:17:25 INFO - PID 20637 | RSS: Main: 148377600 12:17:25 INFO - PID 20637 | 12:17:27 INFO - PID 20637 | Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41223/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:17:27 INFO - PID 20637 | RSS: Main: 148725760 12:17:27 INFO - PID 20637 | 12:17:31 INFO - PID 20637 | Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41223/tests/kraken/driver.html?testName=imaging-darkroom) 12:17:31 INFO - PID 20637 | RSS: Main: 148512768 12:17:31 INFO - PID 20637 | 12:17:35 INFO - PID 20637 | Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41223/tests/kraken/driver.html?testName=imaging-desaturate) 12:17:35 INFO - PID 20637 | RSS: Main: 150028288 12:17:35 INFO - PID 20637 | 12:17:38 INFO - PID 20637 | Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41223/tests/kraken/driver.html?testName=json-parse-financial) 12:17:39 INFO - PID 20637 | RSS: Main: 151498752 12:17:39 INFO - PID 20637 | 12:17:40 INFO - PID 20637 | Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41223/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:17:41 INFO - PID 20637 | RSS: Main: 151425024 12:17:41 INFO - PID 20637 | 12:17:43 INFO - PID 20637 | Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41223/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:17:43 INFO - PID 20637 | RSS: Main: 151703552 12:17:43 INFO - PID 20637 | 12:17:45 INFO - PID 20637 | Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41223/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:17:46 INFO - PID 20637 | RSS: Main: 148549632 12:17:46 INFO - PID 20637 | 12:17:48 INFO - PID 20637 | Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:17:49 INFO - PID 20637 | RSS: Main: 148471808 12:17:49 INFO - PID 20637 | 12:17:52 INFO - PID 20637 | Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:17:52 INFO - PID 20637 | RSS: Main: 149250048 12:17:52 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41223/tests/kraken/driver.html?testName=ai-astar) 12:17:54 INFO - PID 20637 | RSS: Main: 150573056 12:17:54 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | __start_tp_report 12:17:54 INFO - PID 20637 | _x_x_mozilla_page_load 12:17:54 INFO - PID 20637 | _x_x_mozilla_page_load_details 12:17:54 INFO - PID 20637 | |i|pagename|runs| 12:17:54 INFO - PID 20637 | |0;ai-astar;106;105;106;106;107;108;106;106;105;107 12:17:54 INFO - PID 20637 | |1;audio-beat-detection;119;113;119;113;113;119;113;114;116;115 12:17:54 INFO - PID 20637 | |2;audio-dft;163;163;162;164;162;162;162;162;164;163 12:17:54 INFO - PID 20637 | |3;audio-fft;75;75;74;73;74;76;74;75;77;74 12:17:54 INFO - PID 20637 | |4;audio-oscillator;78;78;79;77;78;77;78;78;78;77 12:17:54 INFO - PID 20637 | |5;imaging-gaussian-blur;113;113;113;114;118;116;114;116;114;114 12:17:54 INFO - PID 20637 | |6;imaging-darkroom;148;149;156;150;150;150;150;151;150;150 12:17:54 INFO - PID 20637 | |7;imaging-desaturate;95;94;94;94;94;96;94;94;95;95 12:17:54 INFO - PID 20637 | |8;json-parse-financial;44;44;43;45;48;45;44;46;46;43 12:17:54 INFO - PID 20637 | |9;json-stringify-tinderbox;37;37;36;37;37;36;41;41;37;36 12:17:54 INFO - PID 20637 | |10;stanford-crypto-aes;74;72;70;73;72;70;72;75;74;71 12:17:54 INFO - PID 20637 | |11;stanford-crypto-ccm;106;105;110;112;110;107;115;108;111;107 12:17:54 INFO - PID 20637 | |12;stanford-crypto-pbkdf2;159;151;151;149;156;147;154;154;149;154 12:17:54 INFO - PID 20637 | |13;stanford-crypto-sha256-iterative;61;69;63;61;68;61;62;59;62;65 12:17:54 INFO - PID 20637 | __end_tp_report 12:17:54 INFO - PID 20637 | __start_cc_report 12:17:54 INFO - PID 20637 | _x_x_mozilla_cycle_collect,737 12:17:54 INFO - PID 20637 | __end_cc_report 12:17:54 INFO - PID 20637 | __startTimestamp1506107874693__endTimestamp 12:17:54 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | ------- Summary: start ------- 12:17:54 INFO - PID 20637 | Number of tests: 14 12:17:54 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | [#0] ai-astar Cycles:10 Average:106.20 Median:106.00 stddev:0.92 (0.9%) stddev-sans-first:0.97 12:17:54 INFO - PID 20637 | Values: 106.0 105.0 106.0 106.0 107.0 108.0 106.0 106.0 105.0 107.0 12:17:54 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | [#1] audio-beat-detection Cycles:10 Average:115.40 Median:115.50 stddev:2.67 (2.3%) stddev-sans-first:2.50 12:17:54 INFO - PID 20637 | Values: 119.0 113.0 119.0 113.0 113.0 119.0 113.0 114.0 116.0 115.0 12:17:54 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 12:17:54 INFO - PID 20637 | Values: 163.0 163.0 162.0 164.0 162.0 162.0 162.0 162.0 164.0 163.0 12:17:54 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | [#3] audio-fft Cycles:10 Average:74.70 Median:75.00 stddev:1.16 (1.5%) stddev-sans-first:1.22 12:17:54 INFO - PID 20637 | Values: 75.0 75.0 74.0 73.0 74.0 76.0 74.0 75.0 77.0 74.0 12:17:54 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:78.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 12:17:54 INFO - PID 20637 | Values: 78.0 78.0 79.0 77.0 78.0 77.0 78.0 78.0 78.0 77.0 12:17:54 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.65 (1.4%) stddev-sans-first:1.66 12:17:54 INFO - PID 20637 | Values: 113.0 113.0 113.0 114.0 118.0 116.0 114.0 116.0 114.0 114.0 12:17:54 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.00 stddev:2.12 (1.4%) stddev-sans-first:2.06 12:17:54 INFO - PID 20637 | Values: 148.0 149.0 156.0 150.0 150.0 150.0 150.0 151.0 150.0 150.0 12:17:54 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 12:17:54 INFO - PID 20637 | Values: 95.0 94.0 94.0 94.0 94.0 96.0 94.0 94.0 95.0 95.0 12:17:54 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | [#8] json-parse-financial Cycles:10 Average:44.80 Median:45.00 stddev:1.55 (3.4%) stddev-sans-first:1.62 12:17:54 INFO - PID 20637 | Values: 44.0 44.0 43.0 45.0 48.0 45.0 44.0 46.0 46.0 43.0 12:17:54 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | [#9] json-stringify-tinderbox Cycles:10 Average:37.50 Median:37.00 stddev:1.90 (5.1%) stddev-sans-first:2.01 12:17:54 INFO - PID 20637 | Values: 37.0 37.0 36.0 37.0 37.0 36.0 41.0 41.0 37.0 36.0 12:17:54 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | [#10] stanford-crypto-aes Cycles:10 Average:72.30 Median:72.50 stddev:1.70 (2.3%) stddev-sans-first:1.69 12:17:54 INFO - PID 20637 | Values: 74.0 72.0 70.0 73.0 72.0 70.0 72.0 75.0 74.0 71.0 12:17:54 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | [#11] stanford-crypto-ccm Cycles:10 Average:109.10 Median:110.00 stddev:3.07 (2.8%) stddev-sans-first:3.05 12:17:54 INFO - PID 20637 | Values: 106.0 105.0 110.0 112.0 110.0 107.0 115.0 108.0 111.0 107.0 12:17:54 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:154.00 stddev:3.66 (2.4%) stddev-sans-first:3.00 12:17:54 INFO - PID 20637 | Values: 159.0 151.0 151.0 149.0 156.0 147.0 154.0 154.0 149.0 154.0 12:17:54 INFO - PID 20637 | 12:17:54 INFO - PID 20637 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:62.50 stddev:3.25 (5.2%) stddev-sans-first:3.35 12:17:54 INFO - PID 20637 | Values: 61.0 69.0 63.0 61.0 68.0 61.0 62.0 59.0 62.0 65.0 12:17:54 INFO - PID 20637 | -------- Summary: end -------- 12:17:54 INFO - PID 20637 | 12:17:55 INFO - PID 20637 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:17:55 INFO - TEST-INFO | 20637: exit 0 12:17:55 INFO - TEST-OK | kraken | took 59764ms 12:17:55 INFO - SUITE-END | took 1168s 12:17:55 INFO - Completed test suite (00:19:28) 12:17:55 INFO - javascript benchmark 12:17:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9126.555706438248, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3880.1269714314285, 3903.5315762108553, 3904.121572646155, 3928.8624898128573, 3944.1125746706994, 6186.2885768136675, 6198.876022479548, 6260.092286618444, 6269.373062693729, 6368.649724265169, 6162.661053642048, 6231.626102433857, 6248.84377890553, 6264.310925798159, 6292.370762923717, 5402.810901618424, 5584.050711379055, 5622.269105016342, 5623.831285061445, 5642.238297829802, 5616.831495055155, 5659.660420374791, 5709.486146246837, 5767.682777447239, 5776.306843178824, 5493.313335833021, 5605.663660180382, 5633.32400111985, 5712.057510510761, 5732.770689172449, 5596.468335508161, 5669.6314739541795, 5677.9495793278375, 5683.403242659502, 5692.117721753135, 5559.9444005559835, 5583.860403489945, 5620.747066382022, 5672.0, 5712.1431785232135, 6243.282022567372, 6257.155284036688, 6297.0, 6316.242050953915, 6331.14529538511, 6759.729610815611, 6773.62745049027, 6774.187097548276, 6844.8973265401055, 6872.450203983669, 6734.0, 6812.216595091579, 6814.557053791487, 6891.138607674041, 6913.5506192097855, 6330.936690633081, 6411.96794016027, 6415.775447859302, 6419.679016049179, 6451.806445806634, 6937.965310173417, 6942.271061538567, 7024.789256322319, 7026.051483049825, 7060.223375428699, 6614.933850661528, 6688.498362622823, 6693.765718199937, 6749.291324410964, 6764.898526522106, 6752.932470675329, 6797.422219111332, 6866.896996545056, 6895.172579290517, 6906.482013848981, 6708.2956289589865, 6713.328667133248, 6805.421539169127, 6808.319168083152, 6809.3871551559605, 6529.2817790043055, 6672.199336079701, 6713.530052896251, 6814.352636499525, 6848.623325717133, 5009.248612708123, 5019.42276638184, 5034.345535080416, 5038.118329292359, 5038.496150385005, 4548.56788605082, 4562.475315338778, 4585.358049873021, 4606.262997920384, 4640.976795116003, 6288.968555157195, 6318.557700960981, 6375.139356186948, 6400.871982560323, 6443.838904027437, 6580.9470484722215, 6660.500462465335, 6679.365460281266, 6714.429273511806, 6755.493337999571, 6316.4315211630255, 6352.0, 6352.968235158887, 6353.555251132469, 6364.809055728336, 5460.808871689472, 5473.343198816167, 5475.72621368938, 5478.150886612581, 5479.205515200274, 6926.376626103574, 6982.825429364205, 7058.964705176441, 7084.397826184729, 7129.7861064168155, 6756.88511395624, 6784.3894049535775, 6785.117934668363, 6793.6942837573415, 6806.82982925411, 7137.10786151731, 7163.31948464895, 7163.928360716326, 7258.45561582894, 7260.0, 6572.868542629216, 6578.342165783575, 6611.570247933869, 6630.668466576555, 6677.9332206679255, 6822.727090916506, 6840.31596840312, 6852.040714300102, 6859.4512439003765, 6866.6566671667215, 6375.1712277405495, 6572.7042283098335, 6663.5002374821115, 6665.66671666405, 6675.0, 6528.543001989815, 6541.509386795914, 6622.07290979273, 6625.635590042401, 6628.204615446178, 6288.434040936338, 6407.807765767035, 6429.517786165963, 6519.0, 6533.18335208099, 6627.105340778933, 6637.236717777518, 6650.268470468342, 6671.966640166768, 6695.4308883745425, 6347.17486726741, 6382.393672601095, 6406.5515413920575, 6489.0, 6492.805215843532], "value": 6213.339091045201, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [938.7418459923521, 939.66641842146, 965.7489052846261, 994.0655783563454, 994.2493417469809, 42251.57748422515, 44090.779546102305, 44251.33622995658, 44310.77844610777, 44452.33321500172, 41560.37659435103, 41570.584294157125, 41756.37365439521, 41765.37351939716, 41778.791106044504, 7724.845503089935, 7816.101148367954, 7853.175416581234, 7875.684972601089, 7918.604069796516, 7713.884291735629, 7830.491018083806, 7850.568218747967, 7855.489393189453, 7863.606819659023, 7767.922320776805, 8471.788205294855, 8631.95684021579, 8637.870431943526, 8654.264387527068, 8545.786355341135, 8597.699080532151, 8598.269147122503, 8616.353773467015, 8631.093735157812, 8416.0, 8463.23830855226, 8535.231829135346, 8550.52972086535, 8558.61486233121, 39108.0, 39112.608873911464, 39525.60474395248, 39544.40683389751, 39596.0, 3735.6077611850906, 3772.3775577029755, 3781.810909454544, 3787.8484860605545, 3807.1814559869763, 33863.153421164425, 33903.321933561194, 33913.32173356544, 33930.151746206546, 34021.0, 5484.424135465799, 5518.696471694056, 5519.475649813261, 5556.972215138939, 5610.354809196913, 210021.0, 210415.0, 210620.0, 211968.9401552998, 212465.0, 51530.0, 51801.48198518042, 51817.7409112952, 52028.739856300475, 52919.735401322745, 55533.44466555364, 55669.0, 55706.72146639322, 55733.0, 55741.442585574434, 16514.174291285388, 16685.33258669664, 16766.413175538797, 16795.328186872634, 16824.158792060593, 13334.933325333504, 13398.397072131778, 13408.195508269535, 13419.396127174301, 13429.194248345131, 15515.526025027604, 15702.9214853925, 15719.528414147593, 15725.528234152765, 15774.60563485899, 5886.58793884424, 5980.8803823924145, 6068.241469816273, 6097.390260973867, 6218.06728990655, 1087.374759513283, 1097.9615713449991, 1102.8841971593029, 1108.4070022537903, 1114.0419239454063, 25642.871785640953, 25903.870480647474, 25937.870310648326, 25991.870040649676, 26077.217683469527, 1191.666333426642, 1206.4269472000906, 1215.9027277817754, 1217.4643157010887, 1228.8279640850287, 13716.794248086288, 13811.930940345435, 13873.861261387257, 13897.722045559032, 13979.37092830825, 288458.0, 291436.0, 293673.0, 293918.0, 294690.0, 57523.71238143783, 58004.12993805012, 61359.0, 61503.0, 61785.382146177966, 1447.7683570628649, 1473.0940471609883, 1481.9703605928037, 1484.2133669155364, 1495.439210296139, 30770.613524809098, 30848.53727194049, 30931.84534077315, 30969.8451507741, 31187.53218701676, 40086.0, 40342.39486407647, 40488.79755601321, 40495.0, 40508.1898362037, 240073.0, 240174.0, 240255.0, 240604.0, 242194.0, 36409.45385819162, 37040.0, 37072.07319817026, 37182.76903385806, 37571.24857502889, 46834.0, 46841.53158468508, 46996.7650161747, 47242.76378618085, 47331.526684732715, 34197.316053679286, 34331.485027724106, 34572.654273456945, 34685.826570866986, 35261.47107793334, 33690.83154584211, 33720.83139584286, 33918.321633567684, 34287.14282142966, 34447.0, 39422.60577394189, 40315.1936961265, 40595.188096238504, 40632.796836016816, 40847.183056338115, 32691.673083268863, 33047.0, 33203.50194747129, 33350.0, 33496.33007339888, 25108.372290692147, 25457.363565911, 25729.485410292065, 25792.067824400117, 25956.35109122287], "value": 18724.148191181015, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.9357467465919, 612.7916508387148, 618.5731845026932, 618.6628287583264, 631.7536160897249, 22851.42871428213, 23274.41813954652, 23370.649440258367, 23461.178858739946, 23462.64806027911, 25581.488370232582, 26215.475690486226, 26473.27923684959, 26543.336416589595, 26655.600165997526, 6629.105070815451, 6709.127813384253, 6789.117414736077, 6794.558353707018, 6804.829879253009, 6400.0, 6622.304658010912, 6668.199816022084, 6712.328767123297, 6804.217514985766, 6589.802305930806, 6621.73513059477, 6632.1709786276715, 6635.867282654344, 6638.0, 6472.417482426581, 6585.57193782405, 6745.527813053063, 6761.966190169067, 6775.0, 6327.5570710050315, 6332.430081292706, 6335.651539165344, 6336.493080553545, 6339.651319177444, 29751.702482975325, 29981.10056698281, 30178.54732179019, 30227.244318891982, 30267.0, 2222.866628002325, 2228.9331320060423, 2255.0979608156704, 2261.197274967379, 2263.2418139923147, 20272.797272027237, 21386.46533836651, 21489.355319340444, 21533.24633637815, 21569.568608627895, 2517.3958250020046, 2594.818362714611, 2627.605859121128, 2634.499445105424, 2638.6833579970335, 134799.32600337034, 143132.0, 148932.0, 154419.22790386088, 155758.0, 15826.68346633084, 15888.682226355639, 15917.840821591868, 15934.964227325187, 17117.828821711624, 25618.48763024729, 25658.871705641726, 25676.358091047874, 25701.0, 25763.613545796827, 10209.86500467297, 10388.272820902615, 10524.894751052392, 10576.0, 10594.4702764863, 9309.534523273946, 9426.104520070583, 9456.101670341444, 9534.570944307523, 9582.185514231369, 9721.4653194075, 9779.168770654433, 9786.902130978742, 9844.212463002943, 9993.950030249802, 2864.8567571621334, 2896.406236721467, 2927.1218634409593, 2935.544990526472, 2950.3214260720156, 1017.0897047142765, 1018.2057994764095, 1045.529511719714, 1054.678323111443, 1061.1828891753307, 20870.26954056601, 21343.35969920905, 21432.464188395104, 21621.027053782618, 21811.127554897626, 1106.253279036647, 1107.4739498738036, 1115.2360632966445, 1123.6741345009855, 1126.8535090438354, 11621.593244236412, 11752.529898804123, 11895.405229738479, 11915.940420298017, 12036.157468977262, 551640.0, 576780.0, 586087.0, 605687.0, 607974.0, 123002.38498807448, 125054.37472812578, 127583.0, 127697.0, 127964.0, 1212.860521040074, 1214.2896405602821, 1244.4524409259898, 1247.5758242197696, 1247.7816382133271, 18689.25242990265, 19092.23631054742, 19141.90429047846, 19302.613947720685, 19313.03434828281, 61539.692301538205, 62251.0, 63593.0, 64483.677581611795, 65153.348466514726, 78967.21032789598, 79009.60495197488, 79531.20468795238, 79953.0, 80784.59607701923, 15428.9228553861, 15591.0, 15630.609234769221, 15778.13220272896, 15915.522534323989, 24118.758812411652, 24254.15110471125, 24396.0, 24487.0, 24503.877480612482, 19480.902595486932, 19813.0, 20155.496112597302, 20163.193472260944, 20180.091895865015, 17594.208260628046, 17829.821701782817, 18035.458936231935, 18068.0, 18254.17856196501, 18847.15187816524, 18895.244190232235, 19213.03934803282, 19324.32364867279, 19456.0, 15369.615759606098, 15381.3078411474, 15400.383984640488, 15415.229238538253, 15423.768643470132, 17566.560835978693, 18189.54526136857, 19288.71066933969, 19349.61300774005, 19570.80429195747], "value": 12736.66633297758, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.4942945824773, 1443.328852083781, 1459.489178787424, 1467.6917847252078, 1472.3595236072315, 16406.34374625015, 17207.483775486726, 17218.39735609254, 17245.568860778454, 17258.309667613295, 16925.322987080533, 16955.406560770374, 16992.74510882338, 17062.658746825087, 17067.82932170678, 2805.523061079616, 2919.5912572239904, 2921.123662901121, 2925.488039593073, 2928.31184671602, 2758.1174024312227, 2768.695443501213, 2809.1151287344524, 2809.9157025289173, 2811.732885375886, 2790.2745286225627, 2904.3320036391538, 2934.031769516065, 2935.6183696119583, 2935.779816513759, 2836.3334616365137, 2843.9857800710865, 2860.156253905103, 2876.6548014238215, 2883.1350594821574, 2713.6879258885087, 2720.4967081089862, 2739.0824073935255, 2739.465804168188, 2741.0817376179, 16437.753433698505, 16481.34074637013, 16726.330946762115, 16727.749083763752, 16737.581560460963, 8438.789030274293, 8651.091635378258, 8797.076306987738, 8814.735557933209, 8830.381873268874, 5165.173572228463, 5344.599155063347, 5452.291202143696, 5483.095289277265, 5516.972415137939, 2104.968425473619, 2112.757032941216, 2118.2691971269887, 2147.1304121830685, 2148.2481131603968, 30019.849900750574, 30072.0, 30275.394492110256, 30396.69603303983, 30413.543796843063, 6715.865682686319, 6753.0, 6994.5803251805055, 7001.229864714877, 7121.501494895308, 19493.415197544095, 19528.12123454448, 19616.21535138607, 19625.116869740898, 19644.3124490645, 8459.323254139654, 8463.365247606454, 8472.576371181416, 8492.830143397221, 8502.489850608983, 7609.923900761032, 7649.541027538366, 7747.070351557736, 7831.2560306770765, 7842.333401660809, 5556.91664625031, 5820.767169313265, 5824.825255242349, 5870.236869206976, 5885.0, 1557.4393218441353, 1595.3698289175943, 1697.9575510612087, 1725.7411388291605, 1802.7836659600932, 951.9143277105094, 964.5081008685621, 974.8391515400021, 977.6822532676908, 988.17981075707, 9771.951140244253, 10057.99420058003, 10119.595216191417, 10169.186465082776, 10277.383356998604, 1041.4116024446164, 1061.6496556136456, 1067.2315932528568, 1070.6627412365235, 1074.1353210665334, 5581.776728930798, 6030.366811484819, 6078.179445774764, 6209.6895155242055, 6305.180326557518, 24109.879450602635, 24356.756432435803, 24540.754592454203, 24875.378115546893, 24882.751172488406, 24271.271861844172, 24381.756182437948, 24638.87680561586, 24661.26016219516, 24924.626130608056, 12043.397830108459, 12188.634340969786, 12195.817062744067, 12439.0, 12443.315617641116, 9026.052264512131, 9129.726108216764, 9178.67874624385, 9209.125133112344, 9215.308851836005, 20020.099095540445, 20097.995100244636, 20407.8979605101, 20689.482762931046, 20790.68813967822, 20901.790982089984, 20941.89529052345, 21019.369418917457, 21154.0, 21287.8935605321, 11910.404479776149, 11959.162858599815, 11969.042476602026, 11974.64076077719, 12092.0, 13994.230317332644, 15115.546533604009, 15276.847231527543, 15280.235988200324, 15282.083075015535, 12200.816987745013, 12319.137660364047, 12319.815202771786, 12536.561220357244, 12735.745285094432, 11950.521979120738, 12060.51757929708, 12169.878301217228, 12179.96470299999, 12374.13381063317, 10915.39965301916, 11038.50326735315, 11124.499397527292, 11143.888561114285, 11232.66302010941, 8442.535660538484, 8506.319494440553, 8520.914790852012, 8522.74431767048, 8693.130686931256, 8255.587220638823, 8282.378821588525, 8332.916670833214, 8338.082810890675, 8356.791080223044], "value": 7316.385627743726, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.74662668665667, 546.8851541176352, 548.0463992652783, 576.4782871501291, 578.2309528327324, 6195.442410183083, 6202.5037996960245, 6227.501799856001, 6277.372262773721, 6321.209848768904, 6165.229346331708, 6206.4002878330575, 6223.408776166269, 6223.471004964572, 6272.905906411407, 4182.53992060873, 5017.799288028475, 5101.387833459971, 5111.51440613143, 5121.974390128044, 4910.165271903785, 4964.0, 4975.825846095369, 5012.52381023804, 5016.598672106241, 4953.257011448293, 5000.549950504454, 5004.674696144739, 5022.799088036474, 5034.949650503485, 4950.108980383529, 5020.347354843883, 5050.747462626854, 5060.114479966028, 5063.797448102072, 4652.209124448818, 4668.953310466886, 4680.555347242007, 4692.483826779086, 4705.976470117662, 5971.4327138921735, 6059.969700151515, 6073.817785466443, 6075.483583895374, 6210.96894515529, 5914.231149950522, 5929.1995580596495, 5956.120680613898, 5995.430434108796, 6015.939840601582, 6610.3720146586, 6630.303818099078, 6661.866762664768, 6706.530542862001, 6740.056392105109, 5232.843014709565, 5236.502532259429, 5245.842624721265, 5255.316808814868, 5292.497212764782, 6633.336666333376, 6716.966415167893, 6845.691943862538, 6981.616011119438, 6987.790366289019, 5550.333959924835, 5559.9444005560235, 5573.442655734475, 5582.441755824466, 5615.971920140373, 5596.720163991866, 5644.488202749737, 5679.517241034476, 5714.542836573064, 5736.483716465538, 6129.1419201311855, 6150.292716337589, 6153.107799369066, 6153.2000839890525, 6178.69106544671, 6636.402723754885, 6685.6322902240845, 6721.899171512334, 6739.932600674028, 6755.1556055493065, 1963.1264087480934, 1968.911398987049, 1971.8816870987787, 1975.07171629334, 2001.2795393658562, 1416.3343228682502, 1448.1962510806393, 1457.4097490516358, 1471.42557463513, 1483.5920121966547, 6091.42131497507, 6160.907586386208, 6165.414285642857, 6195.504359651217, 6215.539348253157, 6480.269403335591, 6542.695938551001, 6589.80230593083, 6597.47220222381, 6679.365460281266, 6059.575829691879, 6202.472789812826, 6247.437730604177, 6277.435030847246, 6333.493320534346, 3476.478528220787, 3499.9825000875344, 3518.3491054155065, 3523.3657941570764, 3529.5588051493564, 7070.469714771412, 7071.752488662975, 7115.252898445692, 7120.181179164359, 7139.535930164523, 6677.76627818024, 6788.796336109925, 6799.694013769392, 6889.517733758589, 6907.447404207652, 6953.20038195614, 6976.825579360557, 6977.720891164398, 7034.507584469038, 7075.6815943281645, 6539.4768418525455, 6574.868502630016, 6588.571742836701, 6615.402295404648, 6676.429574613711, 6562.245341785756, 6574.022716256787, 6600.702968366339, 6639.3692599203, 6661.467082633475, 6956.582605043714, 6975.581465112109, 7006.671830880291, 7051.541649792747, 7108.431325494052, 5393.6224464287125, 5497.120460726264, 5511.53151982086, 5545.72271386421, 5571.8885622288135, 6473.676316184266, 6573.408393244631, 6609.669516524058, 6615.338466153346, 6682.763688717603, 6410.45511131559, 6474.708638111202, 6491.188601424822, 6534.8366290843105, 6538.673066346759, 6441.323661015714, 6450.322716114741, 6472.126262954441, 6498.0, 6513.804585862432, 6266.248050234001, 6376.266729326187, 6389.87220255583, 6395.968020159869, 6475.0, 6498.155239818793, 6535.810503481197, 6540.8364790880605, 6561.967190164019, 6611.404973552403, 6359.109724638647, 6373.458256048288, 6380.521460890544, 6388.584741991942, 6411.198600174978], "value": 5233.162130919293, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [961.2982522758386, 963.7856301060662, 965.4352203960684, 970.0445061614308, 976.8876579193391, 19991.600167996632, 20327.0, 20493.692594611093, 20626.89686551569, 20684.48288792781, 19695.704564431508, 20032.399028029184, 20110.9944502775, 20141.697874531892, 20196.798032019677, 999.4053538144792, 1005.7988402319529, 1006.0543089495887, 1009.9091081802636, 1010.5301035018715, 1001.3140998416072, 1029.4749677664408, 1039.1167507618502, 1041.2398948767404, 1041.4272150317333, 1104.1056744037355, 1106.6458733205377, 1106.6956586938575, 1106.8727096383898, 1107.224942540221, 1039.153090231459, 1075.0378411321824, 1080.168270431771, 1093.1145771924726, 1102.691246450995, 790.6995341770148, 791.4736700094488, 791.5369508837337, 791.7387262203459, 791.9168487308865, 21477.785222147733, 21611.0, 21617.67573486399, 21625.783742162534, 21678.132874684994, 23237.7676223239, 23654.69899155546, 23690.40773980647, 23852.880735596384, 23904.282871513882, 18443.815561844345, 18583.256669733193, 18657.906710466497, 18713.81286187148, 18721.344752933717, 3869.8839034829, 3921.509811273591, 3952.071263253133, 3966.6430021297933, 3974.324364857981, 152821.23589382094, 156651.21674391668, 156941.21529392395, 157055.0, 159357.0, 17428.302867885144, 17704.911475442797, 17771.466855994342, 17989.550261243574, 18245.36141235077, 33468.330633387195, 34106.65893341035, 34226.82886585551, 34608.82695586506, 35004.47493287603, 8667.479951202948, 8682.088380719933, 8714.259287960467, 8771.517566533774, 8788.516631585324, 4304.268274393361, 4332.566743325642, 4344.978275108604, 4368.497622773358, 4387.780610969438, 5889.587728858939, 6063.423974722395, 6071.089336599545, 6092.45167934888, 6103.1455596216565, 990.4948476277151, 1001.1240164855751, 1018.3126389686931, 1024.9743756406149, 1026.225199974015, 747.2154238050026, 756.485589798931, 759.6733404635949, 776.6970881356276, 779.8752199648029, 12891.613251602466, 13207.40566674502, 13325.73348533024, 14165.71668566623, 14167.645808854655, 740.134043169493, 741.9443541734391, 751.3876190904396, 760.5740785160217, 765.663108232376, 6142.201513803177, 6355.777547785898, 6365.267994180728, 6375.922725774387, 6463.030545418225, 148147.0, 150395.0, 150814.0, 153274.0, 158990.0, 117608.41195793966, 120343.39828300802, 122723.3863830693, 125016.37491812483, 126374.0, 114335.42832285786, 114437.42781286206, 116994.41502792432, 117248.0, 117480.0, 14634.268286585415, 14895.553133406016, 15007.624809379853, 15053.096814191184, 15239.238038097828, 52519.21221181609, 52804.73597631987, 53297.73351133375, 53386.73306633442, 53986.73006634942, 70627.0, 72551.63724181557, 72951.27048729445, 73917.0, 74868.62565687137, 20460.590788183854, 20592.382228533166, 21185.0, 21222.0, 21253.574928501035, 22745.317640470814, 22944.196953106562, 23131.306060818202, 23212.071517139124, 23287.650685240074, 21637.35087947364, 21679.566408672054, 22137.0, 22162.0, 22317.995690194304, 18988.24047038103, 19047.333343332917, 19103.235870565022, 19163.712544312126, 19179.041047947267, 20877.478063048544, 21186.0, 21257.0, 21376.358709238746, 21468.35594932092, 14229.217393043482, 14392.496262631177, 14509.331426885621, 14682.265886705409, 14848.183349915858, 15079.293970074506, 15216.163111029, 15381.461648842236, 15440.768388473956, 15491.84508154904], "value": 10185.236614865105, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1375.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 106.0, 106.0, 107.0, 108.0, 106.0, 106.0, 105.0, 107.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 113.0, 119.0, 113.0, 113.0, 119.0, 113.0, 114.0, 116.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 164.0, 162.0, 162.0, 162.0, 162.0, 164.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 73.0, 74.0, 76.0, 74.0, 75.0, 77.0, 74.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 77.0, 78.0, 77.0, 78.0, 78.0, 78.0, 77.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 118.0, 116.0, 114.0, 116.0, 114.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 156.0, 150.0, 150.0, 150.0, 150.0, 151.0, 150.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 96.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 43.0, 45.0, 48.0, 45.0, 44.0, 46.0, 46.0, 43.0], "value": 44.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 36.0, 37.0, 37.0, 36.0, 41.0, 41.0, 37.0, 36.0], "value": 37.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 70.0, 73.0, 72.0, 70.0, 72.0, 75.0, 74.0, 71.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 110.0, 112.0, 110.0, 107.0, 115.0, 108.0, 111.0, 107.0], "value": 109.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 151.0, 151.0, 149.0, 156.0, 147.0, 154.0, 154.0, 149.0, 154.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 69.0, 63.0, 61.0, 68.0, 61.0, 62.0, 59.0, 62.0, 65.0], "value": 63.1, "unit": "score"}]}]} 12:17:55 INFO - Return code: 0 12:17:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:17:56 INFO - # TBPL SUCCESS # 12:17:56 INFO - Running post-action listener: _package_coverage_data 12:17:56 INFO - Running post-action listener: _resource_record_post_action 12:17:56 INFO - [mozharness: 2017-09-22 19:17:56.002687Z] Finished run-tests step (success) 12:17:56 INFO - Running post-run listener: _resource_record_post_run 12:17:56 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 338984960; Read time: 208; Write time: 335316 12:17:56 INFO - TinderboxPrint: CPU usage
13.1% 12:17:56 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 208 12:17:56 INFO - TinderboxPrint: I/O write bytes / time
338,984,960 / 335,316 12:17:56 INFO - TinderboxPrint: CPU idle
8,217.6 (86.9%) 12:17:56 INFO - TinderboxPrint: CPU user
1,187.6 (12.6%) 12:17:56 INFO - TinderboxPrint: Swap in / out
0 / 0 12:17:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13115392; Read time: 0; Write time: 1744 12:17:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:17:56 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 8192; Write bytes: 325365760; Read time: 208; Write time: 333572 12:17:56 INFO - Running post-run listener: _upload_blobber_files 12:17:56 INFO - Blob upload gear active. 12:17:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:17:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:17:57 INFO - (blobuploader) - INFO - Open directory for files ... 12:17:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:17:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:17:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:17:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:17:58 INFO - (blobuploader) - INFO - Done attempting. 12:17:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:17:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:18:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:04 INFO - (blobuploader) - INFO - Done attempting. 12:18:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:18:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:18:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:05 INFO - (blobuploader) - INFO - Done attempting. 12:18:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:18:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:18:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:06 INFO - (blobuploader) - INFO - Done attempting. 12:18:06 INFO - (blobuploader) - INFO - Iteration through files over. 12:18:06 INFO - Return code: 0 12:18:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:18:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:18:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93934e491f5970a00a273c30dccf8597f6440c4b80504bc69416402a10a21553400f9e6a664617e69654b4db3f97fa40ae8822460680d1a57f3b79fa325fe3ef", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bce794263e963848c57c92b861b230d233431d8135582185a6d8989e047ed260faa67afbab5c890f2e4e5ab44835c7ace84c0bd7b2f6c5e31b182982912d8655", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8183a8609ec6dffa347d55a2dbe78931dceb433dfa2ad3f78530945a4f765643914b24e080eee90a2607171a461523096f2316dda39f9b8dfb8d1449500fd664", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db1b7b72f835181f46f1e6e0252d2c708e1d9eca94ce1a8c6250b42db0f14b776c2d6f0aba45b7eb78b4b84db8de56c2198aa08251c7bd99c330aae95daaf743"} 12:18:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:18:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:18:06 INFO - Contents: 12:18:06 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93934e491f5970a00a273c30dccf8597f6440c4b80504bc69416402a10a21553400f9e6a664617e69654b4db3f97fa40ae8822460680d1a57f3b79fa325fe3ef", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bce794263e963848c57c92b861b230d233431d8135582185a6d8989e047ed260faa67afbab5c890f2e4e5ab44835c7ace84c0bd7b2f6c5e31b182982912d8655", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8183a8609ec6dffa347d55a2dbe78931dceb433dfa2ad3f78530945a4f765643914b24e080eee90a2607171a461523096f2316dda39f9b8dfb8d1449500fd664", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db1b7b72f835181f46f1e6e0252d2c708e1d9eca94ce1a8c6250b42db0f14b776c2d6f0aba45b7eb78b4b84db8de56c2198aa08251c7bd99c330aae95daaf743"} 12:18:06 INFO - Running post-run listener: copy_logs_to_upload_dir 12:18:06 INFO - Copying logs to upload dir... 12:18:06 INFO - mkdir: /builds/slave/test/build/upload/logs 12:18:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.029901 ========= master_lag: -0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-22 12:18:06.909635) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 12:18:06.913979) ========= 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=5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93934e491f5970a00a273c30dccf8597f6440c4b80504bc69416402a10a21553400f9e6a664617e69654b4db3f97fa40ae8822460680d1a57f3b79fa325fe3ef", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bce794263e963848c57c92b861b230d233431d8135582185a6d8989e047ed260faa67afbab5c890f2e4e5ab44835c7ace84c0bd7b2f6c5e31b182982912d8655", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8183a8609ec6dffa347d55a2dbe78931dceb433dfa2ad3f78530945a4f765643914b24e080eee90a2607171a461523096f2316dda39f9b8dfb8d1449500fd664", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db1b7b72f835181f46f1e6e0252d2c708e1d9eca94ce1a8c6250b42db0f14b776c2d6f0aba45b7eb78b4b84db8de56c2198aa08251c7bd99c330aae95daaf743"} build_url:https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93934e491f5970a00a273c30dccf8597f6440c4b80504bc69416402a10a21553400f9e6a664617e69654b4db3f97fa40ae8822460680d1a57f3b79fa325fe3ef", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bce794263e963848c57c92b861b230d233431d8135582185a6d8989e047ed260faa67afbab5c890f2e4e5ab44835c7ace84c0bd7b2f6c5e31b182982912d8655", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8183a8609ec6dffa347d55a2dbe78931dceb433dfa2ad3f78530945a4f765643914b24e080eee90a2607171a461523096f2316dda39f9b8dfb8d1449500fd664", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db1b7b72f835181f46f1e6e0252d2c708e1d9eca94ce1a8c6250b42db0f14b776c2d6f0aba45b7eb78b4b84db8de56c2198aa08251c7bd99c330aae95daaf743"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 12:18:06.945220) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 12:18:06.945563) ========= 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=5bd038846534b2fdfa68eeae000001e2-1506105753.717156-640515858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 12:18:07.024425) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 12:18:07.024740) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 12:18:07.025045) ========= ========= Total master_lag: 0.13 =========