builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-066 starttime: 1505170042.73 results: success (0) revision: 3a6d2e30bbe18b4ed6d3d964afe9c97237f0515d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:22.726078) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:22.729796) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:22.730122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:22.768278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:22.768588) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-11 15:47:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.7M=0s 2017-09-11 15:47:22 (34.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134209 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:22.920494) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:22.921080) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017738 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:22.978381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:22.978724) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3a6d2e30bbe18b4ed6d3d964afe9c97237f0515d --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 3a6d2e30bbe18b4ed6d3d964afe9c97237f0515d --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=82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-11 15:47:23,036 truncating revision to first 12 chars 2017-09-11 15:47:23,036 Setting DEBUG logging. 2017-09-11 15:47:23,036 attempt 1/10 2017-09-11 15:47:23,036 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3a6d2e30bbe1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-11 15:47:23,407 unpacking tar archive at: mozilla-central-3a6d2e30bbe1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.730417 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:23.726281) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:23.726601) ========= script_repo_revision: 3a6d2e30bbe18b4ed6d3d964afe9c97237f0515d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:23.726965) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:23.727226) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:23.740440) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-11 15:47:23.740760) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:47:23 INFO - MultiFileLogger online at 20170911 15:47:23 in /builds/slave/test 15:47:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:47:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:47:23 INFO - {'append_to_log': False, 15:47:23 INFO - 'base_work_dir': '/builds/slave/test', 15:47:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:47:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:47:23 INFO - 'branch': 'Firefox-Non-PGO', 15:47:23 INFO - 'buildbot_json_path': 'buildprops.json', 15:47:23 INFO - 'code_coverage': False, 15:47:23 INFO - 'config_files': ('talos/linux_config.py',), 15:47:23 INFO - 'default_actions': ('clobber', 15:47:23 INFO - 'read-buildbot-config', 15:47:23 INFO - 'download-and-extract', 15:47:23 INFO - 'populate-webroot', 15:47:23 INFO - 'create-virtualenv', 15:47:23 INFO - 'install', 15:47:23 INFO - 'setup-mitmproxy', 15:47:23 INFO - 'run-tests'), 15:47:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:47:23 INFO - 'disable_ccov_upload': False, 15:47:23 INFO - 'disable_stylo': False, 15:47:23 INFO - 'download_minidump_stackwalk': True, 15:47:23 INFO - 'download_symbols': 'ondemand', 15:47:23 INFO - 'enable_stylo': False, 15:47:23 INFO - 'enable_webrender': False, 15:47:23 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:47:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:47:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:47:23 INFO - 'gecko_profile': False, 15:47:23 INFO - 'gecko_profile_interval': 0, 15:47:23 INFO - 'installer_path': 'installer.exe', 15:47:23 INFO - 'log_level': 'info', 15:47:23 INFO - 'log_name': 'talos', 15:47:23 INFO - 'log_to_console': True, 15:47:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:47:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:47:23 INFO - 'opt_config_files': (), 15:47:23 INFO - 'pip_index': False, 15:47:23 INFO - 'suite': 'dromaeojs-e10s', 15:47:23 INFO - 'system_bits': '32', 15:47:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:47:23 INFO - 'title': 'talos-linux64-ix-066', 15:47:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:47:23 INFO - 'use_talos_json': True, 15:47:23 INFO - 'verify': 'False', 15:47:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:47:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:47:23 INFO - 'work_dir': 'build'} 15:47:23 INFO - [mozharness: 2017-09-11 22:47:23.943110Z] Running clobber step. 15:47:23 INFO - Running pre-action listener: _resource_record_pre_action 15:47:23 INFO - Running main action method: clobber 15:47:23 INFO - rmtree: /builds/slave/test/build 15:47:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:47:25 INFO - Running post-action listener: _resource_record_post_action 15:47:25 INFO - [mozharness: 2017-09-11 22:47:25.481871Z] Finished clobber step (success) 15:47:25 INFO - [mozharness: 2017-09-11 22:47:25.481970Z] Running read-buildbot-config step. 15:47:25 INFO - Running pre-action listener: _resource_record_pre_action 15:47:25 INFO - Running main action method: read_buildbot_config 15:47:25 INFO - Using buildbot properties: 15:47:25 INFO - { 15:47:25 INFO - "project": "", 15:47:25 INFO - "product": "firefox", 15:47:25 INFO - "who": "archaeopteryx@coole-files.de", 15:47:25 INFO - "installer_path": "public/build/target.tar.bz2", 15:47:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:47:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:47:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:47:25 INFO - "stage_platform": "linux64", 15:47:25 INFO - "basedir": "/builds/slave/test", 15:47:25 INFO - "buildnumber": 1139, 15:47:25 INFO - "platform": "ubuntu64_hw", 15:47:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:47:25 INFO - "slavebuilddir": "test", 15:47:25 INFO - "taskId": "b8F6PEfgQi-GVXXp66VmmQ", 15:47:25 INFO - "branch": "mozilla-central", 15:47:25 INFO - "script_repo_revision": "production", 15:47:25 INFO - "revision": "3a6d2e30bbe18b4ed6d3d964afe9c97237f0515d", 15:47:25 INFO - "slavename": "talos-linux64-ix-066", 15:47:25 INFO - "repo_path": "mozilla-central" 15:47:25 INFO - } 15:47:25 INFO - Finding installer, test and symbols from parent task. 15:47:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b8F6PEfgQi-GVXXp66VmmQ'}, attempt #1 15:47:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b8F6PEfgQi-GVXXp66VmmQ'}, attempt #1 15:47:26 INFO - Task dependencies: NZL3uDQ6TNSAakTme7WydQ 15:47:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ'}, attempt #1 15:47:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.tar.bz2 15:47:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.test_packages.json 15:47:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.crashreporter-symbols.zip 15:47:26 INFO - Running post-action listener: _resource_record_post_action 15:47:26 INFO - [mozharness: 2017-09-11 22:47:26.865199Z] Finished read-buildbot-config step (success) 15:47:26 INFO - [mozharness: 2017-09-11 22:47:26.865415Z] Running download-and-extract step. 15:47:26 INFO - Running pre-action listener: _resource_record_pre_action 15:47:26 INFO - Running main action method: download_and_extract 15:47:26 INFO - mkdir: /builds/slave/test/build/tests 15:47: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')]} 15:47:26 INFO - trying https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.test_packages.json 15:47:26 INFO - Downloading https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:47:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:47:27 INFO - Downloaded 989 bytes. 15:47:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:47:27 INFO - Using the following test package requirements: 15:47:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:47:27 INFO - u'common': [u'target.common.tests.zip'], 15:47:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:47:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:47:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:47:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:47:27 INFO - u'mozbase': [u'target.common.tests.zip'], 15:47:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:47:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:47:27 INFO - u'web-platform': [u'target.common.tests.zip', 15:47:27 INFO - u'target.web-platform.tests.tar.gz'], 15:47:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:47:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:47:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.common.tests.zip 15:47:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:47:27 INFO - Fetch https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.common.tests.zip into memory 15:47:28 INFO - Content-Length response header: 55028403 15:47:28 INFO - Bytes received: 55028403 15:47:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.talos.tests.zip 15:47:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:47:39 INFO - Fetch https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.talos.tests.zip into memory 15:47:40 INFO - Content-Length response header: 14497963 15:47:40 INFO - Bytes received: 14497963 15:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:40 INFO - trying https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.tar.bz2 15:47:40 INFO - Downloading https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:47:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:47:41 INFO - Downloaded 62919275 bytes. 15:47:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.tar.bz2 15:47:42 INFO - mkdir: /builds/slave/test/properties 15:47:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:47:42 INFO - Writing to file /builds/slave/test/properties/build_url 15:47:42 INFO - Contents: 15:47:42 INFO - build_url:https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.tar.bz2 15:47:42 INFO - Running post-action listener: _resource_record_post_action 15:47:42 INFO - Running post-action listener: find_tests_for_verification 15:47:42 INFO - Running post-action listener: set_extra_try_arguments 15:47:42 INFO - [mozharness: 2017-09-11 22:47:42.194501Z] Finished download-and-extract step (success) 15:47:42 INFO - [mozharness: 2017-09-11 22:47:42.194742Z] Running populate-webroot step. 15:47:42 INFO - Running pre-action listener: _resource_record_pre_action 15:47:42 INFO - Running main action method: populate_webroot 15:47:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:47:42 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:47:42 INFO - 'tests': ['tresize', 15:47:42 INFO - 'tcanvasmark']}, 15:47:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:47:42 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:47:42 INFO - 'tests': ['dromaeo_css', 15:47:42 INFO - 'kraken']}, 15:47:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:47:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:42 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:47:42 INFO - 'talos_options': ['--disable-stylo'], 15:47:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:47:42 INFO - 'tests': ['damp', 'tps']}, 15:47:42 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:47:42 INFO - 'talos_options': ['--disable-stylo'], 15:47:42 INFO - 'tests': ['damp', 'tps']}, 15:47:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:47:42 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:47:42 INFO - 'tests': ['dromaeo_dom']}, 15:47:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:47:42 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:47:42 INFO - 'tests': ['basic_compositor_video', 15:47:42 INFO - 'glvideo']}, 15:47:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:47:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:47:42 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:47:42 INFO - 'talos_options': ['--disable-stylo'], 15:47:42 INFO - 'tests': ['ts_paint_webext', 15:47:42 INFO - 'tp5o_webext']}, 15:47:42 INFO - 'other-e10s': {'tests': ['a11yr', 15:47:42 INFO - 'ts_paint', 15:47:42 INFO - 'tpaint', 15:47:42 INFO - 'sessionrestore', 15:47:42 INFO - 'sessionrestore_many_windows', 15:47:42 INFO - 'sessionrestore_no_auto_restore', 15:47:42 INFO - 'tabpaint']}, 15:47:42 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:47:42 INFO - 'tests': ['a11yr', 15:47:42 INFO - 'ts_paint', 15:47:42 INFO - 'tpaint', 15:47:42 INFO - 'sessionrestore', 15:47:42 INFO - 'sessionrestore_many_windows', 15:47:42 INFO - 'sessionrestore_no_auto_restore', 15:47:42 INFO - 'tabpaint']}, 15:47:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:47:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:47:42 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:47:42 INFO - 'tests': ['bloom_basic_singleton']}, 15:47:42 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:47:42 INFO - 'tests': ['bloom_basic']}, 15:47:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:47:42 INFO - 'tsvgr_opacity', 15:47:42 INFO - 'tart', 15:47:42 INFO - 'tscrollx', 15:47:42 INFO - 'tsvg_static']}, 15:47:42 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:47:42 INFO - 'tests': ['tsvgx', 15:47:42 INFO - 'tsvgr_opacity', 15:47:42 INFO - 'tart', 15:47:42 INFO - 'tscrollx', 15:47:42 INFO - 'tsvg_static']}, 15:47:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:47:42 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:47:42 INFO - 'talos_options': ['--disable-stylo'], 15:47:42 INFO - 'tests': ['tp5o']}, 15:47:42 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:47:42 INFO - 'talos_options': ['--mitmproxy', 15:47:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:47:42 INFO - '--firstNonBlankPaint'], 15:47:42 INFO - 'tests': ['tp6_google', 15:47:42 INFO - 'tp6_youtube', 15:47:42 INFO - 'tp6_amazon', 15:47:42 INFO - 'tp6_facebook']}, 15:47:42 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:47:42 INFO - 'talos_options': ['--disable-stylo', 15:47:42 INFO - '--mitmproxy', 15:47:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:47:42 INFO - '--firstNonBlankPaint'], 15:47:42 INFO - 'tests': ['tp6_google', 15:47:42 INFO - 'tp6_youtube', 15:47:42 INFO - 'tp6_amazon', 15:47:42 INFO - 'tp6_facebook']}, 15:47:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:47:42 INFO - 'talos_options': ['--stylo-threads=1', 15:47:42 INFO - '--mitmproxy', 15:47:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:47:42 INFO - '--firstNonBlankPaint'], 15:47:42 INFO - 'tests': ['tp6_google', 15:47:42 INFO - 'tp6_youtube', 15:47:42 INFO - 'tp6_amazon', 15:47:42 INFO - 'tp6_facebook']}, 15:47:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:47:42 INFO - 'talos_options': ['--xperf_path', 15:47:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:42 INFO - 'tests': ['tp5n']}, 15:47:42 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:47:42 INFO - 'talos_options': ['--disable-stylo', 15:47:42 INFO - '--xperf_path', 15:47:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:42 INFO - 'tests': ['tp5n']}}} 15:47:42 INFO - Running post-action listener: _resource_record_post_action 15:47:42 INFO - [mozharness: 2017-09-11 22:47:42.214877Z] Finished populate-webroot step (success) 15:47:42 INFO - [mozharness: 2017-09-11 22:47:42.214966Z] Running create-virtualenv step. 15:47:42 INFO - Running pre-action listener: _resource_record_pre_action 15:47:42 INFO - Running main action method: create_virtualenv 15:47:42 INFO - Creating virtualenv /builds/slave/test/build/venv 15:47:42 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:47:42 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:47:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:47:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:47:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:47:42 INFO - Installing distribute.............................................................................................................................................................................................done. 15:47:43 INFO - Installing pip...............done. 15:47:43 INFO - Return code: 0 15:47:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:47:43 INFO - Reading from file tmpfile_stdout 15:47:43 INFO - Output received: 15:47:43 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:47:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:43 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 0x25621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d2090>, '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 0x28d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ccf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:47:43 INFO - Using env: {'DISPLAY': ':0', 15:47:43 INFO - 'HOME': '/home/cltbld', 15:47:43 INFO - 'LANG': 'en_US.UTF-8', 15:47:43 INFO - 'LANGUAGE': 'en_US:en', 15:47:43 INFO - 'LOGNAME': 'cltbld', 15:47:43 INFO - 'MAIL': '/var/mail/cltbld', 15:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:43 INFO - 'MOZ_NO_REMOTE': '1', 15:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:43 INFO - 'NO_EM_RESTART': '1', 15:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:43 INFO - 'PWD': '/builds/slave/test', 15:47:43 INFO - 'SHELL': '/bin/bash', 15:47:43 INFO - 'SHLVL': '1', 15:47:43 INFO - 'TERM': 'linux', 15:47:43 INFO - 'TMOUT': '86400', 15:47:43 INFO - 'USER': 'cltbld', 15:47:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 15:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:43 INFO - '_': '/tools/buildbot/bin/python'} 15:47:44 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:47:44 INFO - Downloading/unpacking pip>=1.5 15:47:44 INFO - Running setup.py egg_info for package pip 15:47:44 INFO - warning: no files found matching 'pip/cacert.pem' 15:47:44 INFO - warning: no files found matching '*.html' under directory 'docs' 15:47:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:47:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:47:44 INFO - Installing collected packages: pip 15:47:44 INFO - Found existing installation: pip 1.1 15:47:44 INFO - Uninstalling pip: 15:47:44 INFO - Successfully uninstalled pip 15:47:44 INFO - Running setup.py install for pip 15:47:44 INFO - warning: no files found matching 'pip/cacert.pem' 15:47:44 INFO - warning: no files found matching '*.html' under directory 'docs' 15:47:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:47:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:47:44 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:47:44 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:47:44 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:47:44 INFO - Successfully installed pip 15:47:44 INFO - Cleaning up... 15:47:44 INFO - Return code: 0 15:47:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d2090>, '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 0x28d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ccf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:47:44 INFO - Using env: {'DISPLAY': ':0', 15:47:44 INFO - 'HOME': '/home/cltbld', 15:47:44 INFO - 'LANG': 'en_US.UTF-8', 15:47:44 INFO - 'LANGUAGE': 'en_US:en', 15:47:44 INFO - 'LOGNAME': 'cltbld', 15:47:44 INFO - 'MAIL': '/var/mail/cltbld', 15:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:44 INFO - 'MOZ_NO_REMOTE': '1', 15:47:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:44 INFO - 'NO_EM_RESTART': '1', 15:47:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:44 INFO - 'PWD': '/builds/slave/test', 15:47:44 INFO - 'SHELL': '/bin/bash', 15:47:44 INFO - 'SHLVL': '1', 15:47:44 INFO - 'TERM': 'linux', 15:47:44 INFO - 'TMOUT': '86400', 15:47:44 INFO - 'USER': 'cltbld', 15:47:44 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 15:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:44 INFO - '_': '/tools/buildbot/bin/python'} 15:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:44 INFO - Downloading/unpacking psutil>=3.1.1 15:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:47:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:45 INFO - Installing collected packages: psutil 15:47:45 INFO - Running setup.py install for psutil 15:47:46 INFO - building 'psutil._psutil_linux' extension 15:47:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:47:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:47:46 INFO - building 'psutil._psutil_posix' extension 15:47:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:47:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:47:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:46 INFO - Successfully installed psutil 15:47:46 INFO - Cleaning up... 15:47:46 INFO - Return code: 0 15:47:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d2090>, '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 0x28d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ccf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:47:46 INFO - Using env: {'DISPLAY': ':0', 15:47:46 INFO - 'HOME': '/home/cltbld', 15:47:46 INFO - 'LANG': 'en_US.UTF-8', 15:47:46 INFO - 'LANGUAGE': 'en_US:en', 15:47:46 INFO - 'LOGNAME': 'cltbld', 15:47:46 INFO - 'MAIL': '/var/mail/cltbld', 15:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:46 INFO - 'MOZ_NO_REMOTE': '1', 15:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:46 INFO - 'NO_EM_RESTART': '1', 15:47:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:46 INFO - 'PWD': '/builds/slave/test', 15:47:46 INFO - 'SHELL': '/bin/bash', 15:47:46 INFO - 'SHLVL': '1', 15:47:46 INFO - 'TERM': 'linux', 15:47:46 INFO - 'TMOUT': '86400', 15:47:46 INFO - 'USER': 'cltbld', 15:47:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 15:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:46 INFO - '_': '/tools/buildbot/bin/python'} 15:47:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:47:47 INFO - Installing collected packages: mozsystemmonitor 15:47:47 INFO - Running setup.py install for mozsystemmonitor 15:47:47 INFO - Successfully installed mozsystemmonitor 15:47:47 INFO - Cleaning up... 15:47:48 INFO - Return code: 0 15:47:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d2090>, '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 0x28d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ccf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:47:48 INFO - Using env: {'DISPLAY': ':0', 15:47:48 INFO - 'HOME': '/home/cltbld', 15:47:48 INFO - 'LANG': 'en_US.UTF-8', 15:47:48 INFO - 'LANGUAGE': 'en_US:en', 15:47:48 INFO - 'LOGNAME': 'cltbld', 15:47:48 INFO - 'MAIL': '/var/mail/cltbld', 15:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:48 INFO - 'MOZ_NO_REMOTE': '1', 15:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:48 INFO - 'NO_EM_RESTART': '1', 15:47:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:48 INFO - 'PWD': '/builds/slave/test', 15:47:48 INFO - 'SHELL': '/bin/bash', 15:47:48 INFO - 'SHLVL': '1', 15:47:48 INFO - 'TERM': 'linux', 15:47:48 INFO - 'TMOUT': '86400', 15:47:48 INFO - 'USER': 'cltbld', 15:47:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 15:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:48 INFO - '_': '/tools/buildbot/bin/python'} 15:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:48 INFO - Downloading/unpacking jsonschema==2.5.1 15:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:47:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:50 INFO - Downloading functools32-3.2.3-2.tar.gz 15:47:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:47:50 INFO - warning: no files found matching '*.txt' 15:47:50 INFO - no previously-included directories found matching 'build' 15:47:50 INFO - no previously-included directories found matching 'dist' 15:47:50 INFO - no previously-included directories found matching '.git*' 15:47:50 INFO - Installing collected packages: jsonschema, functools32 15:47:51 INFO - Running setup.py install for functools32 15:47:51 INFO - warning: no files found matching '*.txt' 15:47:51 INFO - no previously-included directories found matching 'build' 15:47:51 INFO - no previously-included directories found matching 'dist' 15:47:51 INFO - no previously-included directories found matching '.git*' 15:47:51 INFO - Successfully installed jsonschema functools32 15:47:51 INFO - Cleaning up... 15:47:51 INFO - Return code: 0 15:47:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:47: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')]} 15:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47: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')]} 15:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47: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', '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 0x25621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d2090>, '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 0x28d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ccf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:47: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 functools32==3.2.3-2 15:47:51 INFO - Using env: {'DISPLAY': ':0', 15:47:51 INFO - 'HOME': '/home/cltbld', 15:47:51 INFO - 'LANG': 'en_US.UTF-8', 15:47:51 INFO - 'LANGUAGE': 'en_US:en', 15:47:51 INFO - 'LOGNAME': 'cltbld', 15:47:51 INFO - 'MAIL': '/var/mail/cltbld', 15:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:51 INFO - 'MOZ_NO_REMOTE': '1', 15:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:51 INFO - 'NO_EM_RESTART': '1', 15:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:51 INFO - 'PWD': '/builds/slave/test', 15:47:51 INFO - 'SHELL': '/bin/bash', 15:47:51 INFO - 'SHLVL': '1', 15:47:51 INFO - 'TERM': 'linux', 15:47:51 INFO - 'TMOUT': '86400', 15:47:51 INFO - 'USER': 'cltbld', 15:47:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 15:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:51 INFO - '_': '/tools/buildbot/bin/python'} 15:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:47:52 INFO - Cleaning up... 15:47:52 INFO - Return code: 0 15:47:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d2090>, '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 0x28d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ccf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:47:52 INFO - Using env: {'DISPLAY': ':0', 15:47:52 INFO - 'HOME': '/home/cltbld', 15:47:52 INFO - 'LANG': 'en_US.UTF-8', 15:47:52 INFO - 'LANGUAGE': 'en_US:en', 15:47:52 INFO - 'LOGNAME': 'cltbld', 15:47:52 INFO - 'MAIL': '/var/mail/cltbld', 15:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:52 INFO - 'MOZ_NO_REMOTE': '1', 15:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:52 INFO - 'NO_EM_RESTART': '1', 15:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:52 INFO - 'PWD': '/builds/slave/test', 15:47:52 INFO - 'SHELL': '/bin/bash', 15:47:52 INFO - 'SHLVL': '1', 15:47:52 INFO - 'TERM': 'linux', 15:47:52 INFO - 'TMOUT': '86400', 15:47:52 INFO - 'USER': 'cltbld', 15:47:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 15:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:52 INFO - '_': '/tools/buildbot/bin/python'} 15:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:52 INFO - Downloading/unpacking blobuploader==1.2.4 15:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:53 INFO - Downloading blobuploader-1.2.4.tar.gz 15:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:47:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:47:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:53 INFO - Downloading docopt-0.6.1.tar.gz 15:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:47:53 INFO - Installing collected packages: blobuploader, requests, docopt 15:47:53 INFO - Running setup.py install for blobuploader 15:47:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:47:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:47:54 INFO - Running setup.py install for requests 15:47:54 INFO - Running setup.py install for docopt 15:47:54 INFO - Successfully installed blobuploader requests docopt 15:47:54 INFO - Cleaning up... 15:47:54 INFO - Return code: 0 15:47:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:47: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')]} 15:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47: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')]} 15:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:54 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 0x25621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d2090>, '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 0x28d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ccf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:47:54 INFO - Using env: {'DISPLAY': ':0', 15:47:54 INFO - 'HOME': '/home/cltbld', 15:47:54 INFO - 'LANG': 'en_US.UTF-8', 15:47:54 INFO - 'LANGUAGE': 'en_US:en', 15:47:54 INFO - 'LOGNAME': 'cltbld', 15:47:54 INFO - 'MAIL': '/var/mail/cltbld', 15:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:54 INFO - 'MOZ_NO_REMOTE': '1', 15:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:54 INFO - 'NO_EM_RESTART': '1', 15:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:54 INFO - 'PWD': '/builds/slave/test', 15:47:54 INFO - 'SHELL': '/bin/bash', 15:47:54 INFO - 'SHLVL': '1', 15:47:54 INFO - 'TERM': 'linux', 15:47:54 INFO - 'TMOUT': '86400', 15:47:54 INFO - 'USER': 'cltbld', 15:47:54 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 15:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:54 INFO - '_': '/tools/buildbot/bin/python'} 15:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:47:54 INFO - Running setup.py (path:/tmp/pip-5xh4xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:47:54 INFO - Running setup.py (path:/tmp/pip-U7eUxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:47:54 INFO - Running setup.py (path:/tmp/pip-uD1jLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:47:55 INFO - Running setup.py (path:/tmp/pip-MgVdKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:47:55 INFO - Running setup.py (path:/tmp/pip-ssjnwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:47:55 INFO - Running setup.py (path:/tmp/pip-sddmet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:47:55 INFO - Running setup.py (path:/tmp/pip-sxtJ95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:47:55 INFO - Running setup.py (path:/tmp/pip-7VtY0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:47:55 INFO - Running setup.py (path:/tmp/pip-BDR1sO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:47:55 INFO - Running setup.py (path:/tmp/pip-rRKtMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:47:55 INFO - Running setup.py (path:/tmp/pip-LUGo7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:47:55 INFO - Running setup.py (path:/tmp/pip-v1clvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:47:55 INFO - Running setup.py (path:/tmp/pip-d2d90D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:47:55 INFO - Running setup.py (path:/tmp/pip-Z9iTNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:55 INFO - Running setup.py (path:/tmp/pip-o_m6ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:47:55 INFO - Running setup.py (path:/tmp/pip-zKawhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:47:55 INFO - Running setup.py (path:/tmp/pip-q45EJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:47:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:47:55 INFO - Running setup.py install for manifestparser 15:47:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:47:56 INFO - Running setup.py install for mozcrash 15:47:56 INFO - Running setup.py install for mozdebug 15:47:56 INFO - Running setup.py install for mozdevice 15:47:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:47:56 INFO - Running setup.py install for mozfile 15:47:56 INFO - Running setup.py install for mozhttpd 15:47:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:47:56 INFO - Running setup.py install for mozinfo 15:47:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:47:56 INFO - Running setup.py install for mozInstall 15:47:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:47:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:47:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:47:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:47:56 INFO - Running setup.py install for mozleak 15:47:56 INFO - Running setup.py install for mozlog 15:47:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:47:56 INFO - Running setup.py install for moznetwork 15:47:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:47:57 INFO - Running setup.py install for mozprocess 15:47:57 INFO - Running setup.py install for mozprofile 15:47:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:47:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:47:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:47:57 INFO - Running setup.py install for mozrunner 15:47:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:47:57 INFO - Running setup.py install for mozscreenshot 15:47:57 INFO - Running setup.py install for moztest 15:47:57 INFO - Running setup.py install for mozversion 15:47:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:47:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:47:57 INFO - Cleaning up... 15:47:57 INFO - Return code: 0 15:47:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:57 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 0x25621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d2090>, '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 0x28d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ccf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:47:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:47:57 INFO - Using env: {'DISPLAY': ':0', 15:47:57 INFO - 'HOME': '/home/cltbld', 15:47:57 INFO - 'LANG': 'en_US.UTF-8', 15:47:57 INFO - 'LANGUAGE': 'en_US:en', 15:47:57 INFO - 'LOGNAME': 'cltbld', 15:47:57 INFO - 'MAIL': '/var/mail/cltbld', 15:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:57 INFO - 'MOZ_NO_REMOTE': '1', 15:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:57 INFO - 'NO_EM_RESTART': '1', 15:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:57 INFO - 'PWD': '/builds/slave/test', 15:47:57 INFO - 'SHELL': '/bin/bash', 15:47:57 INFO - 'SHLVL': '1', 15:47:57 INFO - 'TERM': 'linux', 15:47:57 INFO - 'TMOUT': '86400', 15:47:57 INFO - 'USER': 'cltbld', 15:47:57 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 15:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:57 INFO - '_': '/tools/buildbot/bin/python'} 15:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:47:57 INFO - Running setup.py (path:/tmp/pip-0DZ7bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:47:58 INFO - Running setup.py (path:/tmp/pip-_xQjzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:47:58 INFO - Running setup.py (path:/tmp/pip-EqT0GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:47:58 INFO - Running setup.py (path:/tmp/pip-fUMEAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:47:58 INFO - Running setup.py (path:/tmp/pip-0Z7nkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:47:58 INFO - Running setup.py (path:/tmp/pip-T6oLAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:47:58 INFO - Running setup.py (path:/tmp/pip-OmZsM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:47:58 INFO - Running setup.py (path:/tmp/pip-HZaTV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:47:58 INFO - Running setup.py (path:/tmp/pip-w1cr04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:47:58 INFO - Running setup.py (path:/tmp/pip-eMDZZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:47:58 INFO - Running setup.py (path:/tmp/pip-uu1HCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:47:58 INFO - Running setup.py (path:/tmp/pip-zXBVQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:47:58 INFO - Running setup.py (path:/tmp/pip-sjkY24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:47:58 INFO - Running setup.py (path:/tmp/pip-GQOE0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:58 INFO - Running setup.py (path:/tmp/pip-FMCAfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:47:59 INFO - Running setup.py (path:/tmp/pip-xa4Im5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:47:59 INFO - Running setup.py (path:/tmp/pip-gsis1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:47:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:00 INFO - Downloading blessings-1.6.tar.gz 15:48:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:48:00 INFO - Installing collected packages: blessings 15:48:00 INFO - Running setup.py install for blessings 15:48:00 INFO - Successfully installed blessings 15:48:00 INFO - Cleaning up... 15:48:00 INFO - Return code: 0 15:48:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:48:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:00 INFO - Reading from file tmpfile_stdout 15:48:00 INFO - Current package versions: 15:48:00 INFO - argparse == 1.2.1 15:48:00 INFO - blessings == 1.6 15:48:00 INFO - blobuploader == 1.2.4 15:48:00 INFO - docopt == 0.6.1 15:48:00 INFO - functools32 == 3.2.3-2 15:48:00 INFO - jsonschema == 2.5.1 15:48:00 INFO - manifestparser == 1.1 15:48:00 INFO - mozInstall == 1.13 15:48:00 INFO - mozcrash == 1.0 15:48:00 INFO - mozdebug == 0.1 15:48:00 INFO - mozdevice == 0.51 15:48:00 INFO - mozfile == 1.2 15:48:00 INFO - mozhttpd == 0.7 15:48:00 INFO - mozinfo == 0.10 15:48:00 INFO - mozleak == 0.1 15:48:00 INFO - mozlog == 3.5 15:48:00 INFO - moznetwork == 0.27 15:48:00 INFO - mozprocess == 0.25 15:48:00 INFO - mozprofile == 0.28 15:48:00 INFO - mozrunner == 6.13 15:48:00 INFO - mozscreenshot == 0.1 15:48:00 INFO - mozsystemmonitor == 0.3 15:48:00 INFO - moztest == 0.8 15:48:00 INFO - mozversion == 1.4 15:48:00 INFO - psutil == 3.1.1 15:48:00 INFO - requests == 1.2.3 15:48:00 INFO - wsgiref == 0.1.2 15:48:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:00 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 0x25621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d2090>, '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 0x28d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ccf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:00 INFO - Using env: {'DISPLAY': ':0', 15:48:00 INFO - 'HOME': '/home/cltbld', 15:48:00 INFO - 'LANG': 'en_US.UTF-8', 15:48:00 INFO - 'LANGUAGE': 'en_US:en', 15:48:00 INFO - 'LOGNAME': 'cltbld', 15:48:00 INFO - 'MAIL': '/var/mail/cltbld', 15:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:00 INFO - 'MOZ_NO_REMOTE': '1', 15:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:00 INFO - 'NO_EM_RESTART': '1', 15:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:00 INFO - 'PWD': '/builds/slave/test', 15:48:00 INFO - 'SHELL': '/bin/bash', 15:48:00 INFO - 'SHLVL': '1', 15:48:00 INFO - 'TERM': 'linux', 15:48:00 INFO - 'TMOUT': '86400', 15:48:00 INFO - 'USER': 'cltbld', 15:48:00 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 15:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:00 INFO - '_': '/tools/buildbot/bin/python'} 15:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:48:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:48:02 INFO - Installing collected packages: simplejson 15:48:02 INFO - Running setup.py install for simplejson 15:48:02 INFO - building 'simplejson._speedups' extension 15:48:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:48:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:48:03 INFO - Successfully installed simplejson 15:48:03 INFO - Cleaning up... 15:48:03 INFO - Return code: 0 15:48:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:03 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 0x25621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d2090>, '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 0x28d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ccf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:48:03 INFO - Using env: {'DISPLAY': ':0', 15:48:03 INFO - 'HOME': '/home/cltbld', 15:48:03 INFO - 'LANG': 'en_US.UTF-8', 15:48:03 INFO - 'LANGUAGE': 'en_US:en', 15:48:03 INFO - 'LOGNAME': 'cltbld', 15:48:03 INFO - 'MAIL': '/var/mail/cltbld', 15:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:03 INFO - 'MOZ_NO_REMOTE': '1', 15:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:03 INFO - 'NO_EM_RESTART': '1', 15:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:03 INFO - 'PWD': '/builds/slave/test', 15:48:03 INFO - 'SHELL': '/bin/bash', 15:48:03 INFO - 'SHLVL': '1', 15:48:03 INFO - 'TERM': 'linux', 15:48:03 INFO - 'TMOUT': '86400', 15:48:03 INFO - 'USER': 'cltbld', 15:48:03 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 15:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:03 INFO - '_': '/tools/buildbot/bin/python'} 15:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:48:03 INFO - Cleaning up... 15:48:03 INFO - Return code: 0 15:48:03 INFO - Running post-action listener: _resource_record_post_action 15:48:03 INFO - Running post-action listener: _start_resource_monitoring 15:48:03 INFO - Starting resource monitoring. 15:48:03 INFO - [mozharness: 2017-09-11 22:48:03.458016Z] Finished create-virtualenv step (success) 15:48:03 INFO - [mozharness: 2017-09-11 22:48:03.458540Z] Running install step. 15:48:03 INFO - Running pre-action listener: _resource_record_pre_action 15:48:03 INFO - Running main action method: install 15:48:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:03 INFO - Reading from file tmpfile_stdout 15:48:03 INFO - Detecting whether we're running mozinstall >=1.0... 15:48:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:48:03 INFO - Reading from file tmpfile_stdout 15:48:03 INFO - Output received: 15:48:03 INFO - Usage: mozinstall [options] installer 15:48:03 INFO - Options: 15:48:03 INFO - -h, --help show this help message and exit 15:48:03 INFO - -d DEST, --destination=DEST 15:48:03 INFO - Directory to install application into. [default: 15:48:03 INFO - "/builds/slave/test"] 15:48:03 INFO - --app=APP Application being installed. [default: firefox] 15:48:03 INFO - mkdir: /builds/slave/test/build/application 15:48:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:48:20 INFO - Reading from file tmpfile_stdout 15:48:20 INFO - Output received: 15:48:20 INFO - /builds/slave/test/build/application/firefox/firefox 15:48:20 INFO - Running post-action listener: _resource_record_post_action 15:48:20 INFO - [mozharness: 2017-09-11 22:48:20.392046Z] Finished install step (success) 15:48:20 INFO - [mozharness: 2017-09-11 22:48:20.392295Z] Running setup-mitmproxy step. 15:48:20 INFO - Running pre-action listener: _resource_record_pre_action 15:48:20 INFO - Running main action method: setup_mitmproxy 15:48:20 INFO - Skipping: mitmproxy is not required 15:48:20 INFO - Running post-action listener: _resource_record_post_action 15:48:20 INFO - [mozharness: 2017-09-11 22:48:20.393419Z] Finished setup-mitmproxy step (success) 15:48:20 INFO - [mozharness: 2017-09-11 22:48:20.393638Z] Running run-tests step. 15:48:20 INFO - Running pre-action listener: _resource_record_pre_action 15:48:20 INFO - Running pre-action listener: _set_gcov_prefix 15:48:20 INFO - Running main action method: run_tests 15:48:20 WARNING - Try message not found. 15:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:48:20 INFO - Python 2.7.3 15:48:20 INFO - Return code: 0 15:48:20 INFO - grabbing minidump binary from tooltool 15:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:20 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 0x28d2090>, '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 0x28d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ccf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:48:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:48:20 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:48:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:48:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:48:20 INFO - Return code: 0 15:48:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:48:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:48:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:48:20 INFO - ENV: RUST_BACKTRACE is now full 15:48:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:48:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 15:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 15:48:20 INFO - Using env: {'DISPLAY': ':0', 15:48:20 INFO - 'HOME': '/home/cltbld', 15:48:20 INFO - 'LANG': 'en_US.UTF-8', 15:48:20 INFO - 'LANGUAGE': 'en_US:en', 15:48:20 INFO - 'LOGNAME': 'cltbld', 15:48:20 INFO - 'MAIL': '/var/mail/cltbld', 15:48:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:48:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:20 INFO - 'MOZ_NO_REMOTE': '1', 15:48:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:20 INFO - 'NO_EM_RESTART': '1', 15:48:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:20 INFO - 'PWD': '/builds/slave/test', 15:48:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:48:20 INFO - 'RUST_BACKTRACE': 'full', 15:48:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:48:20 INFO - 'SHELL': '/bin/bash', 15:48:20 INFO - 'SHLVL': '1', 15:48:20 INFO - 'TERM': 'linux', 15:48:20 INFO - 'TMOUT': '86400', 15:48:20 INFO - 'USER': 'cltbld', 15:48:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 15:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:20 INFO - '_': '/tools/buildbot/bin/python'} 15:48:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 15:48:20 INFO - mozversion application_buildid: 20170911215847 15:48:20 INFO - mozversion application_changeset: 3a6d2e30bbe18b4ed6d3d964afe9c97237f0515d 15:48:20 INFO - mozversion application_display_name: Nightly 15:48:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:48:20 INFO - mozversion application_name: Firefox 15:48:20 INFO - mozversion application_remotingname: firefox 15:48:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:48:20 INFO - mozversion application_vendor: Mozilla 15:48:20 INFO - mozversion application_version: 57.0a1 15:48:20 INFO - mozversion platform_buildid: 20170911215847 15:48:20 INFO - mozversion platform_changeset: 3a6d2e30bbe18b4ed6d3d964afe9c97237f0515d 15:48:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:48:20 INFO - mozversion platform_version: 57.0a1 15:48:20 INFO - using testdate: 1505170100 15:48:20 INFO - actual date: 1505170100 15:48:20 INFO - starting webserver on 'localhost:59431' 15:48:20 INFO - SUITE-START | Running 2 tests 15:48:20 INFO - TEST-START | dromaeo_css 15:48:20 INFO - Initialising browser for dromaeo_css test... 15:48:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59431/getInfo.html -profile /tmp/tmpsavPiA/profile 15:48:20 INFO - TEST-INFO | started process 22764 (/builds/slave/test/build/application/firefox/firefox http://localhost:59431/getInfo.html) 15:48:26 INFO - TEST-INFO | 22764: exit 0 15:48:26 INFO - Browser initialized. 15:48:26 INFO - Running cycle 1/1 for dromaeo_css test... 15:48:26 INFO - Using env: {'DISPLAY': ':0', 15:48:26 INFO - 'HOME': '/home/cltbld', 15:48:26 INFO - 'JSGC_DISABLE_POISONING': '1', 15:48:26 INFO - 'LANG': 'en_US.UTF-8', 15:48:26 INFO - 'LANGUAGE': 'en_US:en', 15:48:26 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:48:26 INFO - 'LOGNAME': 'cltbld', 15:48:26 INFO - 'MAIL': '/var/mail/cltbld', 15:48:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:48:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:48:26 INFO - 'MOZ_CRASHREPORTER': '1', 15:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:26 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:48:26 INFO - 'MOZ_NO_REMOTE': '1', 15:48:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:26 INFO - 'NO_EM_RESTART': '1', 15:48:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:26 INFO - 'PWD': '/builds/slave/test', 15:48:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:48:26 INFO - 'RUST_BACKTRACE': 'full', 15:48:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:48:26 INFO - 'SHELL': '/bin/bash', 15:48:26 INFO - 'SHLVL': '1', 15:48:26 INFO - 'TERM': 'linux', 15:48:26 INFO - 'TMOUT': '86400', 15:48:26 INFO - 'USER': 'cltbld', 15:48:26 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 15:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:26 INFO - '_': '/tools/buildbot/bin/python'} 15:48:26 INFO - TEST-INFO | started process 22968 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsavPiA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:27 INFO - PID 22968 | 15:48:27 INFO - PID 22968 | (/builds/slave/test/build/application/firefox/firefox:23019): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:48:27 INFO - PID 22968 | 15:48:38 INFO - PID 22968 | RSS: Main: 170655744 15:48:38 INFO - PID 22968 | 15:51:34 INFO - PID 22968 | Cycle 1(1): loaded http://localhost:59431/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59431/tests/dromaeo/cssquery-ext.html) 15:51:35 INFO - PID 22968 | RSS: Main: 173690880 15:51:35 INFO - PID 22968 | 15:54:37 INFO - PID 22968 | Cycle 1(1): loaded http://localhost:59431/tests/dromaeo/cssquery-ext.html (next: http://localhost:59431/tests/dromaeo/cssquery-jquery.html) 15:54:38 INFO - PID 22968 | RSS: Main: 170450944 15:54:38 INFO - PID 22968 | 15:57:40 INFO - PID 22968 | Cycle 1(1): loaded http://localhost:59431/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59431/tests/dromaeo/cssquery-mootools.html) 15:57:40 INFO - PID 22968 | RSS: Main: 172650496 15:57:40 INFO - PID 22968 | 16:00:42 INFO - PID 22968 | Cycle 1(1): loaded http://localhost:59431/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59431/tests/dromaeo/cssquery-prototype.html) 16:00:42 INFO - PID 22968 | RSS: Main: 171442176 16:00:42 INFO - PID 22968 | 16:03:46 INFO - PID 22968 | Cycle 1(1): loaded http://localhost:59431/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59431/tests/dromaeo/cssquery-yui.html) 16:03:46 INFO - PID 22968 | RSS: Main: 172503040 16:03:46 INFO - PID 22968 | 16:06:48 INFO - PID 22968 | Cycle 1(1): loaded http://localhost:59431/tests/dromaeo/cssquery-yui.html (next: http://localhost:59431/tests/dromaeo/cssquery-dojo.html) 16:06:48 INFO - PID 22968 | RSS: Main: 175435776 16:06:48 INFO - PID 22968 | 16:06:48 INFO - PID 22968 | __start_tp_report 16:06:48 INFO - PID 22968 | _x_x_mozilla_page_load 16:06:48 INFO - PID 22968 | _x_x_mozilla_page_load_details 16:06:48 INFO - PID 22968 | |i|pagename|runs| 16:06:48 INFO - PID 22968 | |0;dojo.html;3110.253539150604;3141.32461520773;3142.5129104988705;3147.0716138739076;3151.810891346518;6097;6192.659403732793;6246.5315101367405;6278.30938596754;6333.271673757525;6185.41238582334;6227.532935029868;6234.906476402846;6249.53128515362;6255.530835187356;5726.226959360475;5758.337791154008;5762.250907382035;5793.159991801186;5802.680852553108;5716.828495145152;5745.770169193227;5747.971260143693;5752.539796816244;5839.708014599274;5778.757567123068;5851.356350801409;5853.268341457318;5856.912146317787;5867.735951882154;908.3367313938618;5683.687397193153;5694.060480020791;5846.532277417797;5893.351731309553;5682.7442765075675;5734.053881109612;5799.4780469757925;5815.505682017034;5819.67991760453;6273.717682704244;6285.842853928689;6314.242290925073;6334.873302533923;6352.968235158841;6726.93273067268;6727.9327206728285;6728.3271672832325;6810.353016463428;6826.658667066677;6787.490938179656;6791.796246112575;6882.449404047664;6890;6892.035115083892;6104.786332478387;6226.968865155691;6252.3435039320675;6321.589096708699;6342.1121043053545;6998.510104292753;7005.404540614003;7013.964930175316;7023.508354415244;7052.2595127511895;6591.868162636721;6623.867522649616;6686.598804071674;6702.162229721285;6722.764703235363;6710.463162946952;6734.595924244561;6748.932510674928;6819;6831.931680683229;6483.643399612973;6527.34726527353;6577.276499585042;6589.76935807254;6651.567648102858;6744.730210791611;6773;6789.083473730983;6796.558223715443;6802.727890884408;5238.109521381374;5254.15933450646;5255.159174532057;5327.934413117392;5328.813491527778;4546.931796023062;4584.908301833944;4631.606313463393;4649.442066951988;4654.325122857167;5714.628549144375;5720.170575266647;5780.219670344533;5788.3343415506915;5802.912956305659;6779.898301525481;6825.726970921207;6838.794836154923;6865.519413641097;6882.518223724392;5750.7987220447085;5757.827265182052;5832.3292821326095;5838.065909454467;5846.561507886926;5641.548676105984;5773.740181691834;5784.479396854304;5852.648841069465;5853.619514731528;6418;6484.092227088211;6510.739570417225;6511.902321465182;6512.544121911421;6594.967025164748;6662.866742665216;6687.966560167168;6712.39588437043;6877.312268773083;6366.427021568081;6392.105105285171;6468.579542329733;6499.122618446449;6499.285078641251;6428.164338635947;6515.576487528296;6613.27254002069;6698.22970358415;6724.125863637696;6693.866122677617;6780.660966951534;6780.762673306411;6784.151981002375;6786.694598743167;6549.770758023446;6566.573172743756;6634.137562116894;6662.433693135944;6663.033860090357;6537.607743535403;6543.770968016097;6610.07458955737;6616.669166541557;6643.169603799525;6350.555461117678;6463.967680161757;6481.995290729945;6562.737490500517;6565.113709649137;6536.967315163393;6574.178227721535;6611.570247933869;6619.834504137435;6651.401373876374;6413.0701048348665;6475.093486911742;6503.837404064936;6505.251896032017;6509.707063182073 16:06:48 INFO - PID 22968 | |1;ext.html;809.821839195377;843.8523258429773;848.4909054567256;849.252657661258;849.5921957460419;37878.24243515128;38698.226035479274;41344.58655413449;41414.58585414145;41463.79268103655;39214.8039259804;39322.80338598303;39342.8032859836;39362;39485.40771888424;6930.826729331782;7039.718411263543;7044.577325360495;7050.6122163281;7057.89413158803;7553.924460755377;7778.727744528943;7780.299773020427;7786.7663970080985;7789.688412463523;7700.961495192516;7723.806904827368;7730.922690773076;7830.56931868747;7830.647620857047;7824.217578242159;7856.057273127204;7862.764117076468;7866.056073271216;7873.858290547839;7630.732924347677;7679.232076792276;7701.3453856422275;7716.151223365426;7749.612519374009;38349.23301533954;38536;38543.22913541713;38725.80637096796;38744.418833717515;3430.2967891582416;3456.7580269381156;3457.3258214648154;3457.3776720190353;3460.0657822388066;31826;32068;32071.198220044687;32092.358152836812;32162.356752864813;5192.844214673566;5209.2446595243855;5260.079486089919;5274.55166310864;5286.709230992294;198287;198697;199491;199636;199972.00013999981;48773.75613121912;49105;49249.50750492449;49270.31931966457;49364.50635493671;44484.77757611256;45364.546354536695;45440;51697.7415112922;52854.414367569036;14107.929460352838;14168;14214.076085054437;14233.430662773373;14246.145231286157;11374.976252137347;11382.430878456044;11384.601538946263;11386.032187264009;11408.714782130348;14172.645683857985;14280.642983925485;14320.283985800668;14435.566932992027;14494;5676.517496012885;5711.371749107595;5755.827325180251;5803.738831752581;5932.584719069624;993.2103977338033;1002.2783595811004;1006.0894890124449;1009.2077718990557;1028.3726926574784;22415.32754017382;22427.21504747326;22517.549649006927;22707.545849082926;22822.20122295745;1079.4171147580219;1094.8412480190486;1105.0938230650788;1105.6406667832987;1115.5036008975928;11859.908201955732;11869.5845645402;11948.880511194777;11976.28142311464;12005.219660722025;221379;223083;224849;225072;225325;54147.18779218315;54264.72867635637;54298.18552721712;54299.72850135724;54517.72741136269;1402.3689339797131;1442.2860683961296;1447.7249322628877;1466.0690461556987;1470.029780344967;22369;22533.66199506976;22798.65802012938;22944.770552294263;23152.305430837103;38474.230515390096;38525.61474385332;38551.6144838548;38568;38574.42138367871;184171;186594;186817;187878;188140;34300.48549271713;35044.64955350414;36793;37303.44044839275;37375;44973;45847;46117;46224.30663540117;46354.30468543042;33796.15509612279;34054.14864628404;34164.82917585396;34338.82830585831;34406.31187376288;33574.32851342911;33710.83144584359;33922;34177;34796.65203348036;38151;38593;38748;38757.6124238754;38774.61225387823;32537.83731081424;32812.50781238331;32928.67071329352;33221.667783322824;33561.328773423906;23613.29160125199;24001.879990599937;24246.151384702156;24768.752312476645;25228.62157067609 16:06:48 INFO - PID 22968 | |2;jquery.html;553.6041730162933;566.9376368599455;571.9342275638301;576.942305769423;582.1180910919956;21681.783182168172;22226.555468890612;22448;22472.662910056362;22485.887570562165;23212.187573434934;24055.39861503463;24095.39761505963;24132.8793356033;24594.877025614845;6339.239291285052;6441.066045423411;6473.902891456632;6488.124103246048;6494.577852439576;6308.653024083674;6321.46267567255;6417;6588.868222635544;6619.669016549177;6573.868522629545;6580.736770529197;6582.901256481156;6587.571807832475;6587.967060164692;6587.901181482282;6588.901166482507;6591.307912669196;6852.862942741117;7160.462965277573;7014.473914456436;7023.92976070243;7025.051618031552;7036.366726994595;7043.92956070443;29490.70509294901;30026.549601755993;30066.699333006607;30087;30090.24774380636;2044.7852975437513;2065.989670051655;2070.4099331690545;2071.6996035574757;2074.6576814825535;19052.90473547637;19097.140628671743;19779.50551236216;19928.80071199284;19931;2447.204658485999;2456.5946618807875;2532.126416386344;2569.40903592173;2571.4085760275057;118729;124695;132055.33972330077;135788;137034.999999999;19409.95341211295;19953.201871925252;21007.684884726743;21275.36173914785;21498.892505537373;40507;40755.7962210187;40763.79618101891;40847.59152408497;40896.59103408928;10284.537195826206;10284.868664446905;10436.478176091165;10466.63366782159;10569.312994655324;8589.957050214834;8658.567071646392;8688.435251708619;8715.433496822812;8818.206361427503;10611.257211995086;10861.166780782476;11001.039899293975;11133.824815694115;11179.273347232403;4063.6342729154517;4141.751494910315;4217.40956266123;4238.894027649272;4250.107477429774;939.3096074385321;957.2485598804905;961.9086186812242;963.8698775665196;976.6874600127891;18455.723164152547;18741.7188742169;18917.62164756697;19029.238830446626;19364.903175484033;992.3400938376044;1001.7846163074973;1002.9749256268651;1009.9092979582034;1020.1991436722137;10172.745681358025;10251.641192558225;10424.270301079003;10510.211734119972;10558.577656893638;476117;477523;482850;486373;488178;99705;101414;101427;104095.4795226019;104114.95885041052;998.4059484606647;1138.3170097941334;1141.720278531765;1142.8628564572139;1149.2013050929525;19392.4182274532;19432.4170274892;19702;19732.605347893248;19815.504612384804;50804.745976269885;51644.708882278246;53027.73486132544;54017.459825401245;55006.72496637491;65979.34020659732;66894;67171.31314747356;67212.3278767206;67700;18421.53946151357;18705.438836834917;18920.810791892454;19009.33467328637;19014.334498292494;21370.893145534174;21581.13675452964;21673;21695.240666576596;21779.673304900756;16157.192140393168;16320.836791632406;16400.917995409945;17478.475645730647;17807.19867605935;14752.55742327689;15080.095194288378;15857.444989425314;16020.519384418487;16266.51200463988;17970.19134138993;18053.819461805215;18141.27434902589;18213.817861821743;18256.36102736398;18713;18766.249350025846;18795.530111747317;18879.811201887806;18913.810861891205;17437.564060898578;17601.207945642735;17708.583313334646;17710.822891771433;17735.556611084827 16:06:48 INFO - PID 22968 | |3;mootools.html;1295.093434595783;1381.5786185213512;1392.853750356212;1400.0689541454933;1403.130059363195;14860.33128509217;15454.30455629498;15461.226938653064;15493.612659683513;15511.767323490129;15240.923795381008;15309.464168754095;15348.923255383736;15354.385824567004;15380.077195368258;2613.6079588061752;2635.841849489027;2668.786497080229;2681.4368982513697;2684.033747850772;2575.974240257592;2622.2919811650845;2634.1570697376847;2637.446136311377;2648.390870099878;2546.796256299501;2640.194740604115;2647.0470630572977;2649.8807553660035;2750.917472475829;2686.2209959111933;2714.0229517373728;2714.3756935904753;2716.2394529531566;2716.3480764616547;2656.4155885705113;2686.9520886854143;2691.2060942021953;2693.4343787804582;2693.784497240236;15099.32053057604;15180.544583662508;15238.695226095528;15257.771133433007;15286;7542.434317426215;7794.571298578576;7798.376129909594;7803.531788092732;7813.843723125506;4915.21356582945;4999.75001249936;5170.172772356443;5177.430482646906;5190.351206099238;1869.5232715657555;1945.2608008956647;1957.6574099532668;1978.9010549472468;1981.8414526837819;26297.73702262972;26839;27158.864205678845;27863.86068069667;27929.162125136278;6542.476601871934;6564.409203171737;6639.336066393322;6761.019652150509;6775.932240677629;17042.31830726782;17130.571735706708;17205.397811076553;17643.29426822913;17658.82341176572;7269.454790890704;7474.5888976106835;7476.925230747623;7481.214472480311;7482.326590606763;6903.930960690429;6939.375456208965;6958.408535274457;7003.8599228015155;7008.088948436671;5049.394072711225;5176.6635168714665;5177.767000484987;5181.948180518147;5211.452797456288;1461.6418977350618;1464.282501574221;1475.7343678138038;1480.7704805755125;1490.1208287110658;771.1247733822153;796.3947399976059;798.8562058829466;799.3724925933114;811.6996711216888;7216.96391518039;7234.74678386254;7248.0939882514685;7314.634268286564;7330.560166390033;663.9336066393322;669.4410167510086;683.1563019670702;687.5355492800403;694.5034300475185;4163.8959026024595;4734.28985652148;4761;4896.853094407174;4948;20751.8962405187;21013.47466313324;21163;21174.258900938392;21627.134914603554;20178.27593274889;21528.246511372028;21670;21744.456388590414;21748.782512174676;10034.347767395242;10061.346012509164;10074.294799363974;10107.39355638664;10114.443705596115;7710.4602677814255;8046.718364857436;8104.230098140667;8160.959195203986;8250.46371985819;18215.362462313755;18962.905185473985;19110.426687199408;19193.232270709017;19299.131539081056;18662.34681786131;19304.227830886608;19657.606847863248;19668.11493482768;19723.802761972198;10837.783244335227;10868.021878031015;10942.23404361687;10949.397783122005;10974.506147223234;13543.593692188855;13735.381907814372;13753.38109785042;13772.586822395344;13775.448982040607;10985.835212471979;11052;11106.333619982504;11181.888181118411;11322.773544528898;10797.29817561856;10888.455577221266;11012.284201526874;11063.889361106287;11269.154813389192;9025.097490250922;9202.769930751785;9212.631494740135;9226.584803683985;9234.399764015317;6418.6469744164515;6421.8715625688155;6442;6462.224533056064;6528.934710653023;6672.132622759011;6829.2487826338065;6853.554518956252;6901.309869013058;6914.896276555956 16:06:48 INFO - PID 22968 | |4;prototype.html;491.405292132142;493.1772257802524;518.2718280815451;526.568214064467;527.3961314295132;6112.29708583513;6170.9999999999945;6187.628742275467;6266.310705822368;6273.874522509553;6144.262688477378;6167.7841275555365;6180.660063696495;6214.65819379934;6219.595726277788;5131.307273518065;5140.845774626749;5153.969206158765;5162.716050617215;5199.870003249911;4817;4943.505649435064;5093.159628661267;5129.794808207667;5147.794088236466;4891.657583969123;4909.772556860785;4922.507749225085;4933.555979961803;4946.134426475371;4896.485868983759;4924.852254432355;4947.604191664658;4954.628402869799;4957.628177886673;4315.978420107911;4406.515283318832;4411.448568928884;4411.845585404495;4434.334849772527;6018.699065046774;6044.516438684895;6079.483243924272;6083.726232319556;6090.512758979271;5573.015294064763;5607.046802043662;5625.971870140664;5637.49262566371;5649.4633009864;6455.4835613150835;6465.903011454832;6466.450351720109;6470.676466176672;6480.254770701383;4579.152856721517;4776.188048031843;4790.616750659939;4814;4820.879478013043;6518.511111666644;6588.374104460068;6633.20401551812;6641.701123449457;6714.865702685919;4834.226523756182;4849.345338379274;4855.781489832966;4877.634177436636;4885.926711099336;4919.2867034279825;4920.434150072716;4937.308776771255;4939.357883475197;4968.652194346361;5513.228148059275;5570.41510641385;5573.526250268692;5587.776488940397;5597.188407680864;6517.283098859121;6533.640649764308;6536.313687062885;6539.509536784665;6548.476121910236;1698.3631138323128;1714.3656846966453;1714.5884987602885;1722.500474862301;1726.5597272695381;1113.1261959361861;1161.6979585307881;1170.8419363385833;1186.0156070461496;1196.7008247938015;5565.554755619541;5566.165075238747;5584.190292407659;5589.496945274864;5607.859803504945;6452.22573291208;6464.288928217892;6502.862738436676;6513.316101809337;6585.5719378240265;5589.580781441408;5606.6916319602815;5613.298337707786;5630.831075067755;5640.689762063126;3449.448088305859;3475.2528206435736;3477.4088404971217;3478.2347883465595;3513.94729079064;6234.501239900797;6268.8119356418465;6273.654948977759;6291.182146320949;6305.306416294204;6655.600663960178;6692.19693636757;6707.3292670732535;6732.562383445061;6790.93209067903;6190.133381326618;6197.566170368031;6224.844378890473;6239.159447962771;6322.430981211805;6474.320196379501;6555.3772391622715;6612.735490580323;6615.867682646224;6622.933770662425;5941.584089113893;6446.903296450463;6514.2834288229205;6522.902156467562;6580.5064620152725;6207.410296021871;6278.937210627835;6296.212973378328;6299.842503937438;6308.526860485574;4883.487233840396;4885.218365061573;4901.485344038824;4909.1654418748185;4924.532169443897;6328.810135695937;6422.550421470452;6451.580647257913;6642.867142657024;6695.564788288746;6296.653684047238;6324.367563243639;6364.395382438661;6436.710348034443;6459.4832413405875;6267.310595834363;6269.592476489013;6348.682565871595;6369.108324834619;6378.2346118466085;6122.265328160471;6218.533609979179;6254.343293954252;6256.8424841404485;6298.622082675054;6181.207449839496;6288.371162883675;6297.2128483939505;6355.332690067661;6373.553851230369;6166.445019948226;6195.628262304276;6237.220347456568;6254.686515831726;6335.778247761306 16:06:48 INFO - PID 22968 | |5;yui.html;846.4794151596767;867.050579615321;867.1891781184593;895.6372669069025;907.6505545365037;14626.48807291745;14878.776818347733;14909.179995100265;14922.850771492282;14927.776083358758;16022.278997445113;16508.092054937002;16527.917360413183;16551.751723724155;16574;951.8905325887525;966.405660518783;966.9951650241738;968.0803236924914;969.883613966325;964.8504481805331;968.4431451915177;969.016448304971;972.1687956796943;972.2367941166186;958.7555173430766;1001.3241062282966;1005.9195264378832;1006.0643601450648;1006.3659894266602;998.0817647764075;999.14073896449;1000.5147503460815;1000.604761119361;1001.0890090018048;718.7125149940014;739.1979702023258;743.8995735575736;744.5086243079542;744.7877354953866;15793.447229347033;15856.841431585652;15913.522594322189;15955.521334359988;15983.280752366172;20484.283050093174;20539.5892082159;21000.36998890036;21056;21191.364259072252;15652.765208521882;15881.36474541017;15972.28124734378;16001.519954401387;16122.274497647517;3668.0646435158865;3702.777833329982;3705.5182826232417;3705.925881482382;3706.870259540903;105362.47318763434;124474;137469.31265343708;138002;139252;17323.307067717404;17961.101944902963;17987.820121798875;18045.458636240935;18072.90963545174;31620.209494762355;31973.840130799195;31976.840115799274;32032.199195019846;32101.839490802395;8199.508029518249;8357.749267521984;8381;8408.495490270481;8410.957945210357;3725.068732816796;3837.270918525471;3842.8462861485227;3850.3646898261472;3859.7877116758846;5374.838754837361;5466.508014278734;5482.91775623366;5485.862853428696;5521.061419558685;1024.2267088348249;1044.5717255925035;1046.5029111172132;1051.7265510967204;1053.5575058475458;639.67376637915;657.4214691071921;674.9696263668146;676.4182802789597;680.6562685843618;11024;11231.38227397501;11255;11526;11592;652.2108249018646;654.1986067067899;670.7082419147687;676.7259259999709;678.1387637700093;5106.66806657566;5133.224144129787;5213.530782229617;5248;5326.387465441524;120250;120633;123846.38076809558;124041.37979310045;124941;101537;105211;107405;108534.45732771285;108767;92438.53780731054;94959;96006;96256.0374396261;97245;9676;9717.27120465982;9773;9846.31075824714;9931.702048938543;42841;42924.78537607417;44396;44837;45394.546054540355;55125;55357;56882;56961.43038569561;57408.71295643495;15246.847531524543;15246.923765381101;15293.847061529243;15315.387384504495;15353.692926141637;14689.19209443491;14696.338664760326;14725.852741472449;14849.109053456827;14857.108573485626;12674.493020279086;12752.6811829705;12774.744505110031;12846;12860.356982151043;14007;14111.22388268655;14236.50172244008;14250.857491424953;14356.425742970165;13842;14053.789193162314;14124.646883827987;14161.858381416467;14177;9977;9999.150072243941;10049.69850904474;10138.391696498235;10294.176465882561;9203.723888283363;9230.263223465976;9253.306002049738;9375.015623359723;9422.670206542738 16:06:48 INFO - PID 22968 | __end_tp_report 16:06:48 INFO - PID 22968 | __start_cc_report 16:06:48 INFO - PID 22968 | _x_x_mozilla_cycle_collect,355 16:06:48 INFO - PID 22968 | __end_cc_report 16:06:48 INFO - PID 22968 | __startTimestamp1505171208621__endTimestamp 16:06:48 INFO - PID 22968 | 16:06:48 INFO - PID 22968 | ------- Summary: start ------- 16:06:48 INFO - PID 22968 | Number of tests: 6 16:06:48 INFO - PID 22968 | 16:06:48 INFO - PID 22968 | [#0] dojo.html Cycles:165 Average:6162.77 Median:6475.09 stddev:857.32 (13.2%) stddev-sans-first:825.82 16:06:48 INFO - PID 22968 | Values: 3110.3 3141.3 3142.5 3147.1 3151.8 6097.0 6192.7 6246.5 6278.3 6333.3 6185.4 6227.5 6234.9 6249.5 6255.5 5726.2 5758.3 5762.3 5793.2 5802.7 5716.8 5745.8 5748.0 5752.5 5839.7 5778.8 5851.4 5853.3 5856.9 5867.7 908.3 5683.7 5694.1 5846.5 5893.4 5682.7 5734.1 5799.5 5815.5 5819.7 6273.7 6285.8 6314.2 6334.9 6353.0 6726.9 6727.9 6728.3 6810.4 6826.7 6787.5 6791.8 6882.4 6890.0 6892.0 6104.8 6227.0 6252.3 6321.6 6342.1 6998.5 7005.4 7014.0 7023.5 7052.3 6591.9 6623.9 6686.6 6702.2 6722.8 6710.5 6734.6 6748.9 6819.0 6831.9 6483.6 6527.3 6577.3 6589.8 6651.6 6744.7 6773.0 6789.1 6796.6 6802.7 5238.1 5254.2 5255.2 5327.9 5328.8 4546.9 4584.9 4631.6 4649.4 4654.3 5714.6 5720.2 5780.2 5788.3 5802.9 6779.9 6825.7 6838.8 6865.5 6882.5 5750.8 5757.8 5832.3 5838.1 5846.6 5641.5 5773.7 5784.5 5852.6 5853.6 6418.0 6484.1 6510.7 6511.9 6512.5 6595.0 6662.9 6688.0 6712.4 6877.3 6366.4 6392.1 6468.6 6499.1 6499.3 6428.2 6515.6 6613.3 6698.2 6724.1 6693.9 6780.7 6780.8 6784.2 6786.7 6549.8 6566.6 6634.1 6662.4 6663.0 6537.6 6543.8 6610.1 6616.7 6643.2 6350.6 6464.0 6482.0 6562.7 6565.1 6537.0 6574.2 6611.6 6619.8 6651.4 6413.1 6475.1 6503.8 6505.3 6509.7 16:06:48 INFO - PID 22968 | 16:06:48 INFO - PID 22968 | [#1] ext.html Cycles:180 Average:37509.79 Median:35918.82 stddev:52822.26 (147.1%) stddev-sans-first:52898.56 16:06:48 INFO - PID 22968 | Values: 809.8 843.9 848.5 849.3 849.6 37878.2 38698.2 41344.6 41414.6 41463.8 39214.8 39322.8 39342.8 39362.0 39485.4 6930.8 7039.7 7044.6 7050.6 7057.9 7553.9 7778.7 7780.3 7786.8 7789.7 7701.0 7723.8 7730.9 7830.6 7830.6 7824.2 7856.1 7862.8 7866.1 7873.9 7630.7 7679.2 7701.3 7716.2 7749.6 38349.2 38536.0 38543.2 38725.8 38744.4 3430.3 3456.8 3457.3 3457.4 3460.1 31826.0 32068.0 32071.2 32092.4 32162.4 5192.8 5209.2 5260.1 5274.6 5286.7 198287.0 198697.0 199491.0 199636.0 199972.0 48773.8 49105.0 49249.5 49270.3 49364.5 44484.8 45364.5 45440.0 51697.7 52854.4 14107.9 14168.0 14214.1 14233.4 14246.1 11375.0 11382.4 11384.6 11386.0 11408.7 14172.6 14280.6 14320.3 14435.6 14494.0 5676.5 5711.4 5755.8 5803.7 5932.6 993.2 1002.3 1006.1 1009.2 1028.4 22415.3 22427.2 22517.5 22707.5 22822.2 1079.4 1094.8 1105.1 1105.6 1115.5 11859.9 11869.6 11948.9 11976.3 12005.2 221379.0 223083.0 224849.0 225072.0 225325.0 54147.2 54264.7 54298.2 54299.7 54517.7 1402.4 1442.3 1447.7 1466.1 1470.0 22369.0 22533.7 22798.7 22944.8 23152.3 38474.2 38525.6 38551.6 38568.0 38574.4 184171.0 186594.0 186817.0 187878.0 188140.0 34300.5 35044.6 36793.0 37303.4 37375.0 44973.0 45847.0 46117.0 46224.3 46354.3 33796.2 34054.1 34164.8 34338.8 34406.3 33574.3 33710.8 33922.0 34177.0 34796.7 38151.0 38593.0 38748.0 38757.6 38774.6 32537.8 32812.5 32928.7 33221.7 33561.3 23613.3 24001.9 24246.2 24768.8 25228.6 16:06:48 INFO - PID 22968 | 16:06:48 INFO - PID 22968 | [#2] jquery.html Cycles:180 Average:34532.43 Median:21688.51 stddev:80569.59 (371.5%) stddev-sans-first:80755.21 16:06:48 INFO - PID 22968 | Values: 553.6 566.9 571.9 576.9 582.1 21681.8 22226.6 22448.0 22472.7 22485.9 23212.2 24055.4 24095.4 24132.9 24594.9 6339.2 6441.1 6473.9 6488.1 6494.6 6308.7 6321.5 6417.0 6588.9 6619.7 6573.9 6580.7 6582.9 6587.6 6588.0 6587.9 6588.9 6591.3 6852.9 7160.5 7014.5 7023.9 7025.1 7036.4 7043.9 29490.7 30026.5 30066.7 30087.0 30090.2 2044.8 2066.0 2070.4 2071.7 2074.7 19052.9 19097.1 19779.5 19928.8 19931.0 2447.2 2456.6 2532.1 2569.4 2571.4 118729.0 124695.0 132055.3 135788.0 137035.0 19410.0 19953.2 21007.7 21275.4 21498.9 40507.0 40755.8 40763.8 40847.6 40896.6 10284.5 10284.9 10436.5 10466.6 10569.3 8590.0 8658.6 8688.4 8715.4 8818.2 10611.3 10861.2 11001.0 11133.8 11179.3 4063.6 4141.8 4217.4 4238.9 4250.1 939.3 957.2 961.9 963.9 976.7 18455.7 18741.7 18917.6 19029.2 19364.9 992.3 1001.8 1003.0 1009.9 1020.2 10172.7 10251.6 10424.3 10510.2 10558.6 476117.0 477523.0 482850.0 486373.0 488178.0 99705.0 101414.0 101427.0 104095.5 104115.0 998.4 1138.3 1141.7 1142.9 1149.2 19392.4 19432.4 19702.0 19732.6 19815.5 50804.7 51644.7 53027.7 54017.5 55006.7 65979.3 66894.0 67171.3 67212.3 67700.0 18421.5 18705.4 18920.8 19009.3 19014.3 21370.9 21581.1 21673.0 21695.2 21779.7 16157.2 16320.8 16400.9 17478.5 17807.2 14752.6 15080.1 15857.4 16020.5 16266.5 17970.2 18053.8 18141.3 18213.8 18256.4 18713.0 18766.2 18795.5 18879.8 18913.8 17437.6 17601.2 17708.6 17710.8 17735.6 16:06:48 INFO - PID 22968 | 16:06:48 INFO - PID 22968 | [#3] mootools.html Cycles:180 Average:9147.67 Median:2649.14 stddev:6776.12 (255.8%) stddev-sans-first:6769.45 16:06:48 INFO - PID 22968 | Values: 1295.1 1381.6 1392.9 1400.1 1403.1 14860.3 15454.3 15461.2 15493.6 15511.8 15240.9 15309.5 15348.9 15354.4 15380.1 2613.6 2635.8 2668.8 2681.4 2684.0 2576.0 2622.3 2634.2 2637.4 2648.4 2546.8 2640.2 2647.0 2649.9 2750.9 2686.2 2714.0 2714.4 2716.2 2716.3 2656.4 2687.0 2691.2 2693.4 2693.8 15099.3 15180.5 15238.7 15257.8 15286.0 7542.4 7794.6 7798.4 7803.5 7813.8 4915.2 4999.8 5170.2 5177.4 5190.4 1869.5 1945.3 1957.7 1978.9 1981.8 26297.7 26839.0 27158.9 27863.9 27929.2 6542.5 6564.4 6639.3 6761.0 6775.9 17042.3 17130.6 17205.4 17643.3 17658.8 7269.5 7474.6 7476.9 7481.2 7482.3 6903.9 6939.4 6958.4 7003.9 7008.1 5049.4 5176.7 5177.8 5181.9 5211.5 1461.6 1464.3 1475.7 1480.8 1490.1 771.1 796.4 798.9 799.4 811.7 7217.0 7234.7 7248.1 7314.6 7330.6 663.9 669.4 683.2 687.5 694.5 4163.9 4734.3 4761.0 4896.9 4948.0 20751.9 21013.5 21163.0 21174.3 21627.1 20178.3 21528.2 21670.0 21744.5 21748.8 10034.3 10061.3 10074.3 10107.4 10114.4 7710.5 8046.7 8104.2 8161.0 8250.5 18215.4 18962.9 19110.4 19193.2 19299.1 18662.3 19304.2 19657.6 19668.1 19723.8 10837.8 10868.0 10942.2 10949.4 10974.5 13543.6 13735.4 13753.4 13772.6 13775.4 10985.8 11052.0 11106.3 11181.9 11322.8 10797.3 10888.5 11012.3 11063.9 11269.2 9025.1 9202.8 9212.6 9226.6 9234.4 6418.6 6421.9 6442.0 6462.2 6528.9 6672.1 6829.2 6853.6 6901.3 6914.9 16:06:48 INFO - PID 22968 | 16:06:48 INFO - PID 22968 | [#4] prototype.html Cycles:180 Average:5394.02 Median:6101.40 stddev:1500.84 (24.6%) stddev-sans-first:1459.24 16:06:48 INFO - PID 22968 | Values: 491.4 493.2 518.3 526.6 527.4 6112.3 6171.0 6187.6 6266.3 6273.9 6144.3 6167.8 6180.7 6214.7 6219.6 5131.3 5140.8 5154.0 5162.7 5199.9 4817.0 4943.5 5093.2 5129.8 5147.8 4891.7 4909.8 4922.5 4933.6 4946.1 4896.5 4924.9 4947.6 4954.6 4957.6 4316.0 4406.5 4411.4 4411.8 4434.3 6018.7 6044.5 6079.5 6083.7 6090.5 5573.0 5607.0 5626.0 5637.5 5649.5 6455.5 6465.9 6466.5 6470.7 6480.3 4579.2 4776.2 4790.6 4814.0 4820.9 6518.5 6588.4 6633.2 6641.7 6714.9 4834.2 4849.3 4855.8 4877.6 4885.9 4919.3 4920.4 4937.3 4939.4 4968.7 5513.2 5570.4 5573.5 5587.8 5597.2 6517.3 6533.6 6536.3 6539.5 6548.5 1698.4 1714.4 1714.6 1722.5 1726.6 1113.1 1161.7 1170.8 1186.0 1196.7 5565.6 5566.2 5584.2 5589.5 5607.9 6452.2 6464.3 6502.9 6513.3 6585.6 5589.6 5606.7 5613.3 5630.8 5640.7 3449.4 3475.3 3477.4 3478.2 3513.9 6234.5 6268.8 6273.7 6291.2 6305.3 6655.6 6692.2 6707.3 6732.6 6790.9 6190.1 6197.6 6224.8 6239.2 6322.4 6474.3 6555.4 6612.7 6615.9 6622.9 5941.6 6446.9 6514.3 6522.9 6580.5 6207.4 6278.9 6296.2 6299.8 6308.5 4883.5 4885.2 4901.5 4909.2 4924.5 6328.8 6422.6 6451.6 6642.9 6695.6 6296.7 6324.4 6364.4 6436.7 6459.5 6267.3 6269.6 6348.7 6369.1 6378.2 6122.3 6218.5 6254.3 6256.8 6298.6 6181.2 6288.4 6297.2 6355.3 6373.6 6166.4 6195.6 6237.2 6254.7 6335.8 16:06:48 INFO - PID 22968 | 16:06:48 INFO - PID 22968 | [#5] yui.html Cycles:180 Average:23155.85 Median:31797.02 stddev:34430.18 (108.3%) stddev-sans-first:34486.02 16:06:48 INFO - PID 22968 | Values: 846.5 867.1 867.2 895.6 907.7 14626.5 14878.8 14909.2 14922.9 14927.8 16022.3 16508.1 16527.9 16551.8 16574.0 951.9 966.4 967.0 968.1 969.9 964.9 968.4 969.0 972.2 972.2 958.8 1001.3 1005.9 1006.1 1006.4 998.1 999.1 1000.5 1000.6 1001.1 718.7 739.2 743.9 744.5 744.8 15793.4 15856.8 15913.5 15955.5 15983.3 20484.3 20539.6 21000.4 21056.0 21191.4 15652.8 15881.4 15972.3 16001.5 16122.3 3668.1 3702.8 3705.5 3705.9 3706.9 105362.5 124474.0 137469.3 138002.0 139252.0 17323.3 17961.1 17987.8 18045.5 18072.9 31620.2 31973.8 31976.8 32032.2 32101.8 8199.5 8357.7 8381.0 8408.5 8411.0 3725.1 3837.3 3842.8 3850.4 3859.8 5374.8 5466.5 5482.9 5485.9 5521.1 1024.2 1044.6 1046.5 1051.7 1053.6 639.7 657.4 675.0 676.4 680.7 11024.0 11231.4 11255.0 11526.0 11592.0 652.2 654.2 670.7 676.7 678.1 5106.7 5133.2 5213.5 5248.0 5326.4 120250.0 120633.0 123846.4 124041.4 124941.0 101537.0 105211.0 107405.0 108534.5 108767.0 92438.5 94959.0 96006.0 96256.0 97245.0 9676.0 9717.3 9773.0 9846.3 9931.7 42841.0 42924.8 44396.0 44837.0 45394.5 55125.0 55357.0 56882.0 56961.4 57408.7 15246.8 15246.9 15293.8 15315.4 15353.7 14689.2 14696.3 14725.9 14849.1 14857.1 12674.5 12752.7 12774.7 12846.0 12860.4 14007.0 14111.2 14236.5 14250.9 14356.4 13842.0 14053.8 14124.6 14161.9 14177.0 9977.0 9999.2 10049.7 10138.4 10294.2 9203.7 9230.3 9253.3 9375.0 9422.7 16:06:48 INFO - PID 22968 | -------- Summary: end -------- 16:06:48 INFO - PID 22968 | 16:06:49 INFO - TEST-INFO | 22968: exit 0 16:06:49 INFO - TEST-OK | dromaeo_css | took 1108601ms 16:06:49 INFO - TEST-START | kraken 16:06:49 INFO - Initialising browser for kraken test... 16:06:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59431/getInfo.html -profile /tmp/tmpo0dDk1/profile 16:06:49 INFO - TEST-INFO | started process 23348 (/builds/slave/test/build/application/firefox/firefox http://localhost:59431/getInfo.html) 16:06:55 INFO - TEST-INFO | 23348: exit 0 16:06:55 INFO - Browser initialized. 16:06:55 INFO - Running cycle 1/1 for kraken test... 16:06:55 INFO - Using env: {'DISPLAY': ':0', 16:06:55 INFO - 'HOME': '/home/cltbld', 16:06:55 INFO - 'JSGC_DISABLE_POISONING': '1', 16:06:55 INFO - 'LANG': 'en_US.UTF-8', 16:06:55 INFO - 'LANGUAGE': 'en_US:en', 16:06:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:06:55 INFO - 'LOGNAME': 'cltbld', 16:06:55 INFO - 'MAIL': '/var/mail/cltbld', 16:06:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:06:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:06:55 INFO - 'MOZ_CRASHREPORTER': '1', 16:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:06:55 INFO - 'MOZ_NO_REMOTE': '1', 16:06:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:55 INFO - 'NO_EM_RESTART': '1', 16:06:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:55 INFO - 'PWD': '/builds/slave/test', 16:06:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:06:55 INFO - 'RUST_BACKTRACE': 'full', 16:06:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:06:55 INFO - 'SHELL': '/bin/bash', 16:06:55 INFO - 'SHLVL': '1', 16:06:55 INFO - 'TERM': 'linux', 16:06:55 INFO - 'TMOUT': '86400', 16:06:55 INFO - 'USER': 'cltbld', 16:06:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986', 16:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:55 INFO - '_': '/tools/buildbot/bin/python'} 16:06:55 INFO - TEST-INFO | started process 23549 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo0dDk1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:06:56 INFO - PID 23549 | 16:06:56 INFO - PID 23549 | (/builds/slave/test/build/application/firefox/firefox:23600): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:06:56 INFO - PID 23549 | 16:07:06 INFO - PID 23549 | RSS: Main: 167317504 16:07:06 INFO - PID 23549 | 16:07:09 INFO - PID 23549 | Cycle 1(1): loaded http://localhost:59431/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59431/tests/kraken/driver.html?testName=audio-beat-detection) 16:07:10 INFO - PID 23549 | RSS: Main: 172298240 16:07:10 INFO - PID 23549 | 16:07:13 INFO - PID 23549 | Cycle 1(1): loaded http://localhost:59431/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59431/tests/kraken/driver.html?testName=audio-dft) 16:07:13 INFO - PID 23549 | RSS: Main: 172601344 16:07:13 INFO - PID 23549 | 16:07:16 INFO - PID 23549 | Cycle 1(1): loaded http://localhost:59431/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59431/tests/kraken/driver.html?testName=audio-fft) 16:07:17 INFO - PID 23549 | RSS: Main: 168783872 16:07:17 INFO - PID 23549 | 16:07:19 INFO - PID 23549 | Cycle 1(1): loaded http://localhost:59431/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59431/tests/kraken/driver.html?testName=audio-oscillator) 16:07:20 INFO - PID 23549 | RSS: Main: 169209856 16:07:20 INFO - PID 23549 | 16:07:22 INFO - PID 23549 | Cycle 1(1): loaded http://localhost:59431/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59431/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:07:22 INFO - PID 23549 | RSS: Main: 169340928 16:07:22 INFO - PID 23549 | 16:07:26 INFO - PID 23549 | Cycle 1(1): loaded http://localhost:59431/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59431/tests/kraken/driver.html?testName=imaging-darkroom) 16:07:26 INFO - PID 23549 | RSS: Main: 171823104 16:07:26 INFO - PID 23549 | 16:07:30 INFO - PID 23549 | Cycle 1(1): loaded http://localhost:59431/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59431/tests/kraken/driver.html?testName=imaging-desaturate) 16:07:31 INFO - PID 23549 | RSS: Main: 171884544 16:07:31 INFO - PID 23549 | 16:07:34 INFO - PID 23549 | Cycle 1(1): loaded http://localhost:59431/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59431/tests/kraken/driver.html?testName=json-parse-financial) 16:07:34 INFO - PID 23549 | RSS: Main: 173051904 16:07:34 INFO - PID 23549 | 16:07:36 INFO - PID 23549 | Cycle 1(1): loaded http://localhost:59431/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59431/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:07:36 INFO - PID 23549 | RSS: Main: 172957696 16:07:36 INFO - PID 23549 | 16:07:38 INFO - PID 23549 | Cycle 1(1): loaded http://localhost:59431/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59431/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:07:39 INFO - PID 23549 | RSS: Main: 172716032 16:07:39 INFO - PID 23549 | 16:07:41 INFO - PID 23549 | Cycle 1(1): loaded http://localhost:59431/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59431/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:07:42 INFO - PID 23549 | RSS: Main: 172711936 16:07:42 INFO - PID 23549 | 16:07:44 INFO - PID 23549 | Cycle 1(1): loaded http://localhost:59431/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:07:45 INFO - PID 23549 | RSS: Main: 173727744 16:07:45 INFO - PID 23549 | 16:07:48 INFO - PID 23549 | Cycle 1(1): loaded http://localhost:59431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:07:48 INFO - PID 23549 | RSS: Main: 173916160 16:07:48 INFO - PID 23549 | 16:07:50 INFO - PID 23549 | Cycle 1(1): loaded http://localhost:59431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59431/tests/kraken/driver.html?testName=ai-astar) 16:07:51 INFO - PID 23549 | RSS: Main: 175071232 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | __start_tp_report 16:07:51 INFO - PID 23549 | _x_x_mozilla_page_load 16:07:51 INFO - PID 23549 | _x_x_mozilla_page_load_details 16:07:51 INFO - PID 23549 | |i|pagename|runs| 16:07:51 INFO - PID 23549 | |0;ai-astar;110;108;107;108;109;109;109;109;107;107 16:07:51 INFO - PID 23549 | |1;audio-beat-detection;118;118;116;117;122;120;116;117;117;116 16:07:51 INFO - PID 23549 | |2;audio-dft;163;161;163;163;162;163;165;169;165;167 16:07:51 INFO - PID 23549 | |3;audio-fft;73;73;73;76;74;74;73;75;74;76 16:07:51 INFO - PID 23549 | |4;audio-oscillator;79;79;83;78;79;79;79;80;80;79 16:07:51 INFO - PID 23549 | |5;imaging-gaussian-blur;113;114;114;114;115;114;114;113;114;117 16:07:51 INFO - PID 23549 | |6;imaging-darkroom;157;151;150;148;148;148;149;151;149;149 16:07:51 INFO - PID 23549 | |7;imaging-desaturate;100;93;94;94;93;94;94;94;94;95 16:07:51 INFO - PID 23549 | |8;json-parse-financial;55;54;56;54;55;54;55;56;54;55 16:07:51 INFO - PID 23549 | |9;json-stringify-tinderbox;37;37;37;37;38;37;37;37;38;37 16:07:51 INFO - PID 23549 | |10;stanford-crypto-aes;80;76;75;76;76;78;73;74;76;78 16:07:51 INFO - PID 23549 | |11;stanford-crypto-ccm;118;112;119;115;120;118;114;125;111;110 16:07:51 INFO - PID 23549 | |12;stanford-crypto-pbkdf2;181;176;167;181;168;170;169;168;168;174 16:07:51 INFO - PID 23549 | |13;stanford-crypto-sha256-iterative;64;79;64;77;70;67;64;68;66;66 16:07:51 INFO - PID 23549 | __end_tp_report 16:07:51 INFO - PID 23549 | __start_cc_report 16:07:51 INFO - PID 23549 | _x_x_mozilla_cycle_collect,916 16:07:51 INFO - PID 23549 | __end_cc_report 16:07:51 INFO - PID 23549 | __startTimestamp1505171271029__endTimestamp 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | ------- Summary: start ------- 16:07:51 INFO - PID 23549 | Number of tests: 14 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | [#0] ai-astar Cycles:10 Average:108.30 Median:109.00 stddev:1.06 (1.0%) stddev-sans-first:0.93 16:07:51 INFO - PID 23549 | Values: 110.0 108.0 107.0 108.0 109.0 109.0 109.0 109.0 107.0 107.0 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | [#1] audio-beat-detection Cycles:10 Average:117.70 Median:117.50 stddev:1.95 (1.7%) stddev-sans-first:2.06 16:07:51 INFO - PID 23549 | Values: 118.0 118.0 116.0 117.0 122.0 120.0 116.0 117.0 117.0 116.0 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.42 (1.5%) stddev-sans-first:2.54 16:07:51 INFO - PID 23549 | Values: 163.0 161.0 163.0 163.0 162.0 163.0 165.0 169.0 165.0 167.0 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | [#3] audio-fft Cycles:10 Average:74.10 Median:74.00 stddev:1.20 (1.6%) stddev-sans-first:1.20 16:07:51 INFO - PID 23549 | Values: 73.0 73.0 73.0 76.0 74.0 74.0 73.0 75.0 74.0 76.0 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:79.00 stddev:1.35 (1.7%) stddev-sans-first:1.42 16:07:51 INFO - PID 23549 | Values: 79.0 79.0 83.0 78.0 79.0 79.0 79.0 80.0 80.0 79.0 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:1.14 (1.0%) stddev-sans-first:1.12 16:07:51 INFO - PID 23549 | Values: 113.0 114.0 114.0 114.0 115.0 114.0 114.0 113.0 114.0 117.0 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:149.50 stddev:2.71 (1.8%) stddev-sans-first:1.20 16:07:51 INFO - PID 23549 | Values: 157.0 151.0 150.0 148.0 148.0 148.0 149.0 151.0 149.0 149.0 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:2.01 (2.1%) stddev-sans-first:0.60 16:07:51 INFO - PID 23549 | Values: 100.0 93.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 95.0 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:0.79 (1.4%) stddev-sans-first:0.83 16:07:51 INFO - PID 23549 | Values: 55.0 54.0 56.0 54.0 55.0 54.0 55.0 56.0 54.0 55.0 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | [#9] json-stringify-tinderbox Cycles:10 Average:37.20 Median:37.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 16:07:51 INFO - PID 23549 | Values: 37.0 37.0 37.0 37.0 38.0 37.0 37.0 37.0 38.0 37.0 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:2.04 (2.7%) stddev-sans-first:1.64 16:07:51 INFO - PID 23549 | Values: 80.0 76.0 75.0 76.0 76.0 78.0 73.0 74.0 76.0 78.0 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:118.00 stddev:4.66 (4.0%) stddev-sans-first:4.90 16:07:51 INFO - PID 23549 | Values: 118.0 112.0 119.0 115.0 120.0 118.0 114.0 125.0 111.0 110.0 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:172.00 stddev:5.45 (3.2%) stddev-sans-first:4.76 16:07:51 INFO - PID 23549 | Values: 181.0 176.0 167.0 181.0 168.0 170.0 169.0 168.0 168.0 174.0 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:67.50 stddev:5.38 (8.0%) stddev-sans-first:5.45 16:07:51 INFO - PID 23549 | Values: 64.0 79.0 64.0 77.0 70.0 67.0 64.0 68.0 66.0 66.0 16:07:51 INFO - PID 23549 | -------- Summary: end -------- 16:07:51 INFO - PID 23549 | 16:07:51 INFO - PID 23549 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:07:51 INFO - TEST-INFO | 23549: exit 0 16:07:51 INFO - TEST-OK | kraken | took 62317ms 16:07:51 INFO - SUITE-END | took 1170s 16:07:52 INFO - Completed test suite (00:19:31) 16:07:52 INFO - javascript benchmark 16:07:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8375.2730910522, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3110.253539150604, 3141.32461520773, 3142.5129104988705, 3147.0716138739076, 3151.810891346518, 6097.0, 6192.659403732793, 6246.5315101367405, 6278.30938596754, 6333.271673757525, 6185.41238582334, 6227.532935029868, 6234.906476402846, 6249.53128515362, 6255.530835187356, 5726.226959360475, 5758.337791154008, 5762.250907382035, 5793.159991801186, 5802.680852553108, 5716.828495145152, 5745.770169193227, 5747.971260143693, 5752.539796816244, 5839.708014599274, 5778.757567123068, 5851.356350801409, 5853.268341457318, 5856.912146317787, 5867.735951882154, 908.3367313938618, 5683.687397193153, 5694.060480020791, 5846.532277417797, 5893.351731309553, 5682.7442765075675, 5734.053881109612, 5799.4780469757925, 5815.505682017034, 5819.67991760453, 6273.717682704244, 6285.842853928689, 6314.242290925073, 6334.873302533923, 6352.968235158841, 6726.93273067268, 6727.9327206728285, 6728.3271672832325, 6810.353016463428, 6826.658667066677, 6787.490938179656, 6791.796246112575, 6882.449404047664, 6890.0, 6892.035115083892, 6104.786332478387, 6226.968865155691, 6252.3435039320675, 6321.589096708699, 6342.1121043053545, 6998.510104292753, 7005.404540614003, 7013.964930175316, 7023.508354415244, 7052.2595127511895, 6591.868162636721, 6623.867522649616, 6686.598804071674, 6702.162229721285, 6722.764703235363, 6710.463162946952, 6734.595924244561, 6748.932510674928, 6819.0, 6831.931680683229, 6483.643399612973, 6527.34726527353, 6577.276499585042, 6589.76935807254, 6651.567648102858, 6744.730210791611, 6773.0, 6789.083473730983, 6796.558223715443, 6802.727890884408, 5238.109521381374, 5254.15933450646, 5255.159174532057, 5327.934413117392, 5328.813491527778, 4546.931796023062, 4584.908301833944, 4631.606313463393, 4649.442066951988, 4654.325122857167, 5714.628549144375, 5720.170575266647, 5780.219670344533, 5788.3343415506915, 5802.912956305659, 6779.898301525481, 6825.726970921207, 6838.794836154923, 6865.519413641097, 6882.518223724392, 5750.7987220447085, 5757.827265182052, 5832.3292821326095, 5838.065909454467, 5846.561507886926, 5641.548676105984, 5773.740181691834, 5784.479396854304, 5852.648841069465, 5853.619514731528, 6418.0, 6484.092227088211, 6510.739570417225, 6511.902321465182, 6512.544121911421, 6594.967025164748, 6662.866742665216, 6687.966560167168, 6712.39588437043, 6877.312268773083, 6366.427021568081, 6392.105105285171, 6468.579542329733, 6499.122618446449, 6499.285078641251, 6428.164338635947, 6515.576487528296, 6613.27254002069, 6698.22970358415, 6724.125863637696, 6693.866122677617, 6780.660966951534, 6780.762673306411, 6784.151981002375, 6786.694598743167, 6549.770758023446, 6566.573172743756, 6634.137562116894, 6662.433693135944, 6663.033860090357, 6537.607743535403, 6543.770968016097, 6610.07458955737, 6616.669166541557, 6643.169603799525, 6350.555461117678, 6463.967680161757, 6481.995290729945, 6562.737490500517, 6565.113709649137, 6536.967315163393, 6574.178227721535, 6611.570247933869, 6619.834504137435, 6651.401373876374, 6413.0701048348665, 6475.093486911742, 6503.837404064936, 6505.251896032017, 6509.707063182073], "value": 6099.922882738312, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [809.821839195377, 843.8523258429773, 848.4909054567256, 849.252657661258, 849.5921957460419, 37878.24243515128, 38698.226035479274, 41344.58655413449, 41414.58585414145, 41463.79268103655, 39214.8039259804, 39322.80338598303, 39342.8032859836, 39362.0, 39485.40771888424, 6930.826729331782, 7039.718411263543, 7044.577325360495, 7050.6122163281, 7057.89413158803, 7553.924460755377, 7778.727744528943, 7780.299773020427, 7786.7663970080985, 7789.688412463523, 7700.961495192516, 7723.806904827368, 7730.922690773076, 7830.56931868747, 7830.647620857047, 7824.217578242159, 7856.057273127204, 7862.764117076468, 7866.056073271216, 7873.858290547839, 7630.732924347677, 7679.232076792276, 7701.3453856422275, 7716.151223365426, 7749.612519374009, 38349.23301533954, 38536.0, 38543.22913541713, 38725.80637096796, 38744.418833717515, 3430.2967891582416, 3456.7580269381156, 3457.3258214648154, 3457.3776720190353, 3460.0657822388066, 31826.0, 32068.0, 32071.198220044687, 32092.358152836812, 32162.356752864813, 5192.844214673566, 5209.2446595243855, 5260.079486089919, 5274.55166310864, 5286.709230992294, 198287.0, 198697.0, 199491.0, 199636.0, 199972.00013999981, 48773.75613121912, 49105.0, 49249.50750492449, 49270.31931966457, 49364.50635493671, 44484.77757611256, 45364.546354536695, 45440.0, 51697.7415112922, 52854.414367569036, 14107.929460352838, 14168.0, 14214.076085054437, 14233.430662773373, 14246.145231286157, 11374.976252137347, 11382.430878456044, 11384.601538946263, 11386.032187264009, 11408.714782130348, 14172.645683857985, 14280.642983925485, 14320.283985800668, 14435.566932992027, 14494.0, 5676.517496012885, 5711.371749107595, 5755.827325180251, 5803.738831752581, 5932.584719069624, 993.2103977338033, 1002.2783595811004, 1006.0894890124449, 1009.2077718990557, 1028.3726926574784, 22415.32754017382, 22427.21504747326, 22517.549649006927, 22707.545849082926, 22822.20122295745, 1079.4171147580219, 1094.8412480190486, 1105.0938230650788, 1105.6406667832987, 1115.5036008975928, 11859.908201955732, 11869.5845645402, 11948.880511194777, 11976.28142311464, 12005.219660722025, 221379.0, 223083.0, 224849.0, 225072.0, 225325.0, 54147.18779218315, 54264.72867635637, 54298.18552721712, 54299.72850135724, 54517.72741136269, 1402.3689339797131, 1442.2860683961296, 1447.7249322628877, 1466.0690461556987, 1470.029780344967, 22369.0, 22533.66199506976, 22798.65802012938, 22944.770552294263, 23152.305430837103, 38474.230515390096, 38525.61474385332, 38551.6144838548, 38568.0, 38574.42138367871, 184171.0, 186594.0, 186817.0, 187878.0, 188140.0, 34300.48549271713, 35044.64955350414, 36793.0, 37303.44044839275, 37375.0, 44973.0, 45847.0, 46117.0, 46224.30663540117, 46354.30468543042, 33796.15509612279, 34054.14864628404, 34164.82917585396, 34338.82830585831, 34406.31187376288, 33574.32851342911, 33710.83144584359, 33922.0, 34177.0, 34796.65203348036, 38151.0, 38593.0, 38748.0, 38757.6124238754, 38774.61225387823, 32537.83731081424, 32812.50781238331, 32928.67071329352, 33221.667783322824, 33561.328773423906, 23613.29160125199, 24001.879990599937, 24246.151384702156, 24768.752312476645, 25228.62157067609], "value": 17104.727110756558, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.6041730162933, 566.9376368599455, 571.9342275638301, 576.942305769423, 582.1180910919956, 21681.783182168172, 22226.555468890612, 22448.0, 22472.662910056362, 22485.887570562165, 23212.187573434934, 24055.39861503463, 24095.39761505963, 24132.8793356033, 24594.877025614845, 6339.239291285052, 6441.066045423411, 6473.902891456632, 6488.124103246048, 6494.577852439576, 6308.653024083674, 6321.46267567255, 6417.0, 6588.868222635544, 6619.669016549177, 6573.868522629545, 6580.736770529197, 6582.901256481156, 6587.571807832475, 6587.967060164692, 6587.901181482282, 6588.901166482507, 6591.307912669196, 6852.862942741117, 7160.462965277573, 7014.473914456436, 7023.92976070243, 7025.051618031552, 7036.366726994595, 7043.92956070443, 29490.70509294901, 30026.549601755993, 30066.699333006607, 30087.0, 30090.24774380636, 2044.7852975437513, 2065.989670051655, 2070.4099331690545, 2071.6996035574757, 2074.6576814825535, 19052.90473547637, 19097.140628671743, 19779.50551236216, 19928.80071199284, 19931.0, 2447.204658485999, 2456.5946618807875, 2532.126416386344, 2569.40903592173, 2571.4085760275057, 118729.0, 124695.0, 132055.33972330077, 135788.0, 137034.999999999, 19409.95341211295, 19953.201871925252, 21007.684884726743, 21275.36173914785, 21498.892505537373, 40507.0, 40755.7962210187, 40763.79618101891, 40847.59152408497, 40896.59103408928, 10284.537195826206, 10284.868664446905, 10436.478176091165, 10466.63366782159, 10569.312994655324, 8589.957050214834, 8658.567071646392, 8688.435251708619, 8715.433496822812, 8818.206361427503, 10611.257211995086, 10861.166780782476, 11001.039899293975, 11133.824815694115, 11179.273347232403, 4063.6342729154517, 4141.751494910315, 4217.40956266123, 4238.894027649272, 4250.107477429774, 939.3096074385321, 957.2485598804905, 961.9086186812242, 963.8698775665196, 976.6874600127891, 18455.723164152547, 18741.7188742169, 18917.62164756697, 19029.238830446626, 19364.903175484033, 992.3400938376044, 1001.7846163074973, 1002.9749256268651, 1009.9092979582034, 1020.1991436722137, 10172.745681358025, 10251.641192558225, 10424.270301079003, 10510.211734119972, 10558.577656893638, 476117.0, 477523.0, 482850.0, 486373.0, 488178.0, 99705.0, 101414.0, 101427.0, 104095.4795226019, 104114.95885041052, 998.4059484606647, 1138.3170097941334, 1141.720278531765, 1142.8628564572139, 1149.2013050929525, 19392.4182274532, 19432.4170274892, 19702.0, 19732.605347893248, 19815.504612384804, 50804.745976269885, 51644.708882278246, 53027.73486132544, 54017.459825401245, 55006.72496637491, 65979.34020659732, 66894.0, 67171.31314747356, 67212.3278767206, 67700.0, 18421.53946151357, 18705.438836834917, 18920.810791892454, 19009.33467328637, 19014.334498292494, 21370.893145534174, 21581.13675452964, 21673.0, 21695.240666576596, 21779.673304900756, 16157.192140393168, 16320.836791632406, 16400.917995409945, 17478.475645730647, 17807.19867605935, 14752.55742327689, 15080.095194288378, 15857.444989425314, 16020.519384418487, 16266.51200463988, 17970.19134138993, 18053.819461805215, 18141.27434902589, 18213.817861821743, 18256.36102736398, 18713.0, 18766.249350025846, 18795.530111747317, 18879.811201887806, 18913.810861891205, 17437.564060898578, 17601.207945642735, 17708.583313334646, 17710.822891771433, 17735.556611084827], "value": 12433.636861425073, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.093434595783, 1381.5786185213512, 1392.853750356212, 1400.0689541454933, 1403.130059363195, 14860.33128509217, 15454.30455629498, 15461.226938653064, 15493.612659683513, 15511.767323490129, 15240.923795381008, 15309.464168754095, 15348.923255383736, 15354.385824567004, 15380.077195368258, 2613.6079588061752, 2635.841849489027, 2668.786497080229, 2681.4368982513697, 2684.033747850772, 2575.974240257592, 2622.2919811650845, 2634.1570697376847, 2637.446136311377, 2648.390870099878, 2546.796256299501, 2640.194740604115, 2647.0470630572977, 2649.8807553660035, 2750.917472475829, 2686.2209959111933, 2714.0229517373728, 2714.3756935904753, 2716.2394529531566, 2716.3480764616547, 2656.4155885705113, 2686.9520886854143, 2691.2060942021953, 2693.4343787804582, 2693.784497240236, 15099.32053057604, 15180.544583662508, 15238.695226095528, 15257.771133433007, 15286.0, 7542.434317426215, 7794.571298578576, 7798.376129909594, 7803.531788092732, 7813.843723125506, 4915.21356582945, 4999.75001249936, 5170.172772356443, 5177.430482646906, 5190.351206099238, 1869.5232715657555, 1945.2608008956647, 1957.6574099532668, 1978.9010549472468, 1981.8414526837819, 26297.73702262972, 26839.0, 27158.864205678845, 27863.86068069667, 27929.162125136278, 6542.476601871934, 6564.409203171737, 6639.336066393322, 6761.019652150509, 6775.932240677629, 17042.31830726782, 17130.571735706708, 17205.397811076553, 17643.29426822913, 17658.82341176572, 7269.454790890704, 7474.5888976106835, 7476.925230747623, 7481.214472480311, 7482.326590606763, 6903.930960690429, 6939.375456208965, 6958.408535274457, 7003.8599228015155, 7008.088948436671, 5049.394072711225, 5176.6635168714665, 5177.767000484987, 5181.948180518147, 5211.452797456288, 1461.6418977350618, 1464.282501574221, 1475.7343678138038, 1480.7704805755125, 1490.1208287110658, 771.1247733822153, 796.3947399976059, 798.8562058829466, 799.3724925933114, 811.6996711216888, 7216.96391518039, 7234.74678386254, 7248.0939882514685, 7314.634268286564, 7330.560166390033, 663.9336066393322, 669.4410167510086, 683.1563019670702, 687.5355492800403, 694.5034300475185, 4163.8959026024595, 4734.28985652148, 4761.0, 4896.853094407174, 4948.0, 20751.8962405187, 21013.47466313324, 21163.0, 21174.258900938392, 21627.134914603554, 20178.27593274889, 21528.246511372028, 21670.0, 21744.456388590414, 21748.782512174676, 10034.347767395242, 10061.346012509164, 10074.294799363974, 10107.39355638664, 10114.443705596115, 7710.4602677814255, 8046.718364857436, 8104.230098140667, 8160.959195203986, 8250.46371985819, 18215.362462313755, 18962.905185473985, 19110.426687199408, 19193.232270709017, 19299.131539081056, 18662.34681786131, 19304.227830886608, 19657.606847863248, 19668.11493482768, 19723.802761972198, 10837.783244335227, 10868.021878031015, 10942.23404361687, 10949.397783122005, 10974.506147223234, 13543.593692188855, 13735.381907814372, 13753.38109785042, 13772.586822395344, 13775.448982040607, 10985.835212471979, 11052.0, 11106.333619982504, 11181.888181118411, 11322.773544528898, 10797.29817561856, 10888.455577221266, 11012.284201526874, 11063.889361106287, 11269.154813389192, 9025.097490250922, 9202.769930751785, 9212.631494740135, 9226.584803683985, 9234.399764015317, 6418.6469744164515, 6421.8715625688155, 6442.0, 6462.224533056064, 6528.934710653023, 6672.132622759011, 6829.2487826338065, 6853.554518956252, 6901.309869013058, 6914.896276555956], "value": 6418.183493217083, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.405292132142, 493.1772257802524, 518.2718280815451, 526.568214064467, 527.3961314295132, 6112.29708583513, 6170.9999999999945, 6187.628742275467, 6266.310705822368, 6273.874522509553, 6144.262688477378, 6167.7841275555365, 6180.660063696495, 6214.65819379934, 6219.595726277788, 5131.307273518065, 5140.845774626749, 5153.969206158765, 5162.716050617215, 5199.870003249911, 4817.0, 4943.505649435064, 5093.159628661267, 5129.794808207667, 5147.794088236466, 4891.657583969123, 4909.772556860785, 4922.507749225085, 4933.555979961803, 4946.134426475371, 4896.485868983759, 4924.852254432355, 4947.604191664658, 4954.628402869799, 4957.628177886673, 4315.978420107911, 4406.515283318832, 4411.448568928884, 4411.845585404495, 4434.334849772527, 6018.699065046774, 6044.516438684895, 6079.483243924272, 6083.726232319556, 6090.512758979271, 5573.015294064763, 5607.046802043662, 5625.971870140664, 5637.49262566371, 5649.4633009864, 6455.4835613150835, 6465.903011454832, 6466.450351720109, 6470.676466176672, 6480.254770701383, 4579.152856721517, 4776.188048031843, 4790.616750659939, 4814.0, 4820.879478013043, 6518.511111666644, 6588.374104460068, 6633.20401551812, 6641.701123449457, 6714.865702685919, 4834.226523756182, 4849.345338379274, 4855.781489832966, 4877.634177436636, 4885.926711099336, 4919.2867034279825, 4920.434150072716, 4937.308776771255, 4939.357883475197, 4968.652194346361, 5513.228148059275, 5570.41510641385, 5573.526250268692, 5587.776488940397, 5597.188407680864, 6517.283098859121, 6533.640649764308, 6536.313687062885, 6539.509536784665, 6548.476121910236, 1698.3631138323128, 1714.3656846966453, 1714.5884987602885, 1722.500474862301, 1726.5597272695381, 1113.1261959361861, 1161.6979585307881, 1170.8419363385833, 1186.0156070461496, 1196.7008247938015, 5565.554755619541, 5566.165075238747, 5584.190292407659, 5589.496945274864, 5607.859803504945, 6452.22573291208, 6464.288928217892, 6502.862738436676, 6513.316101809337, 6585.5719378240265, 5589.580781441408, 5606.6916319602815, 5613.298337707786, 5630.831075067755, 5640.689762063126, 3449.448088305859, 3475.2528206435736, 3477.4088404971217, 3478.2347883465595, 3513.94729079064, 6234.501239900797, 6268.8119356418465, 6273.654948977759, 6291.182146320949, 6305.306416294204, 6655.600663960178, 6692.19693636757, 6707.3292670732535, 6732.562383445061, 6790.93209067903, 6190.133381326618, 6197.566170368031, 6224.844378890473, 6239.159447962771, 6322.430981211805, 6474.320196379501, 6555.3772391622715, 6612.735490580323, 6615.867682646224, 6622.933770662425, 5941.584089113893, 6446.903296450463, 6514.2834288229205, 6522.902156467562, 6580.5064620152725, 6207.410296021871, 6278.937210627835, 6296.212973378328, 6299.842503937438, 6308.526860485574, 4883.487233840396, 4885.218365061573, 4901.485344038824, 4909.1654418748185, 4924.532169443897, 6328.810135695937, 6422.550421470452, 6451.580647257913, 6642.867142657024, 6695.564788288746, 6296.653684047238, 6324.367563243639, 6364.395382438661, 6436.710348034443, 6459.4832413405875, 6267.310595834363, 6269.592476489013, 6348.682565871595, 6369.108324834619, 6378.2346118466085, 6122.265328160471, 6218.533609979179, 6254.343293954252, 6256.8424841404485, 6298.622082675054, 6181.207449839496, 6288.371162883675, 6297.2128483939505, 6355.332690067661, 6373.553851230369, 6166.445019948226, 6195.628262304276, 6237.220347456568, 6254.686515831726, 6335.778247761306], "value": 4951.223813019733, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [846.4794151596767, 867.050579615321, 867.1891781184593, 895.6372669069025, 907.6505545365037, 14626.48807291745, 14878.776818347733, 14909.179995100265, 14922.850771492282, 14927.776083358758, 16022.278997445113, 16508.092054937002, 16527.917360413183, 16551.751723724155, 16574.0, 951.8905325887525, 966.405660518783, 966.9951650241738, 968.0803236924914, 969.883613966325, 964.8504481805331, 968.4431451915177, 969.016448304971, 972.1687956796943, 972.2367941166186, 958.7555173430766, 1001.3241062282966, 1005.9195264378832, 1006.0643601450648, 1006.3659894266602, 998.0817647764075, 999.14073896449, 1000.5147503460815, 1000.604761119361, 1001.0890090018048, 718.7125149940014, 739.1979702023258, 743.8995735575736, 744.5086243079542, 744.7877354953866, 15793.447229347033, 15856.841431585652, 15913.522594322189, 15955.521334359988, 15983.280752366172, 20484.283050093174, 20539.5892082159, 21000.36998890036, 21056.0, 21191.364259072252, 15652.765208521882, 15881.36474541017, 15972.28124734378, 16001.519954401387, 16122.274497647517, 3668.0646435158865, 3702.777833329982, 3705.5182826232417, 3705.925881482382, 3706.870259540903, 105362.47318763434, 124474.0, 137469.31265343708, 138002.0, 139252.0, 17323.307067717404, 17961.101944902963, 17987.820121798875, 18045.458636240935, 18072.90963545174, 31620.209494762355, 31973.840130799195, 31976.840115799274, 32032.199195019846, 32101.839490802395, 8199.508029518249, 8357.749267521984, 8381.0, 8408.495490270481, 8410.957945210357, 3725.068732816796, 3837.270918525471, 3842.8462861485227, 3850.3646898261472, 3859.7877116758846, 5374.838754837361, 5466.508014278734, 5482.91775623366, 5485.862853428696, 5521.061419558685, 1024.2267088348249, 1044.5717255925035, 1046.5029111172132, 1051.7265510967204, 1053.5575058475458, 639.67376637915, 657.4214691071921, 674.9696263668146, 676.4182802789597, 680.6562685843618, 11024.0, 11231.38227397501, 11255.0, 11526.0, 11592.0, 652.2108249018646, 654.1986067067899, 670.7082419147687, 676.7259259999709, 678.1387637700093, 5106.66806657566, 5133.224144129787, 5213.530782229617, 5248.0, 5326.387465441524, 120250.0, 120633.0, 123846.38076809558, 124041.37979310045, 124941.0, 101537.0, 105211.0, 107405.0, 108534.45732771285, 108767.0, 92438.53780731054, 94959.0, 96006.0, 96256.0374396261, 97245.0, 9676.0, 9717.27120465982, 9773.0, 9846.31075824714, 9931.702048938543, 42841.0, 42924.78537607417, 44396.0, 44837.0, 45394.546054540355, 55125.0, 55357.0, 56882.0, 56961.43038569561, 57408.71295643495, 15246.847531524543, 15246.923765381101, 15293.847061529243, 15315.387384504495, 15353.692926141637, 14689.19209443491, 14696.338664760326, 14725.852741472449, 14849.109053456827, 14857.108573485626, 12674.493020279086, 12752.6811829705, 12774.744505110031, 12846.0, 12860.356982151043, 14007.0, 14111.22388268655, 14236.50172244008, 14250.857491424953, 14356.425742970165, 13842.0, 14053.789193162314, 14124.646883827987, 14161.858381416467, 14177.0, 9977.0, 9999.150072243941, 10049.69850904474, 10138.391696498235, 10294.176465882561, 9203.723888283363, 9230.263223465976, 9253.306002049738, 9375.015623359723, 9422.670206542738], "value": 8371.491842719404, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 108.0, 107.0, 108.0, 109.0, 109.0, 109.0, 109.0, 107.0, 107.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 116.0, 117.0, 122.0, 120.0, 116.0, 117.0, 117.0, 116.0], "value": 117.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 163.0, 162.0, 163.0, 165.0, 169.0, 165.0, 167.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 76.0, 74.0, 74.0, 73.0, 75.0, 74.0, 76.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 83.0, 78.0, 79.0, 79.0, 79.0, 80.0, 80.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 117.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 151.0, 150.0, 148.0, 148.0, 148.0, 149.0, 151.0, 149.0, 149.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 56.0, 54.0, 55.0, 54.0, 55.0, 56.0, 54.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 37.0, 38.0, 37.0, 37.0, 37.0, 38.0, 37.0], "value": 37.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 75.0, 76.0, 76.0, 78.0, 73.0, 74.0, 76.0, 78.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 112.0, 119.0, 115.0, 120.0, 118.0, 114.0, 125.0, 111.0, 110.0], "value": 116.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 176.0, 167.0, 181.0, 168.0, 170.0, 169.0, 168.0, 168.0, 174.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 79.0, 64.0, 77.0, 70.0, 67.0, 64.0, 68.0, 66.0, 66.0], "value": 68.5, "unit": "score"}]}]} 16:07:52 INFO - Return code: 0 16:07:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:07:52 INFO - # TBPL SUCCESS # 16:07:52 INFO - Running post-action listener: _package_coverage_data 16:07:52 INFO - Running post-action listener: _resource_record_post_action 16:07:52 INFO - [mozharness: 2017-09-11 23:07:52.275278Z] Finished run-tests step (success) 16:07:52 INFO - Running post-run listener: _resource_record_post_run 16:07:52 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 300580864; Read time: 12; Write time: 214920 16:07:52 INFO - TinderboxPrint: CPU usage
13.1% 16:07:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:07:52 INFO - TinderboxPrint: I/O write bytes / time
300,580,864 / 214,920 16:07:52 INFO - TinderboxPrint: CPU idle
8,228.6 (86.9%) 16:07:52 INFO - TinderboxPrint: CPU user
1,192.0 (12.6%) 16:07:52 INFO - TinderboxPrint: Swap in / out
0 / 0 16:07:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12767232; Read time: 0; Write time: 2328 16:07:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:07:52 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287371264; Read time: 12; Write time: 212548 16:07:52 INFO - Running post-run listener: _upload_blobber_files 16:07:52 INFO - Blob upload gear active. 16:07:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:07:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:07:52 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:07:52 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:07:53 INFO - (blobuploader) - INFO - Open directory for files ... 16:07:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:07:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:07:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:07:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:07:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:07:54 INFO - (blobuploader) - INFO - Done attempting. 16:07:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:07:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:07:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:07:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:07:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:07:55 INFO - (blobuploader) - INFO - Done attempting. 16:07:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:07:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:07:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:08:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:02 INFO - (blobuploader) - INFO - Done attempting. 16:08:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:08:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:08:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:03 INFO - (blobuploader) - INFO - Done attempting. 16:08:03 INFO - (blobuploader) - INFO - Iteration through files over. 16:08:03 INFO - Return code: 0 16:08:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:08:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:08:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1390b35b0d0cdc4610a5a33fa73f2d8efae4c59b084bf1d138be7dcb604e16133ba02bc08f489afcc4f7e69efc2093ace1e7443e09cec0d9cbc992052d9295cb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0396d3c1aa652159544718956df1347da2c2c4b3e95843fda05c71da821a89bb9d417bc62913192a91b3062323f8196d57d341a7c9723b7f2030a4187c02e69", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2fbbce05d213107ecda1b919262736a2094106712867bfbf59ddd2899cd04ac10b74dad77840df26068b6b29d4a430f9ed9c0b8fcada4a4a5fee43ad5839c3d3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72ba0fc1557720f7423da5c46d157e5f5d828cb185ca97e87e54138ef6346068eb4bdcebb216f92f36dfc661e3d54bb2fa535ab302a6a2e7213ddfccea385b3b"} 16:08:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:08:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:08:03 INFO - Contents: 16:08:03 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1390b35b0d0cdc4610a5a33fa73f2d8efae4c59b084bf1d138be7dcb604e16133ba02bc08f489afcc4f7e69efc2093ace1e7443e09cec0d9cbc992052d9295cb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0396d3c1aa652159544718956df1347da2c2c4b3e95843fda05c71da821a89bb9d417bc62913192a91b3062323f8196d57d341a7c9723b7f2030a4187c02e69", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2fbbce05d213107ecda1b919262736a2094106712867bfbf59ddd2899cd04ac10b74dad77840df26068b6b29d4a430f9ed9c0b8fcada4a4a5fee43ad5839c3d3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72ba0fc1557720f7423da5c46d157e5f5d828cb185ca97e87e54138ef6346068eb4bdcebb216f92f36dfc661e3d54bb2fa535ab302a6a2e7213ddfccea385b3b"} 16:08:03 INFO - Running post-run listener: copy_logs_to_upload_dir 16:08:03 INFO - Copying logs to upload dir... 16:08:03 INFO - mkdir: /builds/slave/test/build/upload/logs 16:08:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.612526 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-11 16:08:03.428958) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-11 16:08:03.434044) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986 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-Non-PGO/sha512/1390b35b0d0cdc4610a5a33fa73f2d8efae4c59b084bf1d138be7dcb604e16133ba02bc08f489afcc4f7e69efc2093ace1e7443e09cec0d9cbc992052d9295cb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0396d3c1aa652159544718956df1347da2c2c4b3e95843fda05c71da821a89bb9d417bc62913192a91b3062323f8196d57d341a7c9723b7f2030a4187c02e69", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2fbbce05d213107ecda1b919262736a2094106712867bfbf59ddd2899cd04ac10b74dad77840df26068b6b29d4a430f9ed9c0b8fcada4a4a5fee43ad5839c3d3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72ba0fc1557720f7423da5c46d157e5f5d828cb185ca97e87e54138ef6346068eb4bdcebb216f92f36dfc661e3d54bb2fa535ab302a6a2e7213ddfccea385b3b"} build_url:https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1390b35b0d0cdc4610a5a33fa73f2d8efae4c59b084bf1d138be7dcb604e16133ba02bc08f489afcc4f7e69efc2093ace1e7443e09cec0d9cbc992052d9295cb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0396d3c1aa652159544718956df1347da2c2c4b3e95843fda05c71da821a89bb9d417bc62913192a91b3062323f8196d57d341a7c9723b7f2030a4187c02e69", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2fbbce05d213107ecda1b919262736a2094106712867bfbf59ddd2899cd04ac10b74dad77840df26068b6b29d4a430f9ed9c0b8fcada4a4a5fee43ad5839c3d3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72ba0fc1557720f7423da5c46d157e5f5d828cb185ca97e87e54138ef6346068eb4bdcebb216f92f36dfc661e3d54bb2fa535ab302a6a2e7213ddfccea385b3b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-11 16:08:03.472411) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 16:08:03.472778) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1505166550.74905-1754694986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 16:08:03.552505) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-11 16:08:03.552834) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-11 16:08:03.553185) ========= ========= Total master_lag: 0.25 =========