builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-085 starttime: 1504187657.26 results: success (0) revision: fb22415719a9d971a2646fa2d1b74e134ca00c3d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 06:54:17.261302) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 06:54:17.261772) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 06:54:17.262089) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 06:54:17.279830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:54:17.280251) ========= 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=5c37b704b588aaa989324530000001d0-1504187656.131071-718767297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-31 06:54:17-- 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% 109M=0s 2017-08-31 06:54:17 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125874 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:54:17.424174) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:54:17.424488) ========= 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=5c37b704b588aaa989324530000001d0-1504187656.131071-718767297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020515 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:54:17.474086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-31 06:54:17.474427) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fb22415719a9d971a2646fa2d1b74e134ca00c3d --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 fb22415719a9d971a2646fa2d1b74e134ca00c3d --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=5c37b704b588aaa989324530000001d0-1504187656.131071-718767297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-31 06:54:17,631 truncating revision to first 12 chars 2017-08-31 06:54:17,631 Setting DEBUG logging. 2017-08-31 06:54:17,631 attempt 1/10 2017-08-31 06:54:17,631 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fb22415719a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-31 06:54:18,350 unpacking tar archive at: mozilla-central-fb22415719a9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.112259 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-31 06:54:18.601552) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 06:54:18.601868) ========= script_repo_revision: fb22415719a9d971a2646fa2d1b74e134ca00c3d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 06:54:18.602313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 06:54:18.602578) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 06:54:18.619598) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-08-31 06:54:18.619978) ========= /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=5c37b704b588aaa989324530000001d0-1504187656.131071-718767297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:54:18 INFO - MultiFileLogger online at 20170831 06:54:18 in /builds/slave/test 06:54:18 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 06:54:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:54:18 INFO - {'append_to_log': False, 06:54:18 INFO - 'base_work_dir': '/builds/slave/test', 06:54:18 INFO - 'blob_upload_branch': 'Firefox', 06:54:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:54:18 INFO - 'branch': 'Firefox', 06:54:18 INFO - 'buildbot_json_path': 'buildprops.json', 06:54:18 INFO - 'code_coverage': False, 06:54:18 INFO - 'config_files': ('talos/linux_config.py',), 06:54:18 INFO - 'default_actions': ('clobber', 06:54:18 INFO - 'read-buildbot-config', 06:54:18 INFO - 'download-and-extract', 06:54:18 INFO - 'populate-webroot', 06:54:18 INFO - 'create-virtualenv', 06:54:18 INFO - 'install', 06:54:18 INFO - 'setup-mitmproxy', 06:54:18 INFO - 'run-tests'), 06:54:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:54:18 INFO - 'disable_ccov_upload': False, 06:54:18 INFO - 'disable_stylo': False, 06:54:18 INFO - 'download_minidump_stackwalk': True, 06:54:18 INFO - 'download_symbols': 'ondemand', 06:54:18 INFO - 'enable_stylo': False, 06:54:18 INFO - 'enable_webrender': False, 06:54:18 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 06:54:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:54:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:54:18 INFO - 'gecko_profile': False, 06:54:18 INFO - 'gecko_profile_interval': 0, 06:54:18 INFO - 'installer_path': 'installer.exe', 06:54:18 INFO - 'log_level': 'info', 06:54:18 INFO - 'log_name': 'talos', 06:54:18 INFO - 'log_to_console': True, 06:54:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:54:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:54:18 INFO - 'opt_config_files': (), 06:54:18 INFO - 'pip_index': False, 06:54:18 INFO - 'suite': 'dromaeojs-e10s', 06:54:18 INFO - 'system_bits': '32', 06:54:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:54:18 INFO - 'title': 'talos-linux64-ix-085', 06:54:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:54:18 INFO - 'use_talos_json': True, 06:54:18 INFO - 'verify': 'False', 06:54:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:54:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:54:18 INFO - 'work_dir': 'build'} 06:54:18 INFO - [mozharness: 2017-08-31 13:54:18.911031Z] Running clobber step. 06:54:18 INFO - Running pre-action listener: _resource_record_pre_action 06:54:18 INFO - Running main action method: clobber 06:54:18 INFO - rmtree: /builds/slave/test/build 06:54:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:54:19 INFO - Running post-action listener: _resource_record_post_action 06:54:19 INFO - [mozharness: 2017-08-31 13:54:19.932053Z] Finished clobber step (success) 06:54:19 INFO - [mozharness: 2017-08-31 13:54:19.932151Z] Running read-buildbot-config step. 06:54:19 INFO - Running pre-action listener: _resource_record_pre_action 06:54:19 INFO - Running main action method: read_buildbot_config 06:54:19 INFO - Using buildbot properties: 06:54:19 INFO - { 06:54:19 INFO - "project": "", 06:54:19 INFO - "product": "firefox", 06:54:19 INFO - "who": "archaeopteryx@coole-files.de", 06:54:19 INFO - "installer_path": "public/build/target.tar.bz2", 06:54:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:54:19 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 06:54:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:54:19 INFO - "stage_platform": "linux64-pgo", 06:54:19 INFO - "basedir": "/builds/slave/test", 06:54:19 INFO - "buildnumber": 132, 06:54:19 INFO - "platform": "ubuntu64_hw", 06:54:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:54:19 INFO - "slavebuilddir": "test", 06:54:19 INFO - "taskId": "Pc2FXD4dQF627gkhm7Iqqw", 06:54:19 INFO - "branch": "mozilla-central", 06:54:19 INFO - "script_repo_revision": "production", 06:54:19 INFO - "revision": "fb22415719a9d971a2646fa2d1b74e134ca00c3d", 06:54:19 INFO - "slavename": "talos-linux64-ix-085", 06:54:19 INFO - "repo_path": "mozilla-central" 06:54:19 INFO - } 06:54:19 INFO - Finding installer, test and symbols from parent task. 06:54:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pc2FXD4dQF627gkhm7Iqqw'}, attempt #1 06:54:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pc2FXD4dQF627gkhm7Iqqw'}, attempt #1 06:54:20 INFO - Task dependencies: aFFo2BkuTfOVMIWuwaBEfg 06:54:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg'}, attempt #1 06:54:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.tar.bz2 06:54:21 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.test_packages.json 06:54:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.crashreporter-symbols.zip 06:54:21 INFO - Running post-action listener: _resource_record_post_action 06:54:21 INFO - [mozharness: 2017-08-31 13:54:21.296058Z] Finished read-buildbot-config step (success) 06:54:21 INFO - [mozharness: 2017-08-31 13:54:21.296276Z] Running download-and-extract step. 06:54:21 INFO - Running pre-action listener: _resource_record_pre_action 06:54:21 INFO - Running main action method: download_and_extract 06:54:21 INFO - mkdir: /builds/slave/test/build/tests 06:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:21 INFO - trying https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.test_packages.json 06:54:21 INFO - Downloading https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:54:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:54:21 INFO - Downloaded 989 bytes. 06:54:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:54:21 INFO - Using the following test package requirements: 06:54:21 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:54:21 INFO - u'common': [u'target.common.tests.zip'], 06:54:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:54:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:54:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:54:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:54:21 INFO - u'mozbase': [u'target.common.tests.zip'], 06:54:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:54:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:54:21 INFO - u'web-platform': [u'target.common.tests.zip', 06:54:21 INFO - u'target.web-platform.tests.tar.gz'], 06:54:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:54:21 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:54:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.common.tests.zip 06:54:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:54:21 INFO - Fetch https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.common.tests.zip into memory 06:54:22 INFO - Content-Length response header: 55562851 06:54:22 INFO - Bytes received: 55562851 06:54:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:54:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.common.tests.zip 06:54:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:54:34 INFO - Fetch https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.common.tests.zip into memory 06:54:35 INFO - Content-Length response header: 55562851 06:54:35 INFO - Bytes received: 55562851 06:54:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.talos.tests.zip 06:54:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:54:47 INFO - Fetch https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.talos.tests.zip into memory 06:54:47 INFO - Content-Length response header: 14496650 06:54:47 INFO - Bytes received: 14496650 06:54: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')]} 06:54:48 INFO - trying https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.tar.bz2 06:54:48 INFO - Downloading https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:54:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:54:49 INFO - Downloaded 63363691 bytes. 06:54:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.tar.bz2 06:54:49 INFO - mkdir: /builds/slave/test/properties 06:54:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:54:49 INFO - Writing to file /builds/slave/test/properties/build_url 06:54:49 INFO - Contents: 06:54:49 INFO - build_url:https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.tar.bz2 06:54:49 INFO - Running post-action listener: _resource_record_post_action 06:54:49 INFO - Running post-action listener: find_tests_for_verification 06:54:49 INFO - Running post-action listener: set_extra_try_arguments 06:54:49 INFO - [mozharness: 2017-08-31 13:54:49.243259Z] Finished download-and-extract step (success) 06:54:49 INFO - [mozharness: 2017-08-31 13:54:49.243361Z] Running populate-webroot step. 06:54:49 INFO - Running pre-action listener: _resource_record_pre_action 06:54:49 INFO - Running main action method: populate_webroot 06:54:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:54:49 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:54:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:54:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:54:49 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:54:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:54:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:54:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:49 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:54:49 INFO - 'talos_options': ['--enable-stylo'], 06:54:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:54:49 INFO - 'tests': ['damp', 'tps']}, 06:54:49 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:54:49 INFO - 'talos_options': ['--enable-stylo'], 06:54:49 INFO - 'tests': ['damp', 'tps']}, 06:54:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:54:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:54:49 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:54:49 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:54:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:54:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:54:49 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:54:49 INFO - 'talos_options': ['--enable-stylo'], 06:54:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:54:49 INFO - 'other-e10s': {'tests': ['a11yr', 06:54:49 INFO - 'ts_paint', 06:54:49 INFO - 'tpaint', 06:54:49 INFO - 'sessionrestore', 06:54:49 INFO - 'sessionrestore_many_windows', 06:54:49 INFO - 'sessionrestore_no_auto_restore', 06:54:49 INFO - 'tabpaint']}, 06:54:49 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:54:49 INFO - 'tests': ['a11yr', 06:54:49 INFO - 'ts_paint', 06:54:49 INFO - 'tpaint', 06:54:49 INFO - 'sessionrestore', 06:54:49 INFO - 'sessionrestore_many_windows', 06:54:49 INFO - 'sessionrestore_no_auto_restore', 06:54:49 INFO - 'tabpaint']}, 06:54:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:54:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 06:54:49 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:54:49 INFO - 'tests': ['bloom_basic_singleton']}, 06:54:49 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:54:49 INFO - 'tests': ['bloom_basic']}, 06:54:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:54:49 INFO - 'tsvgr_opacity', 06:54:49 INFO - 'tart', 06:54:49 INFO - 'tscrollx', 06:54:49 INFO - 'tsvg_static']}, 06:54:49 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:54:49 INFO - 'tests': ['tsvgx', 06:54:49 INFO - 'tsvgr_opacity', 06:54:49 INFO - 'tart', 06:54:49 INFO - 'tscrollx', 06:54:49 INFO - 'tsvg_static']}, 06:54:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:54:49 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:54:49 INFO - 'talos_options': ['--enable-stylo'], 06:54:49 INFO - 'tests': ['tp5o']}, 06:54:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:54:49 INFO - 'talos_options': ['--mitmproxy', 06:54:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:54:49 INFO - '--firstNonBlankPaint'], 06:54:49 INFO - 'tests': ['tp6_google', 06:54:49 INFO - 'tp6_youtube', 06:54:49 INFO - 'tp6_amazon', 06:54:49 INFO - 'tp6_facebook']}, 06:54:49 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:54:49 INFO - 'talos_options': ['--enable-stylo', 06:54:49 INFO - '--mitmproxy', 06:54:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:54:49 INFO - '--firstNonBlankPaint'], 06:54:49 INFO - 'tests': ['tp6_google', 06:54:49 INFO - 'tp6_youtube', 06:54:49 INFO - 'tp6_amazon', 06:54:49 INFO - 'tp6_facebook']}, 06:54:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:54:49 INFO - 'talos_options': ['--enable-stylo', 06:54:49 INFO - '--stylo-threads=1', 06:54:49 INFO - '--mitmproxy', 06:54:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:54:49 INFO - '--firstNonBlankPaint'], 06:54:49 INFO - 'tests': ['tp6_google', 06:54:49 INFO - 'tp6_youtube', 06:54:49 INFO - 'tp6_amazon', 06:54:49 INFO - 'tp6_facebook']}, 06:54:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:54:49 INFO - 'talos_options': ['--xperf_path', 06:54:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:49 INFO - 'tests': ['tp5n']}, 06:54:49 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:54:49 INFO - 'talos_options': ['--enable-stylo', 06:54:49 INFO - '--xperf_path', 06:54:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:49 INFO - 'tests': ['tp5n']}}} 06:54:49 INFO - Running post-action listener: _resource_record_post_action 06:54:49 INFO - [mozharness: 2017-08-31 13:54:49.257837Z] Finished populate-webroot step (success) 06:54:49 INFO - [mozharness: 2017-08-31 13:54:49.257927Z] Running create-virtualenv step. 06:54:49 INFO - Running pre-action listener: _resource_record_pre_action 06:54:49 INFO - Running main action method: create_virtualenv 06:54:49 INFO - Creating virtualenv /builds/slave/test/build/venv 06:54:49 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:54:49 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 06:54:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:54:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:54:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:54:49 INFO - Installing distribute.............................................................................................................................................................................................done. 06:54:50 INFO - Installing pip...............done. 06:54:50 INFO - Return code: 0 06:54:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:54:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:54:50 INFO - Reading from file tmpfile_stdout 06:54:50 INFO - Output received: 06:54:50 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 06:54:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeadb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa580>, '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 0xeab480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeab910>, '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': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', '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 06:54:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:54:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:54:50 INFO - Using env: {'DISPLAY': ':0', 06:54:50 INFO - 'HOME': '/home/cltbld', 06:54:50 INFO - 'LANG': 'en_US.UTF-8', 06:54:50 INFO - 'LANGUAGE': 'en_US:en', 06:54:50 INFO - 'LOGNAME': 'cltbld', 06:54:50 INFO - 'MAIL': '/var/mail/cltbld', 06:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:50 INFO - 'MOZ_NO_REMOTE': '1', 06:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:50 INFO - 'NO_EM_RESTART': '1', 06:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:50 INFO - 'PWD': '/builds/slave/test', 06:54:50 INFO - 'SHELL': '/bin/bash', 06:54:50 INFO - 'SHLVL': '1', 06:54:50 INFO - 'TERM': 'linux', 06:54:50 INFO - 'TMOUT': '86400', 06:54:50 INFO - 'USER': 'cltbld', 06:54:50 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', 06:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:50 INFO - '_': '/tools/buildbot/bin/python'} 06:54:51 INFO - Ignoring indexes: http://pypi.python.org/simple/ 06:54:51 INFO - Downloading/unpacking pip>=1.5 06:54:51 INFO - Running setup.py egg_info for package pip 06:54:51 INFO - warning: no files found matching 'pip/cacert.pem' 06:54:51 INFO - warning: no files found matching '*.html' under directory 'docs' 06:54:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:54:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:54:51 INFO - Installing collected packages: pip 06:54:51 INFO - Found existing installation: pip 1.1 06:54:51 INFO - Uninstalling pip: 06:54:51 INFO - Successfully uninstalled pip 06:54:51 INFO - Running setup.py install for pip 06:54:51 INFO - warning: no files found matching 'pip/cacert.pem' 06:54:51 INFO - warning: no files found matching '*.html' under directory 'docs' 06:54:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:54:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:54:51 INFO - Installing pip script to /builds/slave/test/build/venv/bin 06:54:51 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 06:54:51 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 06:54:51 INFO - Successfully installed pip 06:54:51 INFO - Cleaning up... 06:54:51 INFO - Return code: 0 06:54:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:54: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')]} 06:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54: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')]} 06:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54: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', '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 0xb3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeadb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa580>, '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 0xeab480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeab910>, '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': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', '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 06:54: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', 'psutil>=3.1.1'] in /builds/slave/test/build 06:54: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 psutil>=3.1.1 06:54:51 INFO - Using env: {'DISPLAY': ':0', 06:54:51 INFO - 'HOME': '/home/cltbld', 06:54:51 INFO - 'LANG': 'en_US.UTF-8', 06:54:51 INFO - 'LANGUAGE': 'en_US:en', 06:54:51 INFO - 'LOGNAME': 'cltbld', 06:54:51 INFO - 'MAIL': '/var/mail/cltbld', 06:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:51 INFO - 'MOZ_NO_REMOTE': '1', 06:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:51 INFO - 'NO_EM_RESTART': '1', 06:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:51 INFO - 'PWD': '/builds/slave/test', 06:54:51 INFO - 'SHELL': '/bin/bash', 06:54:51 INFO - 'SHLVL': '1', 06:54:51 INFO - 'TERM': 'linux', 06:54:51 INFO - 'TMOUT': '86400', 06:54:51 INFO - 'USER': 'cltbld', 06:54:51 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', 06:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:51 INFO - '_': '/tools/buildbot/bin/python'} 06:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:51 INFO - Downloading/unpacking psutil>=3.1.1 06:54: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 06:54: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 06:54: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 06:54: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 06:54:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:54:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:52 INFO - Installing collected packages: psutil 06:54:52 INFO - Running setup.py install for psutil 06:54:52 INFO - building 'psutil._psutil_linux' extension 06:54:52 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 06:54:53 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 06:54:53 INFO - building 'psutil._psutil_posix' extension 06:54:53 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 06:54:53 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 06:54:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:53 INFO - Successfully installed psutil 06:54:53 INFO - Cleaning up... 06:54:53 INFO - Return code: 0 06:54:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:54: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')]} 06:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54: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')]} 06:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeadb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa580>, '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 0xeab480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeab910>, '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': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', '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 06:54: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:54: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 mozsystemmonitor==0.3 06:54:53 INFO - Using env: {'DISPLAY': ':0', 06:54:53 INFO - 'HOME': '/home/cltbld', 06:54:53 INFO - 'LANG': 'en_US.UTF-8', 06:54:53 INFO - 'LANGUAGE': 'en_US:en', 06:54:53 INFO - 'LOGNAME': 'cltbld', 06:54:53 INFO - 'MAIL': '/var/mail/cltbld', 06:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:53 INFO - 'MOZ_NO_REMOTE': '1', 06:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:53 INFO - 'NO_EM_RESTART': '1', 06:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:53 INFO - 'PWD': '/builds/slave/test', 06:54:53 INFO - 'SHELL': '/bin/bash', 06:54:53 INFO - 'SHLVL': '1', 06:54:53 INFO - 'TERM': 'linux', 06:54:53 INFO - 'TMOUT': '86400', 06:54:53 INFO - 'USER': 'cltbld', 06:54:53 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', 06:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:53 INFO - '_': '/tools/buildbot/bin/python'} 06:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:54: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 06:54: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 06:54: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 06:54: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 06:54:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:54:54 INFO - Installing collected packages: mozsystemmonitor 06:54:54 INFO - Running setup.py install for mozsystemmonitor 06:54:54 INFO - Successfully installed mozsystemmonitor 06:54:54 INFO - Cleaning up... 06:54:54 INFO - Return code: 0 06:54:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:54:54 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')]} 06:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:54 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')]} 06:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:54 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 0xb3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeadb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa580>, '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 0xeab480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeab910>, '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': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', '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 06:54:54 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 06:54:54 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 06:54:54 INFO - Using env: {'DISPLAY': ':0', 06:54:54 INFO - 'HOME': '/home/cltbld', 06:54:54 INFO - 'LANG': 'en_US.UTF-8', 06:54:54 INFO - 'LANGUAGE': 'en_US:en', 06:54:54 INFO - 'LOGNAME': 'cltbld', 06:54:54 INFO - 'MAIL': '/var/mail/cltbld', 06:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:54 INFO - 'MOZ_NO_REMOTE': '1', 06:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:54 INFO - 'NO_EM_RESTART': '1', 06:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:54 INFO - 'PWD': '/builds/slave/test', 06:54:54 INFO - 'SHELL': '/bin/bash', 06:54:54 INFO - 'SHLVL': '1', 06:54:54 INFO - 'TERM': 'linux', 06:54:54 INFO - 'TMOUT': '86400', 06:54:54 INFO - 'USER': 'cltbld', 06:54:54 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', 06:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:54 INFO - '_': '/tools/buildbot/bin/python'} 06:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:55 INFO - Downloading/unpacking jsonschema==2.5.1 06:54: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 06:54: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 06:54: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 06:54: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 06:54:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:54:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:56 INFO - Downloading functools32-3.2.3-2.tar.gz 06:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:54:56 INFO - warning: no files found matching '*.txt' 06:54:56 INFO - no previously-included directories found matching 'build' 06:54:56 INFO - no previously-included directories found matching 'dist' 06:54:56 INFO - no previously-included directories found matching '.git*' 06:54:56 INFO - Installing collected packages: jsonschema, functools32 06:54:56 INFO - Running setup.py install for functools32 06:54:56 INFO - warning: no files found matching '*.txt' 06:54:56 INFO - no previously-included directories found matching 'build' 06:54:56 INFO - no previously-included directories found matching 'dist' 06:54:56 INFO - no previously-included directories found matching '.git*' 06:54:56 INFO - Successfully installed jsonschema functools32 06:54:56 INFO - Cleaning up... 06:54:56 INFO - Return code: 0 06:54:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:54:56 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')]} 06:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:56 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')]} 06:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:56 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 0xb3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeadb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa580>, '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 0xeab480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeab910>, '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': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', '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 06:54:56 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 06:54:56 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 06:54:56 INFO - Using env: {'DISPLAY': ':0', 06:54:56 INFO - 'HOME': '/home/cltbld', 06:54:56 INFO - 'LANG': 'en_US.UTF-8', 06:54:56 INFO - 'LANGUAGE': 'en_US:en', 06:54:56 INFO - 'LOGNAME': 'cltbld', 06:54:56 INFO - 'MAIL': '/var/mail/cltbld', 06:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:56 INFO - 'MOZ_NO_REMOTE': '1', 06:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:56 INFO - 'NO_EM_RESTART': '1', 06:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:56 INFO - 'PWD': '/builds/slave/test', 06:54:56 INFO - 'SHELL': '/bin/bash', 06:54:56 INFO - 'SHLVL': '1', 06:54:56 INFO - 'TERM': 'linux', 06:54:56 INFO - 'TMOUT': '86400', 06:54:56 INFO - 'USER': 'cltbld', 06:54:56 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', 06:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:56 INFO - '_': '/tools/buildbot/bin/python'} 06:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:54:56 INFO - Cleaning up... 06:54:56 INFO - Return code: 0 06:54:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:54:56 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')]} 06:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:56 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')]} 06:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:56 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 0xb3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeadb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa580>, '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 0xeab480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeab910>, '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': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', '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 06:54:56 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 06:54:56 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 06:54:56 INFO - Using env: {'DISPLAY': ':0', 06:54:56 INFO - 'HOME': '/home/cltbld', 06:54:56 INFO - 'LANG': 'en_US.UTF-8', 06:54:56 INFO - 'LANGUAGE': 'en_US:en', 06:54:56 INFO - 'LOGNAME': 'cltbld', 06:54:56 INFO - 'MAIL': '/var/mail/cltbld', 06:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:56 INFO - 'MOZ_NO_REMOTE': '1', 06:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:56 INFO - 'NO_EM_RESTART': '1', 06:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:56 INFO - 'PWD': '/builds/slave/test', 06:54:56 INFO - 'SHELL': '/bin/bash', 06:54:56 INFO - 'SHLVL': '1', 06:54:56 INFO - 'TERM': 'linux', 06:54:56 INFO - 'TMOUT': '86400', 06:54:56 INFO - 'USER': 'cltbld', 06:54:56 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', 06:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:56 INFO - '_': '/tools/buildbot/bin/python'} 06:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:57 INFO - Downloading/unpacking blobuploader==1.2.4 06:54: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 06:54: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 06:54: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 06:54: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 06:54:58 INFO - Downloading blobuploader-1.2.4.tar.gz 06:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:54:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:54:58 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 06:54:58 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 06:54:58 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 06:54:58 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 06:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:54:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:54:58 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 06:54:58 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 06:54:58 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 06:54:58 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 06:54:58 INFO - Downloading docopt-0.6.1.tar.gz 06:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:54:58 INFO - Installing collected packages: blobuploader, requests, docopt 06:54:58 INFO - Running setup.py install for blobuploader 06:54:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:54:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:54:58 INFO - Running setup.py install for requests 06:54:59 INFO - Running setup.py install for docopt 06:54:59 INFO - Successfully installed blobuploader requests docopt 06:54:59 INFO - Cleaning up... 06:54:59 INFO - Return code: 0 06:54:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54:59 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')]} 06:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:59 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')]} 06:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:59 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 0xb3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeadb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa580>, '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 0xeab480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeab910>, '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': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', '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 06:54:59 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 06:54:59 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 06:54:59 INFO - Using env: {'DISPLAY': ':0', 06:54:59 INFO - 'HOME': '/home/cltbld', 06:54:59 INFO - 'LANG': 'en_US.UTF-8', 06:54:59 INFO - 'LANGUAGE': 'en_US:en', 06:54:59 INFO - 'LOGNAME': 'cltbld', 06:54:59 INFO - 'MAIL': '/var/mail/cltbld', 06:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:59 INFO - 'MOZ_NO_REMOTE': '1', 06:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:59 INFO - 'NO_EM_RESTART': '1', 06:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:59 INFO - 'PWD': '/builds/slave/test', 06:54:59 INFO - 'SHELL': '/bin/bash', 06:54:59 INFO - 'SHLVL': '1', 06:54:59 INFO - 'TERM': 'linux', 06:54:59 INFO - 'TMOUT': '86400', 06:54:59 INFO - 'USER': 'cltbld', 06:54:59 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', 06:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:59 INFO - '_': '/tools/buildbot/bin/python'} 06:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:54:59 INFO - Running setup.py (path:/tmp/pip-Vqav2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:54:59 INFO - Running setup.py (path:/tmp/pip-TrImJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:54:59 INFO - Running setup.py (path:/tmp/pip-anPQpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:54:59 INFO - Running setup.py (path:/tmp/pip-h4pILn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:54:59 INFO - Running setup.py (path:/tmp/pip-5j2ubl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:54:59 INFO - Running setup.py (path:/tmp/pip-y4xahR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:54:59 INFO - Running setup.py (path:/tmp/pip-8k2Ly7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:54:59 INFO - Running setup.py (path:/tmp/pip-jZxl4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:00 INFO - Running setup.py (path:/tmp/pip-z8vVWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:00 INFO - Running setup.py (path:/tmp/pip-7YomVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:00 INFO - Running setup.py (path:/tmp/pip-eJFmWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:00 INFO - Running setup.py (path:/tmp/pip-ewOkdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:00 INFO - Running setup.py (path:/tmp/pip-On08vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:00 INFO - Running setup.py (path:/tmp/pip-c08PKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:00 INFO - Running setup.py (path:/tmp/pip-7l_J88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:00 INFO - Running setup.py (path:/tmp/pip-IYJUUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:00 INFO - Running setup.py (path:/tmp/pip-lCu3kV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:55:00 INFO - Running setup.py install for manifestparser 06:55:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:55:00 INFO - Running setup.py install for mozcrash 06:55:00 INFO - Running setup.py install for mozdebug 06:55:00 INFO - Running setup.py install for mozdevice 06:55:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:55:01 INFO - Running setup.py install for mozfile 06:55:01 INFO - Running setup.py install for mozhttpd 06:55:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:55:01 INFO - Running setup.py install for mozinfo 06:55:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:55:01 INFO - Running setup.py install for mozInstall 06:55:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:55:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:55:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:55:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:55:01 INFO - Running setup.py install for mozleak 06:55:01 INFO - Running setup.py install for mozlog 06:55:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:55:01 INFO - Running setup.py install for moznetwork 06:55:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:55:01 INFO - Running setup.py install for mozprocess 06:55:01 INFO - Running setup.py install for mozprofile 06:55:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:55:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:55:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:55:02 INFO - Running setup.py install for mozrunner 06:55:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:55:02 INFO - Running setup.py install for mozscreenshot 06:55:02 INFO - Running setup.py install for moztest 06:55:02 INFO - Running setup.py install for mozversion 06:55:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:55:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:55:02 INFO - Cleaning up... 06:55:02 INFO - Return code: 0 06:55:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:02 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')]} 06:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:02 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')]} 06:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:02 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 0xb3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeadb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa580>, '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 0xeab480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeab910>, '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': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', '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 06:55:02 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 06:55:02 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 06:55:02 INFO - Using env: {'DISPLAY': ':0', 06:55:02 INFO - 'HOME': '/home/cltbld', 06:55:02 INFO - 'LANG': 'en_US.UTF-8', 06:55:02 INFO - 'LANGUAGE': 'en_US:en', 06:55:02 INFO - 'LOGNAME': 'cltbld', 06:55:02 INFO - 'MAIL': '/var/mail/cltbld', 06:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:02 INFO - 'MOZ_NO_REMOTE': '1', 06:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:02 INFO - 'NO_EM_RESTART': '1', 06:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:02 INFO - 'PWD': '/builds/slave/test', 06:55:02 INFO - 'SHELL': '/bin/bash', 06:55:02 INFO - 'SHLVL': '1', 06:55:02 INFO - 'TERM': 'linux', 06:55:02 INFO - 'TMOUT': '86400', 06:55:02 INFO - 'USER': 'cltbld', 06:55:02 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', 06:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:02 INFO - '_': '/tools/buildbot/bin/python'} 06:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:02 INFO - Running setup.py (path:/tmp/pip-yo6UCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:02 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)) 06:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:02 INFO - Running setup.py (path:/tmp/pip-XKlUFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:02 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)) 06:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:02 INFO - Running setup.py (path:/tmp/pip-J2JQV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:02 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)) 06:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:02 INFO - Running setup.py (path:/tmp/pip-r8SY6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:02 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)) 06:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:02 INFO - Running setup.py (path:/tmp/pip-DfuAJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55: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)) 06:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:03 INFO - Running setup.py (path:/tmp/pip-_fxE9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55: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)) 06:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:03 INFO - Running setup.py (path:/tmp/pip-gxmHhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:03 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)) 06:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:03 INFO - Running setup.py (path:/tmp/pip-Omu9Ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:03 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)) 06:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:03 INFO - Running setup.py (path:/tmp/pip-C_dVou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:03 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)) 06:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:03 INFO - Running setup.py (path:/tmp/pip-C9XwPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:03 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)) 06:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:03 INFO - Running setup.py (path:/tmp/pip-7IXW6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:03 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)) 06:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:03 INFO - Running setup.py (path:/tmp/pip-pt6rRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:03 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)) 06:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:03 INFO - Running setup.py (path:/tmp/pip-xtYUIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:03 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)) 06:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:03 INFO - Running setup.py (path:/tmp/pip-pwnfw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:03 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)) 06:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:03 INFO - Running setup.py (path:/tmp/pip-vDtOUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:03 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)) 06:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:03 INFO - Running setup.py (path:/tmp/pip-9EZSbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:03 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)) 06:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:03 INFO - Running setup.py (path:/tmp/pip-9KbTZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:03 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)) 06:55:03 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)) 06:55:03 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)) 06:55:03 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)) 06:55:03 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)) 06:55:03 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)) 06:55:03 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)) 06:55:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:55:03 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 06:55:03 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 06:55:03 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 06:55:03 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 06:55:05 INFO - Downloading blessings-1.6.tar.gz 06:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:55:05 INFO - Installing collected packages: blessings 06:55:05 INFO - Running setup.py install for blessings 06:55:05 INFO - Successfully installed blessings 06:55:05 INFO - Cleaning up... 06:55:05 INFO - Return code: 0 06:55:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:05 INFO - Reading from file tmpfile_stdout 06:55:05 INFO - Current package versions: 06:55:05 INFO - argparse == 1.2.1 06:55:05 INFO - blessings == 1.6 06:55:05 INFO - blobuploader == 1.2.4 06:55:05 INFO - docopt == 0.6.1 06:55:05 INFO - functools32 == 3.2.3-2 06:55:05 INFO - jsonschema == 2.5.1 06:55:05 INFO - manifestparser == 1.1 06:55:05 INFO - mozInstall == 1.13 06:55:05 INFO - mozcrash == 1.0 06:55:05 INFO - mozdebug == 0.1 06:55:05 INFO - mozdevice == 0.51 06:55:05 INFO - mozfile == 1.2 06:55:05 INFO - mozhttpd == 0.7 06:55:05 INFO - mozinfo == 0.10 06:55:05 INFO - mozleak == 0.1 06:55:05 INFO - mozlog == 3.5 06:55:05 INFO - moznetwork == 0.27 06:55:05 INFO - mozprocess == 0.25 06:55:05 INFO - mozprofile == 0.28 06:55:05 INFO - mozrunner == 6.13 06:55:05 INFO - mozscreenshot == 0.1 06:55:05 INFO - mozsystemmonitor == 0.3 06:55:05 INFO - moztest == 0.8 06:55:05 INFO - mozversion == 1.4 06:55:05 INFO - psutil == 3.1.1 06:55:05 INFO - requests == 1.2.3 06:55:05 INFO - wsgiref == 0.1.2 06:55:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:05 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')]} 06:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:05 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')]} 06:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:05 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 0xb3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeadb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa580>, '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 0xeab480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeab910>, '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': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', '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 06:55:05 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 06:55:05 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 06:55:05 INFO - Using env: {'DISPLAY': ':0', 06:55:05 INFO - 'HOME': '/home/cltbld', 06:55:05 INFO - 'LANG': 'en_US.UTF-8', 06:55:05 INFO - 'LANGUAGE': 'en_US:en', 06:55:05 INFO - 'LOGNAME': 'cltbld', 06:55:05 INFO - 'MAIL': '/var/mail/cltbld', 06:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:05 INFO - 'MOZ_NO_REMOTE': '1', 06:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:05 INFO - 'NO_EM_RESTART': '1', 06:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:05 INFO - 'PWD': '/builds/slave/test', 06:55:05 INFO - 'SHELL': '/bin/bash', 06:55:05 INFO - 'SHLVL': '1', 06:55:05 INFO - 'TERM': 'linux', 06:55:05 INFO - 'TMOUT': '86400', 06:55:05 INFO - 'USER': 'cltbld', 06:55:05 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', 06:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:05 INFO - '_': '/tools/buildbot/bin/python'} 06:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:05 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)) 06:55:05 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)) 06:55:05 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)) 06:55:05 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)) 06:55:05 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)) 06:55:05 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)) 06:55:05 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)) 06:55:05 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)) 06:55:05 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)) 06:55:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:55:05 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 06:55:05 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 06:55:05 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 06:55:05 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 06:55:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:55:06 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)) 06:55:06 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)) 06:55:06 INFO - Installing collected packages: simplejson 06:55:06 INFO - Running setup.py install for simplejson 06:55:06 INFO - building 'simplejson._speedups' extension 06:55:06 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 06:55:07 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 06:55:07 INFO - Successfully installed simplejson 06:55:07 INFO - Cleaning up... 06:55:07 INFO - Return code: 0 06:55:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:55:07 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')]} 06:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:07 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')]} 06:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:07 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 0xb3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd06a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeadb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa580>, '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 0xeab480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeab910>, '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': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', '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 06:55:07 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 06:55:07 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 06:55:07 INFO - Using env: {'DISPLAY': ':0', 06:55:07 INFO - 'HOME': '/home/cltbld', 06:55:07 INFO - 'LANG': 'en_US.UTF-8', 06:55:07 INFO - 'LANGUAGE': 'en_US:en', 06:55:07 INFO - 'LOGNAME': 'cltbld', 06:55:07 INFO - 'MAIL': '/var/mail/cltbld', 06:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:07 INFO - 'MOZ_NO_REMOTE': '1', 06:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:07 INFO - 'NO_EM_RESTART': '1', 06:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:07 INFO - 'PWD': '/builds/slave/test', 06:55:07 INFO - 'SHELL': '/bin/bash', 06:55:07 INFO - 'SHLVL': '1', 06:55:07 INFO - 'TERM': 'linux', 06:55:07 INFO - 'TMOUT': '86400', 06:55:07 INFO - 'USER': 'cltbld', 06:55:07 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', 06:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:07 INFO - '_': '/tools/buildbot/bin/python'} 06:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:55:08 INFO - Cleaning up... 06:55:08 INFO - Return code: 0 06:55:08 INFO - Running post-action listener: _resource_record_post_action 06:55:08 INFO - Running post-action listener: _start_resource_monitoring 06:55:08 INFO - Starting resource monitoring. 06:55:08 INFO - [mozharness: 2017-08-31 13:55:08.165577Z] Finished create-virtualenv step (success) 06:55:08 INFO - [mozharness: 2017-08-31 13:55:08.166089Z] Running install step. 06:55:08 INFO - Running pre-action listener: _resource_record_pre_action 06:55:08 INFO - Running main action method: install 06:55:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:08 INFO - Reading from file tmpfile_stdout 06:55:08 INFO - Detecting whether we're running mozinstall >=1.0... 06:55:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:55:08 INFO - Reading from file tmpfile_stdout 06:55:08 INFO - Output received: 06:55:08 INFO - Usage: mozinstall [options] installer 06:55:08 INFO - Options: 06:55:08 INFO - -h, --help show this help message and exit 06:55:08 INFO - -d DEST, --destination=DEST 06:55:08 INFO - Directory to install application into. [default: 06:55:08 INFO - "/builds/slave/test"] 06:55:08 INFO - --app=APP Application being installed. [default: firefox] 06:55:08 INFO - mkdir: /builds/slave/test/build/application 06:55:08 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'] 06:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:55:26 INFO - Reading from file tmpfile_stdout 06:55:26 INFO - Output received: 06:55:26 INFO - /builds/slave/test/build/application/firefox/firefox 06:55:26 INFO - Running post-action listener: _resource_record_post_action 06:55:26 INFO - [mozharness: 2017-08-31 13:55:26.072920Z] Finished install step (success) 06:55:26 INFO - [mozharness: 2017-08-31 13:55:26.073199Z] Running setup-mitmproxy step. 06:55:26 INFO - Running pre-action listener: _resource_record_pre_action 06:55:26 INFO - Running main action method: setup_mitmproxy 06:55:26 INFO - Skipping: mitmproxy is not required 06:55:26 INFO - Running post-action listener: _resource_record_post_action 06:55:26 INFO - [mozharness: 2017-08-31 13:55:26.074331Z] Finished setup-mitmproxy step (success) 06:55:26 INFO - [mozharness: 2017-08-31 13:55:26.074557Z] Running run-tests step. 06:55:26 INFO - Running pre-action listener: _resource_record_pre_action 06:55:26 INFO - Running pre-action listener: _set_gcov_prefix 06:55:26 INFO - Running main action method: run_tests 06:55:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:55:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:55:26 INFO - Python 2.7.3 06:55:26 INFO - Return code: 0 06:55:26 INFO - grabbing minidump binary from tooltool 06:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:26 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 0xeaa580>, '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 0xeab480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeab910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:55:26 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 06:55:26 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 06:55:26 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 06:55:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:55:26 INFO - Return code: 0 06:55:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:55:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:55:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:55:26 INFO - ENV: RUST_BACKTRACE is now full 06:55:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:55:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:55:26 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/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 06:55:26 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/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-085 --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 06:55:26 INFO - Using env: {'DISPLAY': ':0', 06:55:26 INFO - 'HOME': '/home/cltbld', 06:55:26 INFO - 'LANG': 'en_US.UTF-8', 06:55:26 INFO - 'LANGUAGE': 'en_US:en', 06:55:26 INFO - 'LOGNAME': 'cltbld', 06:55:26 INFO - 'MAIL': '/var/mail/cltbld', 06:55:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:55:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:55:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:26 INFO - 'MOZ_NO_REMOTE': '1', 06:55:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:55:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:26 INFO - 'NO_EM_RESTART': '1', 06:55:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:26 INFO - 'PWD': '/builds/slave/test', 06:55:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:55:26 INFO - 'RUST_BACKTRACE': 'full', 06:55:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:55:26 INFO - 'SHELL': '/bin/bash', 06:55:26 INFO - 'SHLVL': '1', 06:55:26 INFO - 'TERM': 'linux', 06:55:26 INFO - 'TMOUT': '86400', 06:55:26 INFO - 'USER': 'cltbld', 06:55:26 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', 06:55:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:26 INFO - '_': '/tools/buildbot/bin/python'} 06:55:26 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/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 06:55:26 INFO - mozversion application_buildid: 20170831123711 06:55:26 INFO - mozversion application_changeset: fb22415719a9d971a2646fa2d1b74e134ca00c3d 06:55:26 INFO - mozversion application_display_name: Nightly 06:55:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:55:26 INFO - mozversion application_name: Firefox 06:55:26 INFO - mozversion application_remotingname: firefox 06:55:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:55:26 INFO - mozversion application_vendor: Mozilla 06:55:26 INFO - mozversion application_version: 57.0a1 06:55:26 INFO - mozversion platform_buildid: 20170831123711 06:55:26 INFO - mozversion platform_changeset: fb22415719a9d971a2646fa2d1b74e134ca00c3d 06:55:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:55:26 INFO - mozversion platform_version: 57.0a1 06:55:26 INFO - using testdate: 1504187726 06:55:26 INFO - actual date: 1504187726 06:55:26 INFO - starting webserver on 'localhost:40698' 06:55:26 INFO - SUITE-START | Running 2 tests 06:55:26 INFO - TEST-START | dromaeo_css 06:55:26 INFO - Initialising browser for dromaeo_css test... 06:55:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40698/getInfo.html -profile /tmp/tmpdKapOk/profile 06:55:26 INFO - TEST-INFO | started process 17008 (/builds/slave/test/build/application/firefox/firefox http://localhost:40698/getInfo.html) 06:55:31 INFO - TEST-INFO | 17008: exit 0 06:55:31 INFO - Browser initialized. 06:55:31 INFO - Running cycle 1/1 for dromaeo_css test... 06:55:31 INFO - Using env: {'DISPLAY': ':0', 06:55:31 INFO - 'HOME': '/home/cltbld', 06:55:31 INFO - 'JSGC_DISABLE_POISONING': '1', 06:55:31 INFO - 'LANG': 'en_US.UTF-8', 06:55:31 INFO - 'LANGUAGE': 'en_US:en', 06:55:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:55:31 INFO - 'LOGNAME': 'cltbld', 06:55:31 INFO - 'MAIL': '/var/mail/cltbld', 06:55:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:55:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:55:31 INFO - 'MOZ_CRASHREPORTER': '1', 06:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:55:31 INFO - 'MOZ_NO_REMOTE': '1', 06:55:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:55:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:31 INFO - 'NO_EM_RESTART': '1', 06:55:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:31 INFO - 'PWD': '/builds/slave/test', 06:55:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:55:31 INFO - 'RUST_BACKTRACE': 'full', 06:55:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:55:31 INFO - 'SHELL': '/bin/bash', 06:55:31 INFO - 'SHLVL': '1', 06:55:31 INFO - 'TERM': 'linux', 06:55:31 INFO - 'TMOUT': '86400', 06:55:31 INFO - 'USER': 'cltbld', 06:55:31 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', 06:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:31 INFO - '_': '/tools/buildbot/bin/python'} 06:55:31 INFO - TEST-INFO | started process 17196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdKapOk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:55:32 INFO - PID 17196 | 06:55:32 INFO - PID 17196 | (/builds/slave/test/build/application/firefox/firefox:17247): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:55:32 INFO - PID 17196 | 06:55:42 INFO - PID 17196 | RSS: Main: 163512320 06:55:42 INFO - PID 17196 | 06:58:41 INFO - PID 17196 | Cycle 1(1): loaded http://localhost:40698/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40698/tests/dromaeo/cssquery-ext.html) 06:58:43 INFO - PID 17196 | RSS: Main: 165269504 06:58:43 INFO - PID 17196 | 07:01:44 INFO - PID 17196 | Cycle 1(1): loaded http://localhost:40698/tests/dromaeo/cssquery-ext.html (next: http://localhost:40698/tests/dromaeo/cssquery-jquery.html) 07:01:45 INFO - PID 17196 | RSS: Main: 161632256 07:01:45 INFO - PID 17196 | 07:04:46 INFO - PID 17196 | Cycle 1(1): loaded http://localhost:40698/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40698/tests/dromaeo/cssquery-mootools.html) 07:04:47 INFO - PID 17196 | RSS: Main: 164511744 07:04:47 INFO - PID 17196 | 07:07:48 INFO - PID 17196 | Cycle 1(1): loaded http://localhost:40698/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40698/tests/dromaeo/cssquery-prototype.html) 07:07:49 INFO - PID 17196 | RSS: Main: 162533376 07:07:49 INFO - PID 17196 | 07:10:52 INFO - PID 17196 | Cycle 1(1): loaded http://localhost:40698/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40698/tests/dromaeo/cssquery-yui.html) 07:10:53 INFO - PID 17196 | RSS: Main: 164102144 07:10:53 INFO - PID 17196 | 07:13:55 INFO - PID 17196 | Cycle 1(1): loaded http://localhost:40698/tests/dromaeo/cssquery-yui.html (next: http://localhost:40698/tests/dromaeo/cssquery-dojo.html) 07:13:55 INFO - PID 17196 | RSS: Main: 165130240 07:13:55 INFO - PID 17196 | 07:13:55 INFO - PID 17196 | __start_tp_report 07:13:55 INFO - PID 17196 | _x_x_mozilla_page_load 07:13:55 INFO - PID 17196 | _x_x_mozilla_page_load_details 07:13:55 INFO - PID 17196 | |i|pagename|runs| 07:13:55 INFO - PID 17196 | |0;dojo.html;3907.1404291055965;3912.1393293475444;3934.4295077213806;3936.3505021671417;3955.129871428285;6618.768343107992;6750.763723269681;6765.3572910573475;6777;6823.795286141418;6610.8016759497295;6689.2976237495095;6719.697613607387;6768.492363072777;6774.458043356532;5933.703314834241;5937.346891841905;5957.821265362024;5964.701764911737;5981.252343457068;6028.156058151841;6057.878842423171;6062.363451837559;6069.848253793646;6111.327753947062;6109.14471973924;6141.2937512186;6160.507159427235;6166.691665416712;6215.658138802364;5983.551233657493;6079.2400949881485;6089.360617135181;6161.907571386433;6177.598456100339;5541.972290138524;5911.231539899829;6054.8183554493435;6055.9697201514155;6063.363346848561;6667.833304167386;6761.290064543201;6798.150231221098;6833.760818371333;6839.2818754031105;7289.489735718502;7341.082364704412;7353.522021068614;7404.777856664308;7424.2204568520065;7287.988278824913;7328.890066649004;7374.778756637309;7415.073115860518;7421.5176013559485;6890.724371025153;6891.655417229119;6905.620190889499;6958.512904096715;6972.442204623618;7525.661345239478;7544.811379715551;7565.659545320474;7637.770866874002;7652.081750190013;7241.782746517613;7290.526115802456;7353.889691654629;7359.484836061424;7423.1834498206235;7269.67678263015;7295.416366690652;7370.262973702587;7372.963135184397;7435;7276.304795993496;7328.67020984057;7392.926070739331;7443.85112297751;7452.701891924262;7370.410367170613;7393.334599886036;7473.925260747432;7480.0649918760155;7495.737649182252;6256.968715156395;6259.6870156492905;6320.051992201114;6341.904871426932;6373.71318290678;5355.116405793001;5424.159255315432;5429.239906413105;5444.618876678674;5563.109902415594;6288.088227207029;6367.044943258548;6427.228732552124;6441.452476539453;6442.871142577216;7153.856922861618;7197.280271972761;7241.782746517613;7258.709651613982;7259.52813067149;6321.273053598803;6322.241331040304;6327.050942358591;6329.936700633027;6333.334999825044;6653.4677225821815;6654.434373078246;6654.767083152066;6657.667116644148;6661.933380666228;6972.093627828452;6974.651267436608;6987.9301206987275;7081.433485321265;7089.539179953286;7277.482502241339;7282.31091999873;7368.300011498899;7386.926130738839;7392.667329970057;6897.517173797786;7009.2990700929495;7078.610676412641;7089.751858684921;7103.538270012433;7226.602536860313;7288.96355518219;7297.525660832029;7322.157951835394;7346.595937223504;6923.169219693669;7370.668319925723;7390.5196162249285;7478.401727861649;7486;7039.472039596948;7059.117610298713;7081.468889833386;7156.499045067004;7164.713411463483;6926.168859736864;7030.437564994686;7046.647667616496;7059.011738356737;7131.928680713334;7011.929880701332;7030.683619237045;7047.471439641945;7126.429885609243;7127.10911136108;7127.216006239413;7131.179914309921;7155.821104472222;7166.749163779243;7173.641317934187;6842.24735279109;6895.561267190754;6901.75843845463;7000.50996430245;7008.22909479967 07:13:55 INFO - PID 17196 | |1;ext.html;904.3940559824916;939.38939689202;967.1295833749626;995.8157740817949;996.3274789517075;41617;42658.360124598155;42672.573274267284;42699.57300426995;42733;40656.796716016375;40697.59302406975;40727.59272407275;40789.59210407895;40941.59058409415;7328.8167795805;7359.852802943938;7457.515261507984;7462.17916029239;7467.253274672516;7312.5246858954;7387.815304617401;7387.852242955138;7390.187079421259;7391.1500177479475;7372.410207183412;7377.409807215437;7385.852282954338;7396.815079622998;7403.740869069584;7319.963400183018;7336.119665640104;7340.889886651705;7343.88984165238;7345.449091318119;6743.224529179109;6787.04981302618;6796.286389929036;6805.897911531331;6814.1482314710665;34424.65575344239;34784.30431391358;34835.129121771904;34836.30327393463;34893;3473.583170019614;3480.878169264089;3490.4415293553166;3491.0748651607346;3491.598466176397;27776.30559236015;27932;28017.29956751077;28061;28175.295617609518;4632.652551058651;4792.353032340659;4824.662273640846;4835.540623640783;4867.9269810952865;210839;211797;213219;214070;226013.86993065095;52052.739736301075;52483;52511.73744131255;52531.949361012565;52537.211941820904;54138;54313.72843135759;54318;54328;54333.72833135809;15350.07899526032;15408.460703875311;15482.071075735492;15483.071015739091;15673;12644.936775316064;12683.746325073447;12688.619341419771;12716.554920577735;12717.364131793373;13951.511697090553;14050.36773345202;14051.648708782363;14104.153750774987;14200.076994995292;5382.757775900016;5434.347878254634;5473.507384335429;5503.394626591072;5553.500184983371;1088.9782204355868;1093.371311495893;1098.906592939593;1101.1686176936362;1122.45560902962;24916.377090572518;25027.87486062558;25048.37379065538;25138.497230055298;25371.87314063418;1177.0054304113182;1184.1119160629528;1188.2751521571834;1203.3441774233063;1204.8855358740905;13116.278604676643;13279.800802987962;13485.730285394433;13503.392347344394;13509.864901351057;248084;251870;251892;252134;252203;54823.451765482634;55180.17229741557;55295.72352138294;55338.16992745112;55546.44453555493;1508.276027506781;1514.9848501514844;1534.3632392557188;1543.1821134798574;1552.8680062194614;24129.155479558834;31731.206719831265;32139.196520087185;32603.67396326101;33042;54414;54782.45217547774;55015;55050.17424738712;55156.17265741097;226925;227121;227134;227218;227747;35664.465033025044;37616.24767504689;38403.615963840006;38452;38467.6153238464;48980;49300.26049609187;50118.74940625273;50133.498665012885;50412;35899;36503.817480912425;36774.44838327481;36803.44794828133;37185;36411.635883640825;36426.635733642324;36437.08907277339;36660.81669591635;37261.25477490489;42429;42853.1429371417;43091.35362969495;43182.35226471668;43260;34662.82668586641;34886.476702849985;35034.29931401409;35186.824065879504;35660;27298.863505682344;27965.440691186468;27982.160535183975;28315.15054548367;28625.856870715514 07:13:55 INFO - PID 17196 | |2;jquery.html;594.9821505354838;601.4406601860268;605.9000264956283;607.778160971245;627.9591826531275;22474.213402530913;22998.195063172792;23311.533769324626;23345;23376.649350259737;26920.326991825164;27337;27456.176314710592;27460;27499.17502474924;6676.232233293161;6821.079154314179;6835.726570937157;6843.315668433167;6849.212340580847;6427.967860160693;6681.66591670417;6689.2976237495095;6717.563358381714;6718.462522998173;6681.3986741193285;6687.799366019027;6692.130023096991;6693.6318502482345;6693.866122677544;6678.232003319632;6680.465562755016;6684.3315668433015;6686.130802995628;6689.866202675944;6189.6286222826775;6196.101565273055;6215.81352559424;6222.502199824004;6224.719887605023;30422;31271;31441;31658.52512212319;32116.518252226237;2136.1882484655885;2152.2036846366786;2157.4174972757423;2162.7188465499544;2163.318554655294;20255.189792408288;20946.79053209479;20950.47623809417;20983;21042.894785525976;2467.7038755349295;2514.7485251474704;2576.626389173578;2583.7803786678155;2584.767370936606;150809;151247;154205;154336;154796.22601886917;15521.37914483408;15540.766888496682;15830.52508424749;16451.91774041122;16639.750403743954;25564.23307300784;25608.615870761954;25657.61513577298;25697.100601478858;26476.735232647814;10477.10944569705;10590.470476476145;10612.840807387895;10795.892041079645;10831.458427078614;9750.317477776487;9778.65774697882;9812.313138080408;9861.063198996084;9900.900990990142;9581.13769760711;9681.903180968242;9718.368306060225;10033.347832391017;10136.806905824642;2753.2153336299457;2845.587389828463;2937.8090424122365;2948.7935844491108;2968.450836595237;1033.1012019543045;1052.9684109476727;1061.1722856172198;1062.18211976779;1063.3938654966594;22287.55424891493;22463.101475941105;22665.660015099787;23058.65412018821;26538.867305663734;1100.878903320634;1103.9116870650328;1113.3486910157649;1113.7716768062528;1124.3366413815888;12297.44661490235;14926.70146597062;15812.92093539525;15890.76163857543;16132;675753;677114.0721481903;686246;692544;707686;126947.3652631731;133250;136153;136925;138103;1249.7125661097998;1255.6546949588935;1298.8701129886936;1304.693397051692;1306.7451846889765;23138.190163344203;23222.651660224772;23358.76641233566;23477.530449390575;23517.647235291828;63228;64277.357226427135;64533.67733161304;65501.67249163723;65682.67158664177;78529;81838;83199.5840020796;83485.58257208676;84231.5788421054;15842.52472425829;16175.352985880432;16230.51308460748;16241.837581624033;16435.26041328119;25029.87485062563;25247.36881577975;25407.237782866545;25435.236942891745;25493.74506254988;20508.487287817923;20525.38423847287;20874.47813804667;21060.894695527037;21208.36374908755;17581.120943952494;17650.234976502248;17970.640587188445;18259.45221643353;18488.260469581066;20988.475288117308;21021;21318;22463.550728985654;22495;16005.439809606607;16069.035857848567;16146.596335091717;16217;16266.268017939457;20181.19275229033;20241.79758202458;20564;20609.278675246296;20615.690764638242 07:13:55 INFO - PID 17196 | |3;mootools.html;1456.5484699743079;1500.4898334566246;1502.0987407555474;1527.4339110294704;1539.1150088699;16481.67036659266;17145.91427042866;17168.39910603129;17202.999999999985;17224.224909879053;16454.177291135424;17758.82241177588;17788.911055444736;17826.64346713065;17827.286908523645;2800.663920329553;2857.957130643042;2876.0077773168327;2877.1656219696265;2881.927951801201;2609.0868196131296;2659.5079910216673;2700.2439316991176;2816.380396312818;2938.515145001072;2917.095700332893;2941.558766185068;2955.8374289414073;2964.5553167024905;2965.866536005874;2593.818432709711;2595.2603508000225;2603.127952136027;2610.8433493990233;2613.0592986524834;2642.6696662917134;2671.2654020144423;2677.799165062628;2679.3301674581353;2680.0485827531334;16494.42269520573;16782.328706851713;16805;16899.155042247963;16908.915455422768;8295.087540370554;8547.145285471466;8557.786055348604;8574.828503429959;8581.098984606651;5263.973680131575;5362.624616276862;5406.621536492447;5530.170474428827;5705.885882282372;2085.15551201762;2144.603248399051;2151.7095192149172;2191.430228140679;2202.515446601745;31297.217569560944;31372.843135784402;31505.21236969071;31509.684903151134;31572.842135789404;6884;7138;7190.856182876313;7210.242924492957;7221.350078492961;19533;19598.70601940972;19633.901830490755;19646.901765491366;19701.40895773129;8128.309093726981;8259.42184047111;8261.793455163668;8268.338532917352;8268.793280168044;7423.591702456309;7620.428467864822;7649.082110146818;7654.617269136521;7657.310842024244;5277.525022747971;5492.615516913777;5498.340199176125;5499.7250137492965;5512.724363781875;1357.362039841273;1387.2855479428104;1564.1944398634712;1579.9447019354268;1616.4988853455466;936.9063093690713;956.0821611253136;967.9128878400837;973.4694591447678;977.0034564743921;8125.75622731319;8202.466839655403;8232.547209903392;8274.29668478186;8277.296429803535;1036.7667274863247;1046.4715318763976;1052.8262836632023;1075.2473268711933;1084.046039485248;5339.652922560022;5472.753726082336;5495.505404513613;5510.889782204334;5590.217369568264;24259.878700606736;24889;25272.494550109262;25280;25687;23650;24676.629850552257;24744.505109897702;24811.875940620543;25039.749602504107;12293.200941938745;12505.874941250653;12636.620901372973;12757.872421275668;12782.552610658768;9360.4383736976;9458.479783611967;9522.0954009369;9530.046995300414;9575.808483830424;20731;21070.683939741222;21225.575488490453;21951.231706890183;22438;21867.781322186576;22177.223797167022;22412.32763017047;22481.43796405103;22800.88599557058;13209.669758256121;13608.047436679337;13611.11527750693;13615.319234038061;13617.455301787817;14681.486147985197;15090.094594324375;15654.765178522559;15816.841831581536;15847.52457426279;11720;11775.23460975034;11902.702432439259;11903.226290291102;12217.51129954792;11789;11831.033657680899;12132.636020919386;12174.391280435766;12279.570215042431;10558.894411056099;10732.51703673321;10754;10756;10774.838377424188;7254;7284.745033923788;7314.34170924598;7317.634118293958;7321.231270716711;7403.185649578434;7440.516366436164;7448.851022979402;7472.252774722484;7639.656215470428 07:13:55 INFO - PID 17196 | |4;prototype.html;536.3403014292418;553.5460922043923;579.1688926390627;580.9186713860059;585.93554708982;6525.608463492188;6587.6706164691695;6623.470122390209;6627.436667883229;6628.801135965917;6358.491320694345;6377.170967774183;6486.837829054264;6489.707963141658;6525.249596296428;5150.510701483353;5336.946630533684;5338.786448542063;5354.357477102753;5381.7578208980685;5106.412762532319;5207.895842083156;5217.321788139371;5246.737663116848;5273.707941554325;5289.973550132244;5296.417394086667;5320.201969704556;5343.96929166916;5347;5247.160454327309;5285.339332583427;5294.987904596229;5335.573154147659;5405.837824865261;4943.604511639061;4948.282499037619;4982.800687972477;4994.425641051289;5044.39467263927;6340.207474065742;6386.808395748135;6434.388733070351;6439.93560064398;6478.514111441661;6220.284667263278;6241.313455519889;6283.214598175228;6304.5586808922935;6376.29860715321;6873.175218973755;6921.723131074751;6942.680890630764;7019.82450438738;7075.497628673788;5514.476124768181;5540.722963851791;5549.77800887964;5563.276774019392;5583.609147359686;7017.578945263301;7071.82320441993;7105.89341159883;7319.194888562254;7320.560766354036;5677.17680936262;5742.54059675225;5760.251167348218;5814.273215848019;5815.73829177688;5803.564732645069;5848.356680765112;5864.824055278348;5869.8239052828485;5921.3190483094995;6223.688815559204;6290.741851629692;6300.684965751694;6376.681165941684;6400.583962042452;6992.755253566203;7028.7348277310575;7053.717851285994;7069.575825450489;7078.1506219254015;2011.7988201179764;2037.3582321568658;2038.3782946201254;2046.8567200296134;2060.464279287396;1448.2758620689656;1502.248875562219;1521.6195951012246;1527.7708343748304;1536.6004838741785;6031.487323577458;6054.66699331541;6068.331208917495;6075.635461872302;6141.9078713818435;6943.444524438033;6973.825654358681;7017.614031228331;7018.263082376379;7110.360067593838;6044.969775151184;6093.360197179321;6113.694315284218;6122.479589234876;6137.754489820357;3681.9079523012138;3692.2061756722433;3717.423799311111;3722.758020728644;3729.978717239045;6738.764143254963;6764.864702705919;6787.321267873272;6798.422134118557;6802.455803535705;7099.538529995534;7232.493725439274;7327.340539351378;7335.119785625652;7342.339189472973;6575.671216439255;6653.434458070925;6773.288804675537;6774.051632771515;6779.389854913082;6938.363421899646;7014.333638304353;7055;7059.399951004222;7081.327273908971;7100.9289907100265;7149.785506434607;7158.785236442915;7167.749128780468;7172.641367931687;6555.901661474986;6683.198016238082;6737.427318677967;6797.28628494001;6840.521163518506;5624.971875140598;5640.294963129609;5644;5654.604177707685;5675.921574900755;6675.299093595297;6818.352256535622;6936.306369363023;6951.2353641098425;7040.190378106583;6714.362135597111;6715.731370745311;6783;6815.352541508549;6859.07402500676;6617.2721000688925;6671.566348187353;6731.32686731323;6761.628110453776;6767.93232067673;6541.803745887631;6641.800745977628;6655.301193374626;6681.997700344793;6784.864302714017;6746.6626668665385;6776.864462710817;6814.989578074381;6855.211650660238;6885.793426197222;6525.314841941527;6546.279909210079;6627.403533681992;6656.83357916056;6668.166479190101 07:13:55 INFO - PID 17196 | |5;yui.html;979.1921664626681;991.063445044433;1015.3349556040791;1017.3946501831413;1021.0453226233468;16970.321187152498;17166.82833171668;17524.386646467377;18053.09734513274;19289.22843086275;18750.624987500243;18980;19010.71483927742;19014.334498292563;19055.714164287547;1040.7762331098813;1068.3536460441437;1078.95684172633;1097.8353247012933;1099.2415233488907;1114.0419239454063;1120.0423637789695;1125.0718157520039;1126.1666366888485;1127.4982632728438;1149.3046706742425;1152.965411037666;1153.2042890405594;1153.6596703972307;1153.8038533449292;1142.714321419645;1145.5131569083148;1145.604766355606;1145.7135716070982;1145.7937571237173;843.1105184030845;843.1399972028557;843.3169133002226;843.8649816029467;844.2570537926586;17714.557136071573;17735.911320443443;17839.375621853174;17892.821071789247;18041.458756237334;18022.90988545062;18401.53996150107;18562.350317738816;18782.060896955096;18796.24815007398;14953.925230373887;15479.922600386926;15636.4527241546;15637.452689155938;15640.4525841595;3802.8098595070137;3848.942265866014;3851.0372406898277;3851.961480385188;3852.595477474853;135731;136473.3301129936;141831.29084354616;141882;143518;13564.186148830904;13580.38888250031;13898.652533686536;14028.22844743549;14132;25295.62056569153;25393;25497;25584.10455634044;25586.616200757002;8112.18878112184;8153;8164.346852251806;8181.95909020463;8194.590270486451;3511.4908338290807;3665.6884164846288;4093.692973027035;4271.2738834397605;4294.82820687169;4842.6368022398465;4942.1104201244125;4945.2087665973995;4964.280179373971;4971.055499455092;1100.5542755184163;1100.9174311926638;1112.5327362507767;1120.9327440353604;1138.5824648312903;747.6336595068486;764.636797521173;767.3132546370966;778.5717855179629;786.2334224131426;12205;12212.328321942201;12406.689832754073;12709.364531773374;13460.99042571811;752.2402373602591;754.9245075492516;759.9088109426793;768.0821418404953;775.7517594369748;4656.720596764205;4707.105649926503;4723.811047558059;4740.691855029412;4749.95250047502;131208.3439582815;134408.3279583596;135200;136613;137081;115956;116057.4197129009;118459;118885;122581;98089;98198.07207711611;98601;100049.49975250223;101733;12759;12828.679283017625;12948.870511294766;13104.344782760632;13639.863601363859;48331.5166848327;49072;51439;51646;52767.73616131895;82593.58703206446;83422;84586.57706711427;85907;88635.55682221548;17840.643187136444;18074.638507230044;18242.45272641823;18392.264309428007;18523.629527409645;19269.325573605416;19379.709304360727;19672.606547869247;19916;20169;18552.907235463736;18638.720419193993;18891.90554047221;18906.810931890504;18909.43271701851;18085.909570452062;18132.093395329917;18295.908520457844;18361.357352493134;18543.72184417208;16946.66106677884;17271.3955011574;17545.82454175442;18045.278188872297;18180.45458636243;11524.366159861289;11535.307881527135;12087.093467990111;12167.695807604881;12344.13591048618;12765.808512872129;12804.10371274002;12983.156094854183;14003.229822359868;14276.57170284893 07:13:55 INFO - PID 17196 | __end_tp_report 07:13:55 INFO - PID 17196 | __start_cc_report 07:13:55 INFO - PID 17196 | _x_x_mozilla_cycle_collect,336 07:13:55 INFO - PID 17196 | __end_cc_report 07:13:55 INFO - PID 17196 | __startTimestamp1504188835388__endTimestamp 07:13:55 INFO - PID 17196 | 07:13:55 INFO - PID 17196 | ------- Summary: start ------- 07:13:55 INFO - PID 17196 | Number of tests: 6 07:13:55 INFO - PID 17196 | 07:13:55 INFO - PID 17196 | [#0] dojo.html Cycles:165 Average:6750.87 Median:6974.65 stddev:736.98 (10.6%) stddev-sans-first:704.67 07:13:55 INFO - PID 17196 | Values: 3907.1 3912.1 3934.4 3936.4 3955.1 6618.8 6750.8 6765.4 6777.0 6823.8 6610.8 6689.3 6719.7 6768.5 6774.5 5933.7 5937.3 5957.8 5964.7 5981.3 6028.2 6057.9 6062.4 6069.8 6111.3 6109.1 6141.3 6160.5 6166.7 6215.7 5983.6 6079.2 6089.4 6161.9 6177.6 5542.0 5911.2 6054.8 6056.0 6063.4 6667.8 6761.3 6798.2 6833.8 6839.3 7289.5 7341.1 7353.5 7404.8 7424.2 7288.0 7328.9 7374.8 7415.1 7421.5 6890.7 6891.7 6905.6 6958.5 6972.4 7525.7 7544.8 7565.7 7637.8 7652.1 7241.8 7290.5 7353.9 7359.5 7423.2 7269.7 7295.4 7370.3 7373.0 7435.0 7276.3 7328.7 7392.9 7443.9 7452.7 7370.4 7393.3 7473.9 7480.1 7495.7 6257.0 6259.7 6320.1 6341.9 6373.7 5355.1 5424.2 5429.2 5444.6 5563.1 6288.1 6367.0 6427.2 6441.5 6442.9 7153.9 7197.3 7241.8 7258.7 7259.5 6321.3 6322.2 6327.1 6329.9 6333.3 6653.5 6654.4 6654.8 6657.7 6661.9 6972.1 6974.7 6987.9 7081.4 7089.5 7277.5 7282.3 7368.3 7386.9 7392.7 6897.5 7009.3 7078.6 7089.8 7103.5 7226.6 7289.0 7297.5 7322.2 7346.6 6923.2 7370.7 7390.5 7478.4 7486.0 7039.5 7059.1 7081.5 7156.5 7164.7 6926.2 7030.4 7046.6 7059.0 7131.9 7011.9 7030.7 7047.5 7126.4 7127.1 7127.2 7131.2 7155.8 7166.7 7173.6 6842.2 6895.6 6901.8 7000.5 7008.2 07:13:55 INFO - PID 17196 | 07:13:55 INFO - PID 17196 | [#1] ext.html Cycles:180 Average:41378.34 Median:36582.32 stddev:60218.22 (164.6%) stddev-sans-first:60310.46 07:13:55 INFO - PID 17196 | Values: 904.4 939.4 967.1 995.8 996.3 41617.0 42658.4 42672.6 42699.6 42733.0 40656.8 40697.6 40727.6 40789.6 40941.6 7328.8 7359.9 7457.5 7462.2 7467.3 7312.5 7387.8 7387.9 7390.2 7391.2 7372.4 7377.4 7385.9 7396.8 7403.7 7320.0 7336.1 7340.9 7343.9 7345.4 6743.2 6787.0 6796.3 6805.9 6814.1 34424.7 34784.3 34835.1 34836.3 34893.0 3473.6 3480.9 3490.4 3491.1 3491.6 27776.3 27932.0 28017.3 28061.0 28175.3 4632.7 4792.4 4824.7 4835.5 4867.9 210839.0 211797.0 213219.0 214070.0 226013.9 52052.7 52483.0 52511.7 52531.9 52537.2 54138.0 54313.7 54318.0 54328.0 54333.7 15350.1 15408.5 15482.1 15483.1 15673.0 12644.9 12683.7 12688.6 12716.6 12717.4 13951.5 14050.4 14051.6 14104.2 14200.1 5382.8 5434.3 5473.5 5503.4 5553.5 1089.0 1093.4 1098.9 1101.2 1122.5 24916.4 25027.9 25048.4 25138.5 25371.9 1177.0 1184.1 1188.3 1203.3 1204.9 13116.3 13279.8 13485.7 13503.4 13509.9 248084.0 251870.0 251892.0 252134.0 252203.0 54823.5 55180.2 55295.7 55338.2 55546.4 1508.3 1515.0 1534.4 1543.2 1552.9 24129.2 31731.2 32139.2 32603.7 33042.0 54414.0 54782.5 55015.0 55050.2 55156.2 226925.0 227121.0 227134.0 227218.0 227747.0 35664.5 37616.2 38403.6 38452.0 38467.6 48980.0 49300.3 50118.7 50133.5 50412.0 35899.0 36503.8 36774.4 36803.4 37185.0 36411.6 36426.6 36437.1 36660.8 37261.3 42429.0 42853.1 43091.4 43182.4 43260.0 34662.8 34886.5 35034.3 35186.8 35660.0 27298.9 27965.4 27982.2 28315.2 28625.9 07:13:55 INFO - PID 17196 | 07:13:55 INFO - PID 17196 | [#2] jquery.html Cycles:180 Average:42830.61 Median:23328.27 stddev:114334.79 (490.1%) stddev-sans-first:114611.55 07:13:55 INFO - PID 17196 | Values: 595.0 601.4 605.9 607.8 628.0 22474.2 22998.2 23311.5 23345.0 23376.6 26920.3 27337.0 27456.2 27460.0 27499.2 6676.2 6821.1 6835.7 6843.3 6849.2 6428.0 6681.7 6689.3 6717.6 6718.5 6681.4 6687.8 6692.1 6693.6 6693.9 6678.2 6680.5 6684.3 6686.1 6689.9 6189.6 6196.1 6215.8 6222.5 6224.7 30422.0 31271.0 31441.0 31658.5 32116.5 2136.2 2152.2 2157.4 2162.7 2163.3 20255.2 20946.8 20950.5 20983.0 21042.9 2467.7 2514.7 2576.6 2583.8 2584.8 150809.0 151247.0 154205.0 154336.0 154796.2 15521.4 15540.8 15830.5 16451.9 16639.8 25564.2 25608.6 25657.6 25697.1 26476.7 10477.1 10590.5 10612.8 10795.9 10831.5 9750.3 9778.7 9812.3 9861.1 9900.9 9581.1 9681.9 9718.4 10033.3 10136.8 2753.2 2845.6 2937.8 2948.8 2968.5 1033.1 1053.0 1061.2 1062.2 1063.4 22287.6 22463.1 22665.7 23058.7 26538.9 1100.9 1103.9 1113.3 1113.8 1124.3 12297.4 14926.7 15812.9 15890.8 16132.0 675753.0 677114.1 686246.0 692544.0 707686.0 126947.4 133250.0 136153.0 136925.0 138103.0 1249.7 1255.7 1298.9 1304.7 1306.7 23138.2 23222.7 23358.8 23477.5 23517.6 63228.0 64277.4 64533.7 65501.7 65682.7 78529.0 81838.0 83199.6 83485.6 84231.6 15842.5 16175.4 16230.5 16241.8 16435.3 25029.9 25247.4 25407.2 25435.2 25493.7 20508.5 20525.4 20874.5 21060.9 21208.4 17581.1 17650.2 17970.6 18259.5 18488.3 20988.5 21021.0 21318.0 22463.6 22495.0 16005.4 16069.0 16146.6 16217.0 16266.3 20181.2 20241.8 20564.0 20609.3 20615.7 07:13:55 INFO - PID 17196 | 07:13:55 INFO - PID 17196 | [#3] mootools.html Cycles:180 Average:10374.93 Median:2594.54 stddev:7857.91 (302.9%) stddev-sans-first:7851.38 07:13:55 INFO - PID 17196 | Values: 1456.5 1500.5 1502.1 1527.4 1539.1 16481.7 17145.9 17168.4 17203.0 17224.2 16454.2 17758.8 17788.9 17826.6 17827.3 2800.7 2858.0 2876.0 2877.2 2881.9 2609.1 2659.5 2700.2 2816.4 2938.5 2917.1 2941.6 2955.8 2964.6 2965.9 2593.8 2595.3 2603.1 2610.8 2613.1 2642.7 2671.3 2677.8 2679.3 2680.0 16494.4 16782.3 16805.0 16899.2 16908.9 8295.1 8547.1 8557.8 8574.8 8581.1 5264.0 5362.6 5406.6 5530.2 5705.9 2085.2 2144.6 2151.7 2191.4 2202.5 31297.2 31372.8 31505.2 31509.7 31572.8 6884.0 7138.0 7190.9 7210.2 7221.4 19533.0 19598.7 19633.9 19646.9 19701.4 8128.3 8259.4 8261.8 8268.3 8268.8 7423.6 7620.4 7649.1 7654.6 7657.3 5277.5 5492.6 5498.3 5499.7 5512.7 1357.4 1387.3 1564.2 1579.9 1616.5 936.9 956.1 967.9 973.5 977.0 8125.8 8202.5 8232.5 8274.3 8277.3 1036.8 1046.5 1052.8 1075.2 1084.0 5339.7 5472.8 5495.5 5510.9 5590.2 24259.9 24889.0 25272.5 25280.0 25687.0 23650.0 24676.6 24744.5 24811.9 25039.7 12293.2 12505.9 12636.6 12757.9 12782.6 9360.4 9458.5 9522.1 9530.0 9575.8 20731.0 21070.7 21225.6 21951.2 22438.0 21867.8 22177.2 22412.3 22481.4 22800.9 13209.7 13608.0 13611.1 13615.3 13617.5 14681.5 15090.1 15654.8 15816.8 15847.5 11720.0 11775.2 11902.7 11903.2 12217.5 11789.0 11831.0 12132.6 12174.4 12279.6 10558.9 10732.5 10754.0 10756.0 10774.8 7254.0 7284.7 7314.3 7317.6 7321.2 7403.2 7440.5 7448.9 7472.3 7639.7 07:13:55 INFO - PID 17196 | 07:13:55 INFO - PID 17196 | [#4] prototype.html Cycles:180 Average:5870.26 Median:6459.22 stddev:1567.42 (24.3%) stddev-sans-first:1519.83 07:13:55 INFO - PID 17196 | Values: 536.3 553.5 579.2 580.9 585.9 6525.6 6587.7 6623.5 6627.4 6628.8 6358.5 6377.2 6486.8 6489.7 6525.2 5150.5 5336.9 5338.8 5354.4 5381.8 5106.4 5207.9 5217.3 5246.7 5273.7 5290.0 5296.4 5320.2 5344.0 5347.0 5247.2 5285.3 5295.0 5335.6 5405.8 4943.6 4948.3 4982.8 4994.4 5044.4 6340.2 6386.8 6434.4 6439.9 6478.5 6220.3 6241.3 6283.2 6304.6 6376.3 6873.2 6921.7 6942.7 7019.8 7075.5 5514.5 5540.7 5549.8 5563.3 5583.6 7017.6 7071.8 7105.9 7319.2 7320.6 5677.2 5742.5 5760.3 5814.3 5815.7 5803.6 5848.4 5864.8 5869.8 5921.3 6223.7 6290.7 6300.7 6376.7 6400.6 6992.8 7028.7 7053.7 7069.6 7078.2 2011.8 2037.4 2038.4 2046.9 2060.5 1448.3 1502.2 1521.6 1527.8 1536.6 6031.5 6054.7 6068.3 6075.6 6141.9 6943.4 6973.8 7017.6 7018.3 7110.4 6045.0 6093.4 6113.7 6122.5 6137.8 3681.9 3692.2 3717.4 3722.8 3730.0 6738.8 6764.9 6787.3 6798.4 6802.5 7099.5 7232.5 7327.3 7335.1 7342.3 6575.7 6653.4 6773.3 6774.1 6779.4 6938.4 7014.3 7055.0 7059.4 7081.3 7100.9 7149.8 7158.8 7167.7 7172.6 6555.9 6683.2 6737.4 6797.3 6840.5 5625.0 5640.3 5644.0 5654.6 5675.9 6675.3 6818.4 6936.3 6951.2 7040.2 6714.4 6715.7 6783.0 6815.4 6859.1 6617.3 6671.6 6731.3 6761.6 6767.9 6541.8 6641.8 6655.3 6682.0 6784.9 6746.7 6776.9 6815.0 6855.2 6885.8 6525.3 6546.3 6627.4 6656.8 6668.2 07:13:55 INFO - PID 17196 | 07:13:55 INFO - PID 17196 | [#5] yui.html Cycles:180 Average:25950.42 Median:18080.27 stddev:38174.09 (211.1%) stddev-sans-first:38235.13 07:13:55 INFO - PID 17196 | Values: 979.2 991.1 1015.3 1017.4 1021.0 16970.3 17166.8 17524.4 18053.1 19289.2 18750.6 18980.0 19010.7 19014.3 19055.7 1040.8 1068.4 1079.0 1097.8 1099.2 1114.0 1120.0 1125.1 1126.2 1127.5 1149.3 1153.0 1153.2 1153.7 1153.8 1142.7 1145.5 1145.6 1145.7 1145.8 843.1 843.1 843.3 843.9 844.3 17714.6 17735.9 17839.4 17892.8 18041.5 18022.9 18401.5 18562.4 18782.1 18796.2 14953.9 15479.9 15636.5 15637.5 15640.5 3802.8 3848.9 3851.0 3852.0 3852.6 135731.0 136473.3 141831.3 141882.0 143518.0 13564.2 13580.4 13898.7 14028.2 14132.0 25295.6 25393.0 25497.0 25584.1 25586.6 8112.2 8153.0 8164.3 8182.0 8194.6 3511.5 3665.7 4093.7 4271.3 4294.8 4842.6 4942.1 4945.2 4964.3 4971.1 1100.6 1100.9 1112.5 1120.9 1138.6 747.6 764.6 767.3 778.6 786.2 12205.0 12212.3 12406.7 12709.4 13461.0 752.2 754.9 759.9 768.1 775.8 4656.7 4707.1 4723.8 4740.7 4750.0 131208.3 134408.3 135200.0 136613.0 137081.0 115956.0 116057.4 118459.0 118885.0 122581.0 98089.0 98198.1 98601.0 100049.5 101733.0 12759.0 12828.7 12948.9 13104.3 13639.9 48331.5 49072.0 51439.0 51646.0 52767.7 82593.6 83422.0 84586.6 85907.0 88635.6 17840.6 18074.6 18242.5 18392.3 18523.6 19269.3 19379.7 19672.6 19916.0 20169.0 18552.9 18638.7 18891.9 18906.8 18909.4 18085.9 18132.1 18295.9 18361.4 18543.7 16946.7 17271.4 17545.8 18045.3 18180.5 11524.4 11535.3 12087.1 12167.7 12344.1 12765.8 12804.1 12983.2 14003.2 14276.6 07:13:55 INFO - PID 17196 | -------- Summary: end -------- 07:13:55 INFO - PID 17196 | 07:13:56 INFO - TEST-INFO | 17196: exit 0 07:13:56 INFO - TEST-OK | dromaeo_css | took 1109668ms 07:13:56 INFO - TEST-START | kraken 07:13:56 INFO - Initialising browser for kraken test... 07:13:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40698/getInfo.html -profile /tmp/tmpI4H947/profile 07:13:56 INFO - TEST-INFO | started process 17572 (/builds/slave/test/build/application/firefox/firefox http://localhost:40698/getInfo.html) 07:14:01 INFO - TEST-INFO | 17572: exit 0 07:14:01 INFO - Browser initialized. 07:14:01 INFO - Running cycle 1/1 for kraken test... 07:14:01 INFO - Using env: {'DISPLAY': ':0', 07:14:01 INFO - 'HOME': '/home/cltbld', 07:14:01 INFO - 'JSGC_DISABLE_POISONING': '1', 07:14:01 INFO - 'LANG': 'en_US.UTF-8', 07:14:01 INFO - 'LANGUAGE': 'en_US:en', 07:14:01 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:14:01 INFO - 'LOGNAME': 'cltbld', 07:14:01 INFO - 'MAIL': '/var/mail/cltbld', 07:14:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:14:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:14:01 INFO - 'MOZ_CRASHREPORTER': '1', 07:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:01 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:14:01 INFO - 'MOZ_NO_REMOTE': '1', 07:14:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:01 INFO - 'NO_EM_RESTART': '1', 07:14:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:01 INFO - 'PWD': '/builds/slave/test', 07:14:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:14:01 INFO - 'RUST_BACKTRACE': 'full', 07:14:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:14:01 INFO - 'SHELL': '/bin/bash', 07:14:01 INFO - 'SHLVL': '1', 07:14:01 INFO - 'TERM': 'linux', 07:14:01 INFO - 'TMOUT': '86400', 07:14:01 INFO - 'USER': 'cltbld', 07:14:01 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1504187656.131071-718767297', 07:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:01 INFO - '_': '/tools/buildbot/bin/python'} 07:14:01 INFO - TEST-INFO | started process 17760 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI4H947/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:14:02 INFO - PID 17760 | 07:14:02 INFO - PID 17760 | (/builds/slave/test/build/application/firefox/firefox:17812): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:14:02 INFO - PID 17760 | 07:14:12 INFO - PID 17760 | RSS: Main: 161116160 07:14:12 INFO - PID 17760 | 07:14:15 INFO - PID 17760 | Cycle 1(1): loaded http://localhost:40698/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40698/tests/kraken/driver.html?testName=audio-beat-detection) 07:14:16 INFO - PID 17760 | RSS: Main: 167612416 07:14:16 INFO - PID 17760 | 07:14:18 INFO - PID 17760 | Cycle 1(1): loaded http://localhost:40698/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40698/tests/kraken/driver.html?testName=audio-dft) 07:14:19 INFO - PID 17760 | RSS: Main: 171585536 07:14:19 INFO - PID 17760 | 07:14:22 INFO - PID 17760 | Cycle 1(1): loaded http://localhost:40698/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40698/tests/kraken/driver.html?testName=audio-fft) 07:14:22 INFO - PID 17760 | RSS: Main: 163201024 07:14:22 INFO - PID 17760 | 07:14:25 INFO - PID 17760 | Cycle 1(1): loaded http://localhost:40698/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40698/tests/kraken/driver.html?testName=audio-oscillator) 07:14:25 INFO - PID 17760 | RSS: Main: 164184064 07:14:25 INFO - PID 17760 | 07:14:27 INFO - PID 17760 | Cycle 1(1): loaded http://localhost:40698/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40698/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:14:28 INFO - PID 17760 | RSS: Main: 164315136 07:14:28 INFO - PID 17760 | 07:14:31 INFO - PID 17760 | Cycle 1(1): loaded http://localhost:40698/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40698/tests/kraken/driver.html?testName=imaging-darkroom) 07:14:32 INFO - PID 17760 | RSS: Main: 164548608 07:14:32 INFO - PID 17760 | 07:14:35 INFO - PID 17760 | Cycle 1(1): loaded http://localhost:40698/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40698/tests/kraken/driver.html?testName=imaging-desaturate) 07:14:36 INFO - PID 17760 | RSS: Main: 167702528 07:14:36 INFO - PID 17760 | 07:14:38 INFO - PID 17760 | Cycle 1(1): loaded http://localhost:40698/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40698/tests/kraken/driver.html?testName=json-parse-financial) 07:14:39 INFO - PID 17760 | RSS: Main: 166068224 07:14:39 INFO - PID 17760 | 07:14:40 INFO - PID 17760 | Cycle 1(1): loaded http://localhost:40698/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40698/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:14:41 INFO - PID 17760 | RSS: Main: 166039552 07:14:41 INFO - PID 17760 | 07:14:43 INFO - PID 17760 | Cycle 1(1): loaded http://localhost:40698/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40698/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:14:43 INFO - PID 17760 | RSS: Main: 166158336 07:14:43 INFO - PID 17760 | 07:14:45 INFO - PID 17760 | Cycle 1(1): loaded http://localhost:40698/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40698/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:14:46 INFO - PID 17760 | RSS: Main: 162983936 07:14:46 INFO - PID 17760 | 07:14:48 INFO - PID 17760 | Cycle 1(1): loaded http://localhost:40698/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40698/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:14:49 INFO - PID 17760 | RSS: Main: 162930688 07:14:49 INFO - PID 17760 | 07:14:52 INFO - PID 17760 | Cycle 1(1): loaded http://localhost:40698/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40698/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:14:53 INFO - PID 17760 | RSS: Main: 163741696 07:14:53 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | Cycle 1(1): loaded http://localhost:40698/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40698/tests/kraken/driver.html?testName=ai-astar) 07:14:54 INFO - PID 17760 | RSS: Main: 165359616 07:14:54 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | __start_tp_report 07:14:54 INFO - PID 17760 | _x_x_mozilla_page_load 07:14:54 INFO - PID 17760 | _x_x_mozilla_page_load_details 07:14:54 INFO - PID 17760 | |i|pagename|runs| 07:14:54 INFO - PID 17760 | |0;ai-astar;97;106;98;105;105;106;107;97;106;107 07:14:54 INFO - PID 17760 | |1;audio-beat-detection;139;112;137;164;112;145;143;113;166;112 07:14:54 INFO - PID 17760 | |2;audio-dft;161;163;160;161;161;164;162;161;170;176 07:14:54 INFO - PID 17760 | |3;audio-fft;74;73;74;171;73;73;73;90;97;73 07:14:54 INFO - PID 17760 | |4;audio-oscillator;78;78;131;77;79;79;123;77;78;124 07:14:54 INFO - PID 17760 | |5;imaging-gaussian-blur;114;113;113;114;114;114;113;113;113;114 07:14:54 INFO - PID 17760 | |6;imaging-darkroom;150;149;152;151;150;151;149;149;149;149 07:14:54 INFO - PID 17760 | |7;imaging-desaturate;96;95;93;94;94;93;94;94;94;94 07:14:54 INFO - PID 17760 | |8;json-parse-financial;47;44;44;43;47;44;44;45;44;44 07:14:54 INFO - PID 17760 | |9;json-stringify-tinderbox;37;36;37;36;36;37;36;37;37;37 07:14:54 INFO - PID 17760 | |10;stanford-crypto-aes;73;73;72;74;71;76;71;73;74;74 07:14:54 INFO - PID 17760 | |11;stanford-crypto-ccm;113;115;112;110;115;124;120;115;123;165 07:14:54 INFO - PID 17760 | |12;stanford-crypto-pbkdf2;159;166;156;168;162;165;157;155;157;154 07:14:54 INFO - PID 17760 | |13;stanford-crypto-sha256-iterative;60;61;58;59;67;59;60;60;59;61 07:14:54 INFO - PID 17760 | __end_tp_report 07:14:54 INFO - PID 17760 | __start_cc_report 07:14:54 INFO - PID 17760 | _x_x_mozilla_cycle_collect,874 07:14:54 INFO - PID 17760 | __end_cc_report 07:14:54 INFO - PID 17760 | __startTimestamp1504188894961__endTimestamp 07:14:54 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | ------- Summary: start ------- 07:14:54 INFO - PID 17760 | Number of tests: 14 07:14:54 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | [#0] ai-astar Cycles:10 Average:103.40 Median:107.00 stddev:4.25 (4.0%) stddev-sans-first:3.82 07:14:54 INFO - PID 17760 | Values: 97.0 106.0 98.0 105.0 105.0 106.0 107.0 97.0 106.0 107.0 07:14:54 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:141.00 stddev:21.22 (15.0%) stddev-sans-first:22.44 07:14:54 INFO - PID 17760 | Values: 139.0 112.0 137.0 164.0 112.0 145.0 143.0 113.0 166.0 112.0 07:14:54 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | [#2] audio-dft Cycles:10 Average:163.90 Median:162.50 stddev:5.13 (3.2%) stddev-sans-first:5.33 07:14:54 INFO - PID 17760 | Values: 161.0 163.0 160.0 161.0 161.0 164.0 162.0 161.0 170.0 176.0 07:14:54 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | [#3] audio-fft Cycles:10 Average:87.10 Median:73.50 stddev:30.70 (41.8%) stddev-sans-first:32.20 07:14:54 INFO - PID 17760 | Values: 74.0 73.0 74.0 171.0 73.0 73.0 73.0 90.0 97.0 73.0 07:14:54 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:78.00 stddev:23.29 (29.9%) stddev-sans-first:24.11 07:14:54 INFO - PID 17760 | Values: 78.0 78.0 131.0 77.0 79.0 79.0 123.0 77.0 78.0 124.0 07:14:54 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:14:54 INFO - PID 17760 | Values: 114.0 113.0 113.0 114.0 114.0 114.0 113.0 113.0 113.0 114.0 07:14:54 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 07:14:54 INFO - PID 17760 | Values: 150.0 149.0 152.0 151.0 150.0 151.0 149.0 149.0 149.0 149.0 07:14:54 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.88 (0.9%) stddev-sans-first:0.60 07:14:54 INFO - PID 17760 | Values: 96.0 95.0 93.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 07:14:54 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | [#8] json-parse-financial Cycles:10 Average:44.60 Median:44.00 stddev:1.35 (3.1%) stddev-sans-first:1.12 07:14:54 INFO - PID 17760 | Values: 47.0 44.0 44.0 43.0 47.0 44.0 44.0 45.0 44.0 44.0 07:14:54 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | [#9] json-stringify-tinderbox Cycles:10 Average:36.60 Median:37.00 stddev:0.52 (1.4%) stddev-sans-first:0.53 07:14:54 INFO - PID 17760 | Values: 37.0 36.0 37.0 36.0 36.0 37.0 36.0 37.0 37.0 37.0 07:14:54 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:73.50 stddev:1.52 (2.1%) stddev-sans-first:1.62 07:14:54 INFO - PID 17760 | Values: 73.0 73.0 72.0 74.0 71.0 76.0 71.0 73.0 74.0 74.0 07:14:54 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:117.50 stddev:16.07 (13.7%) stddev-sans-first:16.77 07:14:54 INFO - PID 17760 | Values: 113.0 115.0 112.0 110.0 115.0 124.0 120.0 115.0 123.0 165.0 07:14:54 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:160.50 stddev:5.00 (3.1%) stddev-sans-first:5.29 07:14:54 INFO - PID 17760 | Values: 159.0 166.0 156.0 168.0 162.0 165.0 157.0 155.0 157.0 154.0 07:14:54 INFO - PID 17760 | 07:14:54 INFO - PID 17760 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:60.00 stddev:2.50 (4.2%) stddev-sans-first:2.65 07:14:54 INFO - PID 17760 | Values: 60.0 61.0 58.0 59.0 67.0 59.0 60.0 60.0 59.0 61.0 07:14:54 INFO - PID 17760 | -------- Summary: end -------- 07:14:54 INFO - PID 17760 | 07:14:55 INFO - PID 17760 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:14:55 INFO - TEST-INFO | 17760: exit 0 07:14:55 INFO - TEST-OK | kraken | took 59807ms 07:14:55 INFO - SUITE-END | took 1169s 07:14:56 INFO - Completed test suite (00:19:29) 07:14:56 INFO - javascript benchmark 07:14:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9147.01692985988, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3907.1404291055965, 3912.1393293475444, 3934.4295077213806, 3936.3505021671417, 3955.129871428285, 6618.768343107992, 6750.763723269681, 6765.3572910573475, 6777.0, 6823.795286141418, 6610.8016759497295, 6689.2976237495095, 6719.697613607387, 6768.492363072777, 6774.458043356532, 5933.703314834241, 5937.346891841905, 5957.821265362024, 5964.701764911737, 5981.252343457068, 6028.156058151841, 6057.878842423171, 6062.363451837559, 6069.848253793646, 6111.327753947062, 6109.14471973924, 6141.2937512186, 6160.507159427235, 6166.691665416712, 6215.658138802364, 5983.551233657493, 6079.2400949881485, 6089.360617135181, 6161.907571386433, 6177.598456100339, 5541.972290138524, 5911.231539899829, 6054.8183554493435, 6055.9697201514155, 6063.363346848561, 6667.833304167386, 6761.290064543201, 6798.150231221098, 6833.760818371333, 6839.2818754031105, 7289.489735718502, 7341.082364704412, 7353.522021068614, 7404.777856664308, 7424.2204568520065, 7287.988278824913, 7328.890066649004, 7374.778756637309, 7415.073115860518, 7421.5176013559485, 6890.724371025153, 6891.655417229119, 6905.620190889499, 6958.512904096715, 6972.442204623618, 7525.661345239478, 7544.811379715551, 7565.659545320474, 7637.770866874002, 7652.081750190013, 7241.782746517613, 7290.526115802456, 7353.889691654629, 7359.484836061424, 7423.1834498206235, 7269.67678263015, 7295.416366690652, 7370.262973702587, 7372.963135184397, 7435.0, 7276.304795993496, 7328.67020984057, 7392.926070739331, 7443.85112297751, 7452.701891924262, 7370.410367170613, 7393.334599886036, 7473.925260747432, 7480.0649918760155, 7495.737649182252, 6256.968715156395, 6259.6870156492905, 6320.051992201114, 6341.904871426932, 6373.71318290678, 5355.116405793001, 5424.159255315432, 5429.239906413105, 5444.618876678674, 5563.109902415594, 6288.088227207029, 6367.044943258548, 6427.228732552124, 6441.452476539453, 6442.871142577216, 7153.856922861618, 7197.280271972761, 7241.782746517613, 7258.709651613982, 7259.52813067149, 6321.273053598803, 6322.241331040304, 6327.050942358591, 6329.936700633027, 6333.334999825044, 6653.4677225821815, 6654.434373078246, 6654.767083152066, 6657.667116644148, 6661.933380666228, 6972.093627828452, 6974.651267436608, 6987.9301206987275, 7081.433485321265, 7089.539179953286, 7277.482502241339, 7282.31091999873, 7368.300011498899, 7386.926130738839, 7392.667329970057, 6897.517173797786, 7009.2990700929495, 7078.610676412641, 7089.751858684921, 7103.538270012433, 7226.602536860313, 7288.96355518219, 7297.525660832029, 7322.157951835394, 7346.595937223504, 6923.169219693669, 7370.668319925723, 7390.5196162249285, 7478.401727861649, 7486.0, 7039.472039596948, 7059.117610298713, 7081.468889833386, 7156.499045067004, 7164.713411463483, 6926.168859736864, 7030.437564994686, 7046.647667616496, 7059.011738356737, 7131.928680713334, 7011.929880701332, 7030.683619237045, 7047.471439641945, 7126.429885609243, 7127.10911136108, 7127.216006239413, 7131.179914309921, 7155.821104472222, 7166.749163779243, 7173.641317934187, 6842.24735279109, 6895.561267190754, 6901.75843845463, 7000.50996430245, 7008.22909479967], "value": 6703.608809677756, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.3940559824916, 939.38939689202, 967.1295833749626, 995.8157740817949, 996.3274789517075, 41617.0, 42658.360124598155, 42672.573274267284, 42699.57300426995, 42733.0, 40656.796716016375, 40697.59302406975, 40727.59272407275, 40789.59210407895, 40941.59058409415, 7328.8167795805, 7359.852802943938, 7457.515261507984, 7462.17916029239, 7467.253274672516, 7312.5246858954, 7387.815304617401, 7387.852242955138, 7390.187079421259, 7391.1500177479475, 7372.410207183412, 7377.409807215437, 7385.852282954338, 7396.815079622998, 7403.740869069584, 7319.963400183018, 7336.119665640104, 7340.889886651705, 7343.88984165238, 7345.449091318119, 6743.224529179109, 6787.04981302618, 6796.286389929036, 6805.897911531331, 6814.1482314710665, 34424.65575344239, 34784.30431391358, 34835.129121771904, 34836.30327393463, 34893.0, 3473.583170019614, 3480.878169264089, 3490.4415293553166, 3491.0748651607346, 3491.598466176397, 27776.30559236015, 27932.0, 28017.29956751077, 28061.0, 28175.295617609518, 4632.652551058651, 4792.353032340659, 4824.662273640846, 4835.540623640783, 4867.9269810952865, 210839.0, 211797.0, 213219.0, 214070.0, 226013.86993065095, 52052.739736301075, 52483.0, 52511.73744131255, 52531.949361012565, 52537.211941820904, 54138.0, 54313.72843135759, 54318.0, 54328.0, 54333.72833135809, 15350.07899526032, 15408.460703875311, 15482.071075735492, 15483.071015739091, 15673.0, 12644.936775316064, 12683.746325073447, 12688.619341419771, 12716.554920577735, 12717.364131793373, 13951.511697090553, 14050.36773345202, 14051.648708782363, 14104.153750774987, 14200.076994995292, 5382.757775900016, 5434.347878254634, 5473.507384335429, 5503.394626591072, 5553.500184983371, 1088.9782204355868, 1093.371311495893, 1098.906592939593, 1101.1686176936362, 1122.45560902962, 24916.377090572518, 25027.87486062558, 25048.37379065538, 25138.497230055298, 25371.87314063418, 1177.0054304113182, 1184.1119160629528, 1188.2751521571834, 1203.3441774233063, 1204.8855358740905, 13116.278604676643, 13279.800802987962, 13485.730285394433, 13503.392347344394, 13509.864901351057, 248084.0, 251870.0, 251892.0, 252134.0, 252203.0, 54823.451765482634, 55180.17229741557, 55295.72352138294, 55338.16992745112, 55546.44453555493, 1508.276027506781, 1514.9848501514844, 1534.3632392557188, 1543.1821134798574, 1552.8680062194614, 24129.155479558834, 31731.206719831265, 32139.196520087185, 32603.67396326101, 33042.0, 54414.0, 54782.45217547774, 55015.0, 55050.17424738712, 55156.17265741097, 226925.0, 227121.0, 227134.0, 227218.0, 227747.0, 35664.465033025044, 37616.24767504689, 38403.615963840006, 38452.0, 38467.6153238464, 48980.0, 49300.26049609187, 50118.74940625273, 50133.498665012885, 50412.0, 35899.0, 36503.817480912425, 36774.44838327481, 36803.44794828133, 37185.0, 36411.635883640825, 36426.635733642324, 36437.08907277339, 36660.81669591635, 37261.25477490489, 42429.0, 42853.1429371417, 43091.35362969495, 43182.35226471668, 43260.0, 34662.82668586641, 34886.476702849985, 35034.29931401409, 35186.824065879504, 35660.0, 27298.863505682344, 27965.440691186468, 27982.160535183975, 28315.15054548367, 28625.856870715514], "value": 18110.6015510677, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.9821505354838, 601.4406601860268, 605.9000264956283, 607.778160971245, 627.9591826531275, 22474.213402530913, 22998.195063172792, 23311.533769324626, 23345.0, 23376.649350259737, 26920.326991825164, 27337.0, 27456.176314710592, 27460.0, 27499.17502474924, 6676.232233293161, 6821.079154314179, 6835.726570937157, 6843.315668433167, 6849.212340580847, 6427.967860160693, 6681.66591670417, 6689.2976237495095, 6717.563358381714, 6718.462522998173, 6681.3986741193285, 6687.799366019027, 6692.130023096991, 6693.6318502482345, 6693.866122677544, 6678.232003319632, 6680.465562755016, 6684.3315668433015, 6686.130802995628, 6689.866202675944, 6189.6286222826775, 6196.101565273055, 6215.81352559424, 6222.502199824004, 6224.719887605023, 30422.0, 31271.0, 31441.0, 31658.52512212319, 32116.518252226237, 2136.1882484655885, 2152.2036846366786, 2157.4174972757423, 2162.7188465499544, 2163.318554655294, 20255.189792408288, 20946.79053209479, 20950.47623809417, 20983.0, 21042.894785525976, 2467.7038755349295, 2514.7485251474704, 2576.626389173578, 2583.7803786678155, 2584.767370936606, 150809.0, 151247.0, 154205.0, 154336.0, 154796.22601886917, 15521.37914483408, 15540.766888496682, 15830.52508424749, 16451.91774041122, 16639.750403743954, 25564.23307300784, 25608.615870761954, 25657.61513577298, 25697.100601478858, 26476.735232647814, 10477.10944569705, 10590.470476476145, 10612.840807387895, 10795.892041079645, 10831.458427078614, 9750.317477776487, 9778.65774697882, 9812.313138080408, 9861.063198996084, 9900.900990990142, 9581.13769760711, 9681.903180968242, 9718.368306060225, 10033.347832391017, 10136.806905824642, 2753.2153336299457, 2845.587389828463, 2937.8090424122365, 2948.7935844491108, 2968.450836595237, 1033.1012019543045, 1052.9684109476727, 1061.1722856172198, 1062.18211976779, 1063.3938654966594, 22287.55424891493, 22463.101475941105, 22665.660015099787, 23058.65412018821, 26538.867305663734, 1100.878903320634, 1103.9116870650328, 1113.3486910157649, 1113.7716768062528, 1124.3366413815888, 12297.44661490235, 14926.70146597062, 15812.92093539525, 15890.76163857543, 16132.0, 675753.0, 677114.0721481903, 686246.0, 692544.0, 707686.0, 126947.3652631731, 133250.0, 136153.0, 136925.0, 138103.0, 1249.7125661097998, 1255.6546949588935, 1298.8701129886936, 1304.693397051692, 1306.7451846889765, 23138.190163344203, 23222.651660224772, 23358.76641233566, 23477.530449390575, 23517.647235291828, 63228.0, 64277.357226427135, 64533.67733161304, 65501.67249163723, 65682.67158664177, 78529.0, 81838.0, 83199.5840020796, 83485.58257208676, 84231.5788421054, 15842.52472425829, 16175.352985880432, 16230.51308460748, 16241.837581624033, 16435.26041328119, 25029.87485062563, 25247.36881577975, 25407.237782866545, 25435.236942891745, 25493.74506254988, 20508.487287817923, 20525.38423847287, 20874.47813804667, 21060.894695527037, 21208.36374908755, 17581.120943952494, 17650.234976502248, 17970.640587188445, 18259.45221643353, 18488.260469581066, 20988.475288117308, 21021.0, 21318.0, 22463.550728985654, 22495.0, 16005.439809606607, 16069.035857848567, 16146.596335091717, 16217.0, 16266.268017939457, 20181.19275229033, 20241.79758202458, 20564.0, 20609.278675246296, 20615.690764638242], "value": 13196.402460299847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.5484699743079, 1500.4898334566246, 1502.0987407555474, 1527.4339110294704, 1539.1150088699, 16481.67036659266, 17145.91427042866, 17168.39910603129, 17202.999999999985, 17224.224909879053, 16454.177291135424, 17758.82241177588, 17788.911055444736, 17826.64346713065, 17827.286908523645, 2800.663920329553, 2857.957130643042, 2876.0077773168327, 2877.1656219696265, 2881.927951801201, 2609.0868196131296, 2659.5079910216673, 2700.2439316991176, 2816.380396312818, 2938.515145001072, 2917.095700332893, 2941.558766185068, 2955.8374289414073, 2964.5553167024905, 2965.866536005874, 2593.818432709711, 2595.2603508000225, 2603.127952136027, 2610.8433493990233, 2613.0592986524834, 2642.6696662917134, 2671.2654020144423, 2677.799165062628, 2679.3301674581353, 2680.0485827531334, 16494.42269520573, 16782.328706851713, 16805.0, 16899.155042247963, 16908.915455422768, 8295.087540370554, 8547.145285471466, 8557.786055348604, 8574.828503429959, 8581.098984606651, 5263.973680131575, 5362.624616276862, 5406.621536492447, 5530.170474428827, 5705.885882282372, 2085.15551201762, 2144.603248399051, 2151.7095192149172, 2191.430228140679, 2202.515446601745, 31297.217569560944, 31372.843135784402, 31505.21236969071, 31509.684903151134, 31572.842135789404, 6884.0, 7138.0, 7190.856182876313, 7210.242924492957, 7221.350078492961, 19533.0, 19598.70601940972, 19633.901830490755, 19646.901765491366, 19701.40895773129, 8128.309093726981, 8259.42184047111, 8261.793455163668, 8268.338532917352, 8268.793280168044, 7423.591702456309, 7620.428467864822, 7649.082110146818, 7654.617269136521, 7657.310842024244, 5277.525022747971, 5492.615516913777, 5498.340199176125, 5499.7250137492965, 5512.724363781875, 1357.362039841273, 1387.2855479428104, 1564.1944398634712, 1579.9447019354268, 1616.4988853455466, 936.9063093690713, 956.0821611253136, 967.9128878400837, 973.4694591447678, 977.0034564743921, 8125.75622731319, 8202.466839655403, 8232.547209903392, 8274.29668478186, 8277.296429803535, 1036.7667274863247, 1046.4715318763976, 1052.8262836632023, 1075.2473268711933, 1084.046039485248, 5339.652922560022, 5472.753726082336, 5495.505404513613, 5510.889782204334, 5590.217369568264, 24259.878700606736, 24889.0, 25272.494550109262, 25280.0, 25687.0, 23650.0, 24676.629850552257, 24744.505109897702, 24811.875940620543, 25039.749602504107, 12293.200941938745, 12505.874941250653, 12636.620901372973, 12757.872421275668, 12782.552610658768, 9360.4383736976, 9458.479783611967, 9522.0954009369, 9530.046995300414, 9575.808483830424, 20731.0, 21070.683939741222, 21225.575488490453, 21951.231706890183, 22438.0, 21867.781322186576, 22177.223797167022, 22412.32763017047, 22481.43796405103, 22800.88599557058, 13209.669758256121, 13608.047436679337, 13611.11527750693, 13615.319234038061, 13617.455301787817, 14681.486147985197, 15090.094594324375, 15654.765178522559, 15816.841831581536, 15847.52457426279, 11720.0, 11775.23460975034, 11902.702432439259, 11903.226290291102, 12217.51129954792, 11789.0, 11831.033657680899, 12132.636020919386, 12174.391280435766, 12279.570215042431, 10558.894411056099, 10732.51703673321, 10754.0, 10756.0, 10774.838377424188, 7254.0, 7284.745033923788, 7314.34170924598, 7317.634118293958, 7321.231270716711, 7403.185649578434, 7440.516366436164, 7448.851022979402, 7472.252774722484, 7639.656215470428], "value": 7213.291769806806, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.3403014292418, 553.5460922043923, 579.1688926390627, 580.9186713860059, 585.93554708982, 6525.608463492188, 6587.6706164691695, 6623.470122390209, 6627.436667883229, 6628.801135965917, 6358.491320694345, 6377.170967774183, 6486.837829054264, 6489.707963141658, 6525.249596296428, 5150.510701483353, 5336.946630533684, 5338.786448542063, 5354.357477102753, 5381.7578208980685, 5106.412762532319, 5207.895842083156, 5217.321788139371, 5246.737663116848, 5273.707941554325, 5289.973550132244, 5296.417394086667, 5320.201969704556, 5343.96929166916, 5347.0, 5247.160454327309, 5285.339332583427, 5294.987904596229, 5335.573154147659, 5405.837824865261, 4943.604511639061, 4948.282499037619, 4982.800687972477, 4994.425641051289, 5044.39467263927, 6340.207474065742, 6386.808395748135, 6434.388733070351, 6439.93560064398, 6478.514111441661, 6220.284667263278, 6241.313455519889, 6283.214598175228, 6304.5586808922935, 6376.29860715321, 6873.175218973755, 6921.723131074751, 6942.680890630764, 7019.82450438738, 7075.497628673788, 5514.476124768181, 5540.722963851791, 5549.77800887964, 5563.276774019392, 5583.609147359686, 7017.578945263301, 7071.82320441993, 7105.89341159883, 7319.194888562254, 7320.560766354036, 5677.17680936262, 5742.54059675225, 5760.251167348218, 5814.273215848019, 5815.73829177688, 5803.564732645069, 5848.356680765112, 5864.824055278348, 5869.8239052828485, 5921.3190483094995, 6223.688815559204, 6290.741851629692, 6300.684965751694, 6376.681165941684, 6400.583962042452, 6992.755253566203, 7028.7348277310575, 7053.717851285994, 7069.575825450489, 7078.1506219254015, 2011.7988201179764, 2037.3582321568658, 2038.3782946201254, 2046.8567200296134, 2060.464279287396, 1448.2758620689656, 1502.248875562219, 1521.6195951012246, 1527.7708343748304, 1536.6004838741785, 6031.487323577458, 6054.66699331541, 6068.331208917495, 6075.635461872302, 6141.9078713818435, 6943.444524438033, 6973.825654358681, 7017.614031228331, 7018.263082376379, 7110.360067593838, 6044.969775151184, 6093.360197179321, 6113.694315284218, 6122.479589234876, 6137.754489820357, 3681.9079523012138, 3692.2061756722433, 3717.423799311111, 3722.758020728644, 3729.978717239045, 6738.764143254963, 6764.864702705919, 6787.321267873272, 6798.422134118557, 6802.455803535705, 7099.538529995534, 7232.493725439274, 7327.340539351378, 7335.119785625652, 7342.339189472973, 6575.671216439255, 6653.434458070925, 6773.288804675537, 6774.051632771515, 6779.389854913082, 6938.363421899646, 7014.333638304353, 7055.0, 7059.399951004222, 7081.327273908971, 7100.9289907100265, 7149.785506434607, 7158.785236442915, 7167.749128780468, 7172.641367931687, 6555.901661474986, 6683.198016238082, 6737.427318677967, 6797.28628494001, 6840.521163518506, 5624.971875140598, 5640.294963129609, 5644.0, 5654.604177707685, 5675.921574900755, 6675.299093595297, 6818.352256535622, 6936.306369363023, 6951.2353641098425, 7040.190378106583, 6714.362135597111, 6715.731370745311, 6783.0, 6815.352541508549, 6859.07402500676, 6617.2721000688925, 6671.566348187353, 6731.32686731323, 6761.628110453776, 6767.93232067673, 6541.803745887631, 6641.800745977628, 6655.301193374626, 6681.997700344793, 6784.864302714017, 6746.6626668665385, 6776.864462710817, 6814.989578074381, 6855.211650660238, 6885.793426197222, 6525.314841941527, 6546.279909210079, 6627.403533681992, 6656.83357916056, 6668.166479190101], "value": 5426.880752588675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [979.1921664626681, 991.063445044433, 1015.3349556040791, 1017.3946501831413, 1021.0453226233468, 16970.321187152498, 17166.82833171668, 17524.386646467377, 18053.09734513274, 19289.22843086275, 18750.624987500243, 18980.0, 19010.71483927742, 19014.334498292563, 19055.714164287547, 1040.7762331098813, 1068.3536460441437, 1078.95684172633, 1097.8353247012933, 1099.2415233488907, 1114.0419239454063, 1120.0423637789695, 1125.0718157520039, 1126.1666366888485, 1127.4982632728438, 1149.3046706742425, 1152.965411037666, 1153.2042890405594, 1153.6596703972307, 1153.8038533449292, 1142.714321419645, 1145.5131569083148, 1145.604766355606, 1145.7135716070982, 1145.7937571237173, 843.1105184030845, 843.1399972028557, 843.3169133002226, 843.8649816029467, 844.2570537926586, 17714.557136071573, 17735.911320443443, 17839.375621853174, 17892.821071789247, 18041.458756237334, 18022.90988545062, 18401.53996150107, 18562.350317738816, 18782.060896955096, 18796.24815007398, 14953.925230373887, 15479.922600386926, 15636.4527241546, 15637.452689155938, 15640.4525841595, 3802.8098595070137, 3848.942265866014, 3851.0372406898277, 3851.961480385188, 3852.595477474853, 135731.0, 136473.3301129936, 141831.29084354616, 141882.0, 143518.0, 13564.186148830904, 13580.38888250031, 13898.652533686536, 14028.22844743549, 14132.0, 25295.62056569153, 25393.0, 25497.0, 25584.10455634044, 25586.616200757002, 8112.18878112184, 8153.0, 8164.346852251806, 8181.95909020463, 8194.590270486451, 3511.4908338290807, 3665.6884164846288, 4093.692973027035, 4271.2738834397605, 4294.82820687169, 4842.6368022398465, 4942.1104201244125, 4945.2087665973995, 4964.280179373971, 4971.055499455092, 1100.5542755184163, 1100.9174311926638, 1112.5327362507767, 1120.9327440353604, 1138.5824648312903, 747.6336595068486, 764.636797521173, 767.3132546370966, 778.5717855179629, 786.2334224131426, 12205.0, 12212.328321942201, 12406.689832754073, 12709.364531773374, 13460.99042571811, 752.2402373602591, 754.9245075492516, 759.9088109426793, 768.0821418404953, 775.7517594369748, 4656.720596764205, 4707.105649926503, 4723.811047558059, 4740.691855029412, 4749.95250047502, 131208.3439582815, 134408.3279583596, 135200.0, 136613.0, 137081.0, 115956.0, 116057.4197129009, 118459.0, 118885.0, 122581.0, 98089.0, 98198.07207711611, 98601.0, 100049.49975250223, 101733.0, 12759.0, 12828.679283017625, 12948.870511294766, 13104.344782760632, 13639.863601363859, 48331.5166848327, 49072.0, 51439.0, 51646.0, 52767.73616131895, 82593.58703206446, 83422.0, 84586.57706711427, 85907.0, 88635.55682221548, 17840.643187136444, 18074.638507230044, 18242.45272641823, 18392.264309428007, 18523.629527409645, 19269.325573605416, 19379.709304360727, 19672.606547869247, 19916.0, 20169.0, 18552.907235463736, 18638.720419193993, 18891.90554047221, 18906.810931890504, 18909.43271701851, 18085.909570452062, 18132.093395329917, 18295.908520457844, 18361.357352493134, 18543.72184417208, 16946.66106677884, 17271.3955011574, 17545.82454175442, 18045.278188872297, 18180.45458636243, 11524.366159861289, 11535.307881527135, 12087.093467990111, 12167.695807604881, 12344.13591048618, 12765.808512872129, 12804.10371274002, 12983.156094854183, 14003.229822359868, 14276.57170284893], "value": 9338.400464165557, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1434.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 106.0, 98.0, 105.0, 105.0, 106.0, 107.0, 97.0, 106.0, 107.0], "value": 103.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 112.0, 137.0, 164.0, 112.0, 145.0, 143.0, 113.0, 166.0, 112.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 161.0, 161.0, 164.0, 162.0, 161.0, 170.0, 176.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 171.0, 73.0, 73.0, 73.0, 90.0, 97.0, 73.0], "value": 87.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 131.0, 77.0, 79.0, 79.0, 123.0, 77.0, 78.0, 124.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 152.0, 151.0, 150.0, 151.0, 149.0, 149.0, 149.0, 149.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 44.0, 44.0, 43.0, 47.0, 44.0, 44.0, 45.0, 44.0, 44.0], "value": 44.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 36.0, 37.0, 36.0, 36.0, 37.0, 36.0, 37.0, 37.0, 37.0], "value": 36.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 74.0, 71.0, 76.0, 71.0, 73.0, 74.0, 74.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 112.0, 110.0, 115.0, 124.0, 120.0, 115.0, 123.0, 165.0], "value": 121.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 166.0, 156.0, 168.0, 162.0, 165.0, 157.0, 155.0, 157.0, 154.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 58.0, 59.0, 67.0, 59.0, 60.0, 60.0, 59.0, 61.0], "value": 60.4, "unit": "score"}]}]} 07:14:56 INFO - Return code: 0 07:14:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:14:56 INFO - # TBPL SUCCESS # 07:14:56 INFO - Running post-action listener: _package_coverage_data 07:14:56 INFO - Running post-action listener: _resource_record_post_action 07:14:56 INFO - [mozharness: 2017-08-31 14:14:56.265350Z] Finished run-tests step (success) 07:14:56 INFO - Running post-run listener: _resource_record_post_run 07:14:56 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 395542528; Read time: 8; Write time: 443188 07:14:56 INFO - TinderboxPrint: CPU usage
13.1% 07:14:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 07:14:56 INFO - TinderboxPrint: I/O write bytes / time
395,542,528 / 443,188 07:14:56 INFO - TinderboxPrint: CPU idle
8,233.0 (86.9%) 07:14:56 INFO - TinderboxPrint: CPU user
1,186.8 (12.5%) 07:14:56 INFO - TinderboxPrint: Swap in / out
0 / 0 07:14:56 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 109744128; Read time: 0; Write time: 154168 07:14:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:14:56 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 277622784; Read time: 8; Write time: 288272 07:14:56 INFO - Running post-run listener: _upload_blobber_files 07:14:56 INFO - Blob upload gear active. 07:14:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:14: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 07:14: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'] 07:14: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 07:14:57 INFO - (blobuploader) - INFO - Open directory for files ... 07:14:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:14:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:14:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:58 INFO - (blobuploader) - INFO - Done attempting. 07:14:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:14:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:15:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:01 INFO - (blobuploader) - INFO - Done attempting. 07:15:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:15:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:15:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:02 INFO - (blobuploader) - INFO - Done attempting. 07:15:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:15:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:15:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:03 INFO - (blobuploader) - INFO - Done attempting. 07:15:03 INFO - (blobuploader) - INFO - Iteration through files over. 07:15:03 INFO - Return code: 0 07:15:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:15:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:15:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37487f788ea590af84005f9b3c8a7f9d6b6ac9eaadc5df26b2faa7f9ad1158b05a04e2790a83e6380929cfe55eed2533688e77816fa5fddd15c4e086391598ea", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b87e4e936326fa183c9e2c0668bd53a5a21d8336f9af0e2d8195bf1aba586a96434fec0cf3a87cf1a7332a03a1d875c6b87f3ab106217b786b04104efb8fedbf", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04565cdb49ff84c451b8c7b579380c80eb07c9c1474ffc36994443d03d5d4b74fb9eb68df5cf4944f62e17af0f1b1d59dd4c8c75a095e466ea418565525a41a0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46fdb9498571ff262256fb18a5326056d19fd82f7008cb18b1d9632f38c5f970bea43c60f8418ade81bffacfdf096f33ea1cffd66bd47fda22d3f948eab7f9f8"} 07:15:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:15:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:15:03 INFO - Contents: 07:15:03 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37487f788ea590af84005f9b3c8a7f9d6b6ac9eaadc5df26b2faa7f9ad1158b05a04e2790a83e6380929cfe55eed2533688e77816fa5fddd15c4e086391598ea", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b87e4e936326fa183c9e2c0668bd53a5a21d8336f9af0e2d8195bf1aba586a96434fec0cf3a87cf1a7332a03a1d875c6b87f3ab106217b786b04104efb8fedbf", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04565cdb49ff84c451b8c7b579380c80eb07c9c1474ffc36994443d03d5d4b74fb9eb68df5cf4944f62e17af0f1b1d59dd4c8c75a095e466ea418565525a41a0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46fdb9498571ff262256fb18a5326056d19fd82f7008cb18b1d9632f38c5f970bea43c60f8418ade81bffacfdf096f33ea1cffd66bd47fda22d3f948eab7f9f8"} 07:15:03 INFO - Running post-run listener: copy_logs_to_upload_dir 07:15:03 INFO - Copying logs to upload dir... 07:15:03 INFO - mkdir: /builds/slave/test/build/upload/logs 07:15:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.887781 ========= master_lag: -0.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-08-31 07:15:02.913530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 07:15:02.918536) ========= 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=5c37b704b588aaa989324530000001d0-1504187656.131071-718767297 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/37487f788ea590af84005f9b3c8a7f9d6b6ac9eaadc5df26b2faa7f9ad1158b05a04e2790a83e6380929cfe55eed2533688e77816fa5fddd15c4e086391598ea", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b87e4e936326fa183c9e2c0668bd53a5a21d8336f9af0e2d8195bf1aba586a96434fec0cf3a87cf1a7332a03a1d875c6b87f3ab106217b786b04104efb8fedbf", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04565cdb49ff84c451b8c7b579380c80eb07c9c1474ffc36994443d03d5d4b74fb9eb68df5cf4944f62e17af0f1b1d59dd4c8c75a095e466ea418565525a41a0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46fdb9498571ff262256fb18a5326056d19fd82f7008cb18b1d9632f38c5f970bea43c60f8418ade81bffacfdf096f33ea1cffd66bd47fda22d3f948eab7f9f8"} build_url:https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011385 build_url: 'https://queue.taskcluster.net/v1/task/aFFo2BkuTfOVMIWuwaBEfg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37487f788ea590af84005f9b3c8a7f9d6b6ac9eaadc5df26b2faa7f9ad1158b05a04e2790a83e6380929cfe55eed2533688e77816fa5fddd15c4e086391598ea", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b87e4e936326fa183c9e2c0668bd53a5a21d8336f9af0e2d8195bf1aba586a96434fec0cf3a87cf1a7332a03a1d875c6b87f3ab106217b786b04104efb8fedbf", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04565cdb49ff84c451b8c7b579380c80eb07c9c1474ffc36994443d03d5d4b74fb9eb68df5cf4944f62e17af0f1b1d59dd4c8c75a095e466ea418565525a41a0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46fdb9498571ff262256fb18a5326056d19fd82f7008cb18b1d9632f38c5f970bea43c60f8418ade81bffacfdf096f33ea1cffd66bd47fda22d3f948eab7f9f8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 07:15:02.948175) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 07:15:02.948536) ========= 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=5c37b704b588aaa989324530000001d0-1504187656.131071-718767297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 07:15:03.031375) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 07:15:03.031738) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 07:15:03.032070) ========= ========= Total master_lag: -0.44 =========