builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1507940904.4 results: success (0) revision: 4a8c7830ff4822da140890800b401d462695ccc5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-13 17:28:24.396198) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-13 17:28:24.396608) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-13 17:28:24.396879) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-13 17:28:24.419301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-13 17:28:24.419900) ========= 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=826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-13 17:28:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 69.4M=0s 2017-10-13 17:28:24 (69.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103279 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-13 17:28:24.544720) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-13 17:28:24.545030) ========= 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=826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015966 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-13 17:28:24.594961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-13 17:28:24.595288) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4a8c7830ff4822da140890800b401d462695ccc5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4a8c7830ff4822da140890800b401d462695ccc5 --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=826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-13 17:28:24,663 truncating revision to first 12 chars 2017-10-13 17:28:24,663 Setting DEBUG logging. 2017-10-13 17:28:24,663 attempt 1/10 2017-10-13 17:28:24,663 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4a8c7830ff48?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-13 17:28:26,219 unpacking tar archive at: mozilla-beta-4a8c7830ff48/testing/mozharness/ program finished with exit code 0 elapsedTime=1.826319 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-13 17:28:26.440940) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-13 17:28:26.441271) ========= script_repo_revision: 4a8c7830ff4822da140890800b401d462695ccc5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-13 17:28:26.441665) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-13 17:28:26.441926) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-13 17:28:26.456788) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-10-13 17:28:26.457065) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-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', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-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=826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:28:26 INFO - MultiFileLogger online at 20171013 17:28:26 in /builds/slave/test 17:28:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 17:28:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:28:26 INFO - {'append_to_log': False, 17:28:26 INFO - 'base_work_dir': '/builds/slave/test', 17:28:26 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 17:28:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:28:26 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 17:28:26 INFO - 'buildbot_json_path': 'buildprops.json', 17:28:26 INFO - 'code_coverage': False, 17:28:26 INFO - 'config_files': ('talos/linux_config.py',), 17:28:26 INFO - 'default_actions': ('clobber', 17:28:26 INFO - 'read-buildbot-config', 17:28:26 INFO - 'download-and-extract', 17:28:26 INFO - 'populate-webroot', 17:28:26 INFO - 'create-virtualenv', 17:28:26 INFO - 'install', 17:28:26 INFO - 'setup-mitmproxy', 17:28:26 INFO - 'run-tests'), 17:28:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:28:26 INFO - 'disable_ccov_upload': False, 17:28:26 INFO - 'disable_stylo': False, 17:28:26 INFO - 'download_minidump_stackwalk': True, 17:28:26 INFO - 'download_symbols': 'ondemand', 17:28:26 INFO - 'enable_stylo': False, 17:28:26 INFO - 'enable_webrender': False, 17:28:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:28:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:28:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:28:26 INFO - 'gecko_profile': False, 17:28:26 INFO - 'gecko_profile_interval': 0, 17:28:26 INFO - 'installer_path': 'installer.exe', 17:28:26 INFO - 'log_level': 'info', 17:28:26 INFO - 'log_name': 'talos', 17:28:26 INFO - 'log_to_console': True, 17:28:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:28:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:28:26 INFO - 'opt_config_files': (), 17:28:26 INFO - 'pip_index': False, 17:28:26 INFO - 'suite': 'dromaeojs-e10s', 17:28:26 INFO - 'system_bits': '32', 17:28:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:28:26 INFO - 'title': 'talos-linux64-ix-052', 17:28:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:28:26 INFO - 'use_talos_json': True, 17:28:26 INFO - 'verify': 'False', 17:28:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:28:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:28:26 INFO - 'work_dir': 'build'} 17:28:26 INFO - [mozharness: 2017-10-14 00:28:26.660707Z] Running clobber step. 17:28:26 INFO - Running pre-action listener: _resource_record_pre_action 17:28:26 INFO - Running main action method: clobber 17:28:26 INFO - rmtree: /builds/slave/test/build 17:28:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:28:27 INFO - Running post-action listener: _resource_record_post_action 17:28:27 INFO - [mozharness: 2017-10-14 00:28:27.706843Z] Finished clobber step (success) 17:28:27 INFO - [mozharness: 2017-10-14 00:28:27.706940Z] Running read-buildbot-config step. 17:28:27 INFO - Running pre-action listener: _resource_record_pre_action 17:28:27 INFO - Running main action method: read_buildbot_config 17:28:27 INFO - Using buildbot properties: 17:28:27 INFO - { 17:28:27 INFO - "project": "", 17:28:27 INFO - "product": "firefox", 17:28:27 INFO - "who": "ryanvm@gmail.com", 17:28:27 INFO - "installer_path": "public/build/target.tar.bz2", 17:28:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 17:28:27 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 17:28:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 17:28:27 INFO - "stage_platform": "linux64", 17:28:27 INFO - "basedir": "/builds/slave/test", 17:28:27 INFO - "buildnumber": 141, 17:28:27 INFO - "platform": "ubuntu64_hw", 17:28:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:28:27 INFO - "slavebuilddir": "test", 17:28:27 INFO - "taskId": "e893camZRaaO95hNcHJa2A", 17:28:27 INFO - "branch": "mozilla-beta", 17:28:27 INFO - "script_repo_revision": "production", 17:28:27 INFO - "revision": "4a8c7830ff4822da140890800b401d462695ccc5", 17:28:27 INFO - "slavename": "talos-linux64-ix-052", 17:28:27 INFO - "repo_path": "releases/mozilla-beta" 17:28:27 INFO - } 17:28:27 INFO - Finding installer, test and symbols from parent task. 17:28:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e893camZRaaO95hNcHJa2A'}, attempt #1 17:28:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e893camZRaaO95hNcHJa2A'}, attempt #1 17:28:28 INFO - Task dependencies: JyY7kw_hTTa3nrQVjxLbHg 17:28:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg'}, attempt #1 17:28:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.tar.bz2 17:28:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.test_packages.json 17:28:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.crashreporter-symbols.zip 17:28:29 INFO - Running post-action listener: _resource_record_post_action 17:28:29 INFO - [mozharness: 2017-10-14 00:28:29.120490Z] Finished read-buildbot-config step (success) 17:28:29 INFO - [mozharness: 2017-10-14 00:28:29.120746Z] Running download-and-extract step. 17:28:29 INFO - Running pre-action listener: _resource_record_pre_action 17:28:29 INFO - Running main action method: download_and_extract 17:28:29 INFO - mkdir: /builds/slave/test/build/tests 17:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:29 INFO - trying https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.test_packages.json 17:28:29 INFO - Downloading https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:28:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:28:29 INFO - Downloaded 989 bytes. 17:28:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:28:29 INFO - Using the following test package requirements: 17:28:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:28:29 INFO - u'common': [u'target.common.tests.zip'], 17:28:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:28:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:28:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:28:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:28:29 INFO - u'mozbase': [u'target.common.tests.zip'], 17:28:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:28:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:28:29 INFO - u'web-platform': [u'target.common.tests.zip', 17:28:29 INFO - u'target.web-platform.tests.tar.gz'], 17:28:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:28:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:28:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.common.tests.zip 17:28:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:28:29 INFO - Fetch https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.common.tests.zip into memory 17:28:31 INFO - Content-Length response header: 55181713 17:28:31 INFO - Bytes received: 55181713 17:28:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.talos.tests.zip 17:28:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:28:41 INFO - Fetch https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.talos.tests.zip into memory 17:28:42 INFO - Content-Length response header: 14509251 17:28:42 INFO - Bytes received: 14509251 17:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:42 INFO - trying https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.tar.bz2 17:28:42 INFO - Downloading https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:28:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:28:44 INFO - Downloaded 53643935 bytes. 17:28:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.tar.bz2 17:28:44 INFO - mkdir: /builds/slave/test/properties 17:28:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:28:44 INFO - Writing to file /builds/slave/test/properties/build_url 17:28:44 INFO - Contents: 17:28:44 INFO - build_url:https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.tar.bz2 17:28:44 INFO - Running post-action listener: _resource_record_post_action 17:28:44 INFO - Running post-action listener: find_tests_for_verification 17:28:44 INFO - Running post-action listener: set_extra_try_arguments 17:28:44 INFO - [mozharness: 2017-10-14 00:28:44.298215Z] Finished download-and-extract step (success) 17:28:44 INFO - [mozharness: 2017-10-14 00:28:44.298314Z] Running populate-webroot step. 17:28:44 INFO - Running pre-action listener: _resource_record_pre_action 17:28:44 INFO - Running main action method: populate_webroot 17:28:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:28:44 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:28:44 INFO - 'tests': ['tresize', 17:28:44 INFO - 'tcanvasmark']}, 17:28:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:28:44 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:28:44 INFO - 'tests': ['dromaeo_css', 17:28:44 INFO - 'kraken']}, 17:28:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:28:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:28:44 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:28:44 INFO - 'talos_options': ['--disable-stylo'], 17:28:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:28:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:28:44 INFO - 'tests': ['damp', 'tps']}, 17:28:44 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:28:44 INFO - 'talos_options': ['--disable-stylo'], 17:28:44 INFO - 'tests': ['damp', 'tps']}, 17:28:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:28:44 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:28:44 INFO - 'tests': ['dromaeo_dom']}, 17:28:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:28:44 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:28:44 INFO - 'tests': ['basic_compositor_video', 17:28:44 INFO - 'glvideo']}, 17:28:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:28:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:28:44 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:28:44 INFO - 'talos_options': ['--disable-stylo'], 17:28:44 INFO - 'tests': ['ts_paint_webext', 17:28:44 INFO - 'tp5o_webext']}, 17:28:44 INFO - 'other-e10s': {'tests': ['a11yr', 17:28:44 INFO - 'ts_paint', 17:28:44 INFO - 'tpaint', 17:28:44 INFO - 'sessionrestore', 17:28:44 INFO - 'sessionrestore_many_windows', 17:28:44 INFO - 'sessionrestore_no_auto_restore', 17:28:44 INFO - 'tabpaint']}, 17:28:44 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:28:44 INFO - 'tests': ['a11yr', 17:28:44 INFO - 'ts_paint', 17:28:44 INFO - 'tpaint', 17:28:44 INFO - 'sessionrestore', 17:28:44 INFO - 'sessionrestore_many_windows', 17:28:44 INFO - 'sessionrestore_no_auto_restore', 17:28:44 INFO - 'tabpaint']}, 17:28:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:28:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:28:44 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:28:44 INFO - 'tests': ['perf_reftest_singletons']}, 17:28:44 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:28:44 INFO - 'tests': ['bloom_basic']}, 17:28:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:28:44 INFO - 'tsvgr_opacity', 17:28:44 INFO - 'tart', 17:28:44 INFO - 'tscrollx', 17:28:44 INFO - 'tsvg_static']}, 17:28:44 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:28:44 INFO - 'tests': ['tsvgx', 17:28:44 INFO - 'tsvgr_opacity', 17:28:44 INFO - 'tart', 17:28:44 INFO - 'tscrollx', 17:28:44 INFO - 'tsvg_static']}, 17:28:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:28:44 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:28:44 INFO - 'talos_options': ['--disable-stylo'], 17:28:44 INFO - 'tests': ['tp5o']}, 17:28:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:28:44 INFO - 'talos_options': ['--mitmproxy', 17:28:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:28:44 INFO - '--firstNonBlankPaint'], 17:28:44 INFO - 'tests': ['tp6_google', 17:28:44 INFO - 'tp6_youtube', 17:28:44 INFO - 'tp6_amazon', 17:28:44 INFO - 'tp6_facebook']}, 17:28:44 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:28:44 INFO - 'talos_options': ['--disable-stylo', 17:28:44 INFO - '--mitmproxy', 17:28:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:28:44 INFO - '--firstNonBlankPaint'], 17:28:44 INFO - 'tests': ['tp6_google', 17:28:44 INFO - 'tp6_youtube', 17:28:44 INFO - 'tp6_amazon', 17:28:44 INFO - 'tp6_facebook']}, 17:28:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:28:44 INFO - 'talos_options': ['--stylo-threads=1', 17:28:44 INFO - '--mitmproxy', 17:28:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:28:44 INFO - '--firstNonBlankPaint'], 17:28:44 INFO - 'tests': ['tp6_google', 17:28:44 INFO - 'tp6_youtube', 17:28:44 INFO - 'tp6_amazon', 17:28:44 INFO - 'tp6_facebook']}, 17:28:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:28:44 INFO - 'talos_options': ['--xperf_path', 17:28:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:28:44 INFO - 'tests': ['tp5n']}, 17:28:44 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:28:44 INFO - 'talos_options': ['--disable-stylo', 17:28:44 INFO - '--xperf_path', 17:28:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:28:44 INFO - 'tests': ['tp5n']}}} 17:28:44 INFO - Running post-action listener: _resource_record_post_action 17:28:44 INFO - [mozharness: 2017-10-14 00:28:44.313278Z] Finished populate-webroot step (success) 17:28:44 INFO - [mozharness: 2017-10-14 00:28:44.313368Z] Running create-virtualenv step. 17:28:44 INFO - Running pre-action listener: _resource_record_pre_action 17:28:44 INFO - Running main action method: create_virtualenv 17:28:44 INFO - Creating virtualenv /builds/slave/test/build/venv 17:28:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:28:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:28:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:28:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:28:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:28:44 INFO - Installing distribute.............................................................................................................................................................................................done. 17:28:45 INFO - Installing pip...............done. 17:28:45 INFO - Return code: 0 17:28:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:28:45 INFO - Reading from file tmpfile_stdout 17:28:45 INFO - Output received: 17:28:45 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:28:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:28:45 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')]} 17:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:45 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')]} 17:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:45 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 0x28351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4090>, '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 0x2ba4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ef90>, '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': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', '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 17:28:45 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 17:28:45 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 17:28:45 INFO - Using env: {'DISPLAY': ':0', 17:28:45 INFO - 'HOME': '/home/cltbld', 17:28:45 INFO - 'LANG': 'en_US.UTF-8', 17:28:45 INFO - 'LANGUAGE': 'en_US:en', 17:28:45 INFO - 'LOGNAME': 'cltbld', 17:28:45 INFO - 'MAIL': '/var/mail/cltbld', 17:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:45 INFO - 'MOZ_NO_REMOTE': '1', 17:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:45 INFO - 'NO_EM_RESTART': '1', 17:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:45 INFO - 'PWD': '/builds/slave/test', 17:28:45 INFO - 'SHELL': '/bin/bash', 17:28:45 INFO - 'SHLVL': '1', 17:28:45 INFO - 'TERM': 'linux', 17:28:45 INFO - 'TMOUT': '86400', 17:28:45 INFO - 'USER': 'cltbld', 17:28:45 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', 17:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:45 INFO - '_': '/tools/buildbot/bin/python'} 17:28:46 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:28:46 INFO - Downloading/unpacking pip>=1.5 17:28:46 INFO - Running setup.py egg_info for package pip 17:28:46 INFO - warning: no files found matching 'pip/cacert.pem' 17:28:46 INFO - warning: no files found matching '*.html' under directory 'docs' 17:28:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:28:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:28:46 INFO - Installing collected packages: pip 17:28:46 INFO - Found existing installation: pip 1.1 17:28:46 INFO - Uninstalling pip: 17:28:46 INFO - Successfully uninstalled pip 17:28:46 INFO - Running setup.py install for pip 17:28:46 INFO - warning: no files found matching 'pip/cacert.pem' 17:28:46 INFO - warning: no files found matching '*.html' under directory 'docs' 17:28:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:28:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:28:46 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:28:46 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:28:46 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:28:46 INFO - Successfully installed pip 17:28:46 INFO - Cleaning up... 17:28:46 INFO - Return code: 0 17:28:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:28: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')]} 17:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28: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')]} 17:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28: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', '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 0x28351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4090>, '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 0x2ba4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ef90>, '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': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', '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 17:28: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:28: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 psutil>=3.1.1 17:28:46 INFO - Using env: {'DISPLAY': ':0', 17:28:46 INFO - 'HOME': '/home/cltbld', 17:28:46 INFO - 'LANG': 'en_US.UTF-8', 17:28:46 INFO - 'LANGUAGE': 'en_US:en', 17:28:46 INFO - 'LOGNAME': 'cltbld', 17:28:46 INFO - 'MAIL': '/var/mail/cltbld', 17:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:46 INFO - 'MOZ_NO_REMOTE': '1', 17:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:46 INFO - 'NO_EM_RESTART': '1', 17:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:46 INFO - 'PWD': '/builds/slave/test', 17:28:46 INFO - 'SHELL': '/bin/bash', 17:28:46 INFO - 'SHLVL': '1', 17:28:46 INFO - 'TERM': 'linux', 17:28:46 INFO - 'TMOUT': '86400', 17:28:46 INFO - 'USER': 'cltbld', 17:28:46 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', 17:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:46 INFO - '_': '/tools/buildbot/bin/python'} 17:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:46 INFO - Downloading/unpacking psutil>=3.1.1 17:28: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 17:28: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 17:28: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 17:28: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 17:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:28:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:28:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:28:48 INFO - Installing collected packages: psutil 17:28:48 INFO - Running setup.py install for psutil 17:28:48 INFO - building 'psutil._psutil_linux' extension 17:28:48 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 17:28:48 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 17:28:48 INFO - building 'psutil._psutil_posix' extension 17:28:48 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 17:28:48 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 17:28:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:28:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:28:48 INFO - Successfully installed psutil 17:28:48 INFO - Cleaning up... 17:28:48 INFO - Return code: 0 17:28:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:28: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')]} 17:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28: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')]} 17:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4090>, '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 0x2ba4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ef90>, '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': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', '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 17:28: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:28: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 mozsystemmonitor==0.3 17:28:48 INFO - Using env: {'DISPLAY': ':0', 17:28:48 INFO - 'HOME': '/home/cltbld', 17:28:48 INFO - 'LANG': 'en_US.UTF-8', 17:28:48 INFO - 'LANGUAGE': 'en_US:en', 17:28:48 INFO - 'LOGNAME': 'cltbld', 17:28:48 INFO - 'MAIL': '/var/mail/cltbld', 17:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:48 INFO - 'MOZ_NO_REMOTE': '1', 17:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:48 INFO - 'NO_EM_RESTART': '1', 17:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:48 INFO - 'PWD': '/builds/slave/test', 17:28:48 INFO - 'SHELL': '/bin/bash', 17:28:48 INFO - 'SHLVL': '1', 17:28:48 INFO - 'TERM': 'linux', 17:28:48 INFO - 'TMOUT': '86400', 17:28:48 INFO - 'USER': 'cltbld', 17:28:48 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', 17:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:48 INFO - '_': '/tools/buildbot/bin/python'} 17:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:28: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 17:28: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 17:28: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 17:28: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 17:28:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:28:50 INFO - Installing collected packages: mozsystemmonitor 17:28:50 INFO - Running setup.py install for mozsystemmonitor 17:28:50 INFO - Successfully installed mozsystemmonitor 17:28:50 INFO - Cleaning up... 17:28:50 INFO - Return code: 0 17:28:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4090>, '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 0x2ba4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ef90>, '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': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', '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 17:28:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:28:50 INFO - Using env: {'DISPLAY': ':0', 17:28:50 INFO - 'HOME': '/home/cltbld', 17:28:50 INFO - 'LANG': 'en_US.UTF-8', 17:28:50 INFO - 'LANGUAGE': 'en_US:en', 17:28:50 INFO - 'LOGNAME': 'cltbld', 17:28:50 INFO - 'MAIL': '/var/mail/cltbld', 17:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:50 INFO - 'MOZ_NO_REMOTE': '1', 17:28:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:50 INFO - 'NO_EM_RESTART': '1', 17:28:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:50 INFO - 'PWD': '/builds/slave/test', 17:28:50 INFO - 'SHELL': '/bin/bash', 17:28:50 INFO - 'SHLVL': '1', 17:28:50 INFO - 'TERM': 'linux', 17:28:50 INFO - 'TMOUT': '86400', 17:28:50 INFO - 'USER': 'cltbld', 17:28:50 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', 17:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:50 INFO - '_': '/tools/buildbot/bin/python'} 17:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:51 INFO - Downloading/unpacking jsonschema==2.5.1 17:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:28:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:28: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 17:28: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 17:28: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 17:28: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 17:28:52 INFO - Downloading functools32-3.2.3-2.tar.gz 17:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:28:52 INFO - warning: no files found matching '*.txt' 17:28:52 INFO - no previously-included directories found matching 'build' 17:28:52 INFO - no previously-included directories found matching 'dist' 17:28:52 INFO - no previously-included directories found matching '.git*' 17:28:52 INFO - Installing collected packages: jsonschema, functools32 17:28:53 INFO - Running setup.py install for functools32 17:28:53 INFO - warning: no files found matching '*.txt' 17:28:53 INFO - no previously-included directories found matching 'build' 17:28:53 INFO - no previously-included directories found matching 'dist' 17:28:53 INFO - no previously-included directories found matching '.git*' 17:28:53 INFO - Successfully installed jsonschema functools32 17:28:53 INFO - Cleaning up... 17:28:53 INFO - Return code: 0 17:28:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4090>, '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 0x2ba4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ef90>, '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': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', '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 17:28:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:28:53 INFO - Using env: {'DISPLAY': ':0', 17:28:53 INFO - 'HOME': '/home/cltbld', 17:28:53 INFO - 'LANG': 'en_US.UTF-8', 17:28:53 INFO - 'LANGUAGE': 'en_US:en', 17:28:53 INFO - 'LOGNAME': 'cltbld', 17:28:53 INFO - 'MAIL': '/var/mail/cltbld', 17:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:53 INFO - 'MOZ_NO_REMOTE': '1', 17:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:53 INFO - 'NO_EM_RESTART': '1', 17:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:53 INFO - 'PWD': '/builds/slave/test', 17:28:53 INFO - 'SHELL': '/bin/bash', 17:28:53 INFO - 'SHLVL': '1', 17:28:53 INFO - 'TERM': 'linux', 17:28:53 INFO - 'TMOUT': '86400', 17:28:53 INFO - 'USER': 'cltbld', 17:28:53 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', 17:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:53 INFO - '_': '/tools/buildbot/bin/python'} 17:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:28:54 INFO - Cleaning up... 17:28:54 INFO - Return code: 0 17:28:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:28: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')]} 17:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28: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')]} 17:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4090>, '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 0x2ba4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ef90>, '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': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', '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 17:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:28:54 INFO - Using env: {'DISPLAY': ':0', 17:28:54 INFO - 'HOME': '/home/cltbld', 17:28:54 INFO - 'LANG': 'en_US.UTF-8', 17:28:54 INFO - 'LANGUAGE': 'en_US:en', 17:28:54 INFO - 'LOGNAME': 'cltbld', 17:28:54 INFO - 'MAIL': '/var/mail/cltbld', 17:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:54 INFO - 'MOZ_NO_REMOTE': '1', 17:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:54 INFO - 'NO_EM_RESTART': '1', 17:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:54 INFO - 'PWD': '/builds/slave/test', 17:28:54 INFO - 'SHELL': '/bin/bash', 17:28:54 INFO - 'SHLVL': '1', 17:28:54 INFO - 'TERM': 'linux', 17:28:54 INFO - 'TMOUT': '86400', 17:28:54 INFO - 'USER': 'cltbld', 17:28:54 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', 17:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:54 INFO - '_': '/tools/buildbot/bin/python'} 17:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:54 INFO - Downloading/unpacking blobuploader==1.2.4 17:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:55 INFO - Downloading blobuploader-1.2.4.tar.gz 17:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:28:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:28:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:55 INFO - Downloading docopt-0.6.1.tar.gz 17:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:28:56 INFO - Installing collected packages: blobuploader, requests, docopt 17:28:56 INFO - Running setup.py install for blobuploader 17:28:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:28:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:28:56 INFO - Running setup.py install for requests 17:28:56 INFO - Running setup.py install for docopt 17:28:56 INFO - Successfully installed blobuploader requests docopt 17:28:56 INFO - Cleaning up... 17:28:56 INFO - Return code: 0 17:28:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:56 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 0x28351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4090>, '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 0x2ba4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ef90>, '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': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', '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 17:28:56 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 17:28:56 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 17:28:56 INFO - Using env: {'DISPLAY': ':0', 17:28:56 INFO - 'HOME': '/home/cltbld', 17:28:56 INFO - 'LANG': 'en_US.UTF-8', 17:28:56 INFO - 'LANGUAGE': 'en_US:en', 17:28:56 INFO - 'LOGNAME': 'cltbld', 17:28:56 INFO - 'MAIL': '/var/mail/cltbld', 17:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:56 INFO - 'MOZ_NO_REMOTE': '1', 17:28:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:56 INFO - 'NO_EM_RESTART': '1', 17:28:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:56 INFO - 'PWD': '/builds/slave/test', 17:28:56 INFO - 'SHELL': '/bin/bash', 17:28:56 INFO - 'SHLVL': '1', 17:28:56 INFO - 'TERM': 'linux', 17:28:56 INFO - 'TMOUT': '86400', 17:28:56 INFO - 'USER': 'cltbld', 17:28:56 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', 17:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:56 INFO - '_': '/tools/buildbot/bin/python'} 17:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:28:56 INFO - Running setup.py (path:/tmp/pip-T4CCZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:28:56 INFO - Running setup.py (path:/tmp/pip-nXFNGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:28:57 INFO - Running setup.py (path:/tmp/pip-VhJDK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:28:57 INFO - Running setup.py (path:/tmp/pip-suAy4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:28:57 INFO - Running setup.py (path:/tmp/pip-cRIu_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:28:57 INFO - Running setup.py (path:/tmp/pip-vB4wUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:28:57 INFO - Running setup.py (path:/tmp/pip-OOGJep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:28:57 INFO - Running setup.py (path:/tmp/pip-SAWb07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:28:57 INFO - Running setup.py (path:/tmp/pip-nm93yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:28:57 INFO - Running setup.py (path:/tmp/pip-O0_mXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:28:57 INFO - Running setup.py (path:/tmp/pip-QxkFbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:28:57 INFO - Running setup.py (path:/tmp/pip-70PQje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:28:57 INFO - Running setup.py (path:/tmp/pip-71rmfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:28:57 INFO - Running setup.py (path:/tmp/pip-yxpvw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:57 INFO - Running setup.py (path:/tmp/pip-e9cySG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:28:57 INFO - Running setup.py (path:/tmp/pip-6Jt0Lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:28:58 INFO - Running setup.py (path:/tmp/pip-IM4zR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:28:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:28:58 INFO - Running setup.py install for manifestparser 17:28:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:28:58 INFO - Running setup.py install for mozcrash 17:28:58 INFO - Running setup.py install for mozdebug 17:28:58 INFO - Running setup.py install for mozdevice 17:28:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:28:58 INFO - Running setup.py install for mozfile 17:28:58 INFO - Running setup.py install for mozhttpd 17:28:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:28:58 INFO - Running setup.py install for mozinfo 17:28:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:28:58 INFO - Running setup.py install for mozInstall 17:28:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:28:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:28:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:28:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:28:58 INFO - Running setup.py install for mozleak 17:28:58 INFO - Running setup.py install for mozlog 17:28:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:28:59 INFO - Running setup.py install for moznetwork 17:28:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:28:59 INFO - Running setup.py install for mozprocess 17:28:59 INFO - Running setup.py install for mozprofile 17:28:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:28:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:28:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:28:59 INFO - Running setup.py install for mozrunner 17:28:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:28:59 INFO - Running setup.py install for mozscreenshot 17:28:59 INFO - Running setup.py install for moztest 17:28:59 INFO - Running setup.py install for mozversion 17:28:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:28:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:28:59 INFO - Cleaning up... 17:28:59 INFO - Return code: 0 17:28:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:59 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 0x28351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4090>, '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 0x2ba4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ef90>, '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': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', '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 17:28:59 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 17:28:59 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 17:28:59 INFO - Using env: {'DISPLAY': ':0', 17:28:59 INFO - 'HOME': '/home/cltbld', 17:28:59 INFO - 'LANG': 'en_US.UTF-8', 17:28:59 INFO - 'LANGUAGE': 'en_US:en', 17:28:59 INFO - 'LOGNAME': 'cltbld', 17:28:59 INFO - 'MAIL': '/var/mail/cltbld', 17:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:59 INFO - 'MOZ_NO_REMOTE': '1', 17:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:59 INFO - 'NO_EM_RESTART': '1', 17:28:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:59 INFO - 'PWD': '/builds/slave/test', 17:28:59 INFO - 'SHELL': '/bin/bash', 17:28:59 INFO - 'SHLVL': '1', 17:28:59 INFO - 'TERM': 'linux', 17:28:59 INFO - 'TMOUT': '86400', 17:28:59 INFO - 'USER': 'cltbld', 17:28:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', 17:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:59 INFO - '_': '/tools/buildbot/bin/python'} 17:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:29:00 INFO - Running setup.py (path:/tmp/pip-HCOiZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:29:00 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)) 17:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:29:00 INFO - Running setup.py (path:/tmp/pip-Wai_SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:29:00 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)) 17:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:29:00 INFO - Running setup.py (path:/tmp/pip-AboLnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:29:00 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)) 17:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:29:00 INFO - Running setup.py (path:/tmp/pip-PNTPei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:29:00 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)) 17:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:29:00 INFO - Running setup.py (path:/tmp/pip-hW9HFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:29:00 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)) 17:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:29:00 INFO - Running setup.py (path:/tmp/pip-2vMfds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:29:00 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)) 17:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:29:00 INFO - Running setup.py (path:/tmp/pip-mn6jAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:29:00 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)) 17:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:29:00 INFO - Running setup.py (path:/tmp/pip-45Qwhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:29:00 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)) 17:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:29:00 INFO - Running setup.py (path:/tmp/pip-_16Ij9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:29:00 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)) 17:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:29:00 INFO - Running setup.py (path:/tmp/pip-dfuZ2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:29:00 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)) 17:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:29:00 INFO - Running setup.py (path:/tmp/pip-mXkLZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:29:00 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)) 17:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:29:00 INFO - Running setup.py (path:/tmp/pip-YqjqwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:29:00 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)) 17:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:29:00 INFO - Running setup.py (path:/tmp/pip-8s5F6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:29:01 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)) 17:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:29:01 INFO - Running setup.py (path:/tmp/pip-mgex1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:29:01 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)) 17:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:29:01 INFO - Running setup.py (path:/tmp/pip-uK1aAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:29:01 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)) 17:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:29:01 INFO - Running setup.py (path:/tmp/pip-8Enx7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:29:01 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)) 17:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:29:01 INFO - Running setup.py (path:/tmp/pip-4BjGnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:29:01 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)) 17:29:01 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)) 17:29:01 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)) 17:29:01 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)) 17:29:01 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)) 17:29:01 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)) 17:29:01 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)) 17:29:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:29:01 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 17:29:01 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 17:29:01 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 17:29:01 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 17:29:02 INFO - Downloading blessings-1.6.tar.gz 17:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:29:02 INFO - Installing collected packages: blessings 17:29:02 INFO - Running setup.py install for blessings 17:29:02 INFO - Successfully installed blessings 17:29:02 INFO - Cleaning up... 17:29:02 INFO - Return code: 0 17:29:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:29:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:29:02 INFO - Reading from file tmpfile_stdout 17:29:02 INFO - Current package versions: 17:29:02 INFO - argparse == 1.2.1 17:29:02 INFO - blessings == 1.6 17:29:02 INFO - blobuploader == 1.2.4 17:29:02 INFO - docopt == 0.6.1 17:29:02 INFO - functools32 == 3.2.3-2 17:29:02 INFO - jsonschema == 2.5.1 17:29:02 INFO - manifestparser == 1.1 17:29:02 INFO - mozInstall == 1.13 17:29:02 INFO - mozcrash == 1.0 17:29:02 INFO - mozdebug == 0.1 17:29:02 INFO - mozdevice == 0.51 17:29:02 INFO - mozfile == 1.2 17:29:02 INFO - mozhttpd == 0.7 17:29:02 INFO - mozinfo == 0.10 17:29:02 INFO - mozleak == 0.1 17:29:02 INFO - mozlog == 3.5 17:29:02 INFO - moznetwork == 0.27 17:29:02 INFO - mozprocess == 0.25 17:29:02 INFO - mozprofile == 0.28 17:29:02 INFO - mozrunner == 6.13 17:29:02 INFO - mozscreenshot == 0.1 17:29:02 INFO - mozsystemmonitor == 0.3 17:29:02 INFO - moztest == 0.8 17:29:02 INFO - mozversion == 1.4 17:29:02 INFO - psutil == 3.1.1 17:29:02 INFO - requests == 1.2.3 17:29:02 INFO - wsgiref == 0.1.2 17:29:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:02 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 0x28351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4090>, '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 0x2ba4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ef90>, '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': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', '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 17:29:02 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 17:29:02 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 17:29:02 INFO - Using env: {'DISPLAY': ':0', 17:29:02 INFO - 'HOME': '/home/cltbld', 17:29:02 INFO - 'LANG': 'en_US.UTF-8', 17:29:02 INFO - 'LANGUAGE': 'en_US:en', 17:29:02 INFO - 'LOGNAME': 'cltbld', 17:29:02 INFO - 'MAIL': '/var/mail/cltbld', 17:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:02 INFO - 'MOZ_NO_REMOTE': '1', 17:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:02 INFO - 'NO_EM_RESTART': '1', 17:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:02 INFO - 'PWD': '/builds/slave/test', 17:29:02 INFO - 'SHELL': '/bin/bash', 17:29:02 INFO - 'SHLVL': '1', 17:29:02 INFO - 'TERM': 'linux', 17:29:02 INFO - 'TMOUT': '86400', 17:29:02 INFO - 'USER': 'cltbld', 17:29:02 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', 17:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:02 INFO - '_': '/tools/buildbot/bin/python'} 17:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:03 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)) 17:29:03 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)) 17:29:03 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)) 17:29:03 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)) 17:29:03 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)) 17:29:03 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)) 17:29:03 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)) 17:29:03 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)) 17:29:03 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)) 17:29:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:29:04 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)) 17:29:04 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)) 17:29:04 INFO - Installing collected packages: simplejson 17:29:04 INFO - Running setup.py install for simplejson 17:29:04 INFO - building 'simplejson._speedups' extension 17:29:04 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 17:29:05 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 17:29:05 INFO - Successfully installed simplejson 17:29:05 INFO - Cleaning up... 17:29:05 INFO - Return code: 0 17:29:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:05 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 0x28351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4090>, '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 0x2ba4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ef90>, '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': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', '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 17:29:05 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 17:29:05 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 17:29:05 INFO - Using env: {'DISPLAY': ':0', 17:29:05 INFO - 'HOME': '/home/cltbld', 17:29:05 INFO - 'LANG': 'en_US.UTF-8', 17:29:05 INFO - 'LANGUAGE': 'en_US:en', 17:29:05 INFO - 'LOGNAME': 'cltbld', 17:29:05 INFO - 'MAIL': '/var/mail/cltbld', 17:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:05 INFO - 'MOZ_NO_REMOTE': '1', 17:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:05 INFO - 'NO_EM_RESTART': '1', 17:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:05 INFO - 'PWD': '/builds/slave/test', 17:29:05 INFO - 'SHELL': '/bin/bash', 17:29:05 INFO - 'SHLVL': '1', 17:29:05 INFO - 'TERM': 'linux', 17:29:05 INFO - 'TMOUT': '86400', 17:29:05 INFO - 'USER': 'cltbld', 17:29:05 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', 17:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:05 INFO - '_': '/tools/buildbot/bin/python'} 17:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:29:05 INFO - Cleaning up... 17:29:05 INFO - Return code: 0 17:29:05 INFO - Running post-action listener: _resource_record_post_action 17:29:05 INFO - Running post-action listener: _start_resource_monitoring 17:29:05 INFO - Starting resource monitoring. 17:29:05 INFO - [mozharness: 2017-10-14 00:29:05.534406Z] Finished create-virtualenv step (success) 17:29:05 INFO - [mozharness: 2017-10-14 00:29:05.534924Z] Running install step. 17:29:05 INFO - Running pre-action listener: _resource_record_pre_action 17:29:05 INFO - Running main action method: install 17:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:29:05 INFO - Reading from file tmpfile_stdout 17:29:05 INFO - Detecting whether we're running mozinstall >=1.0... 17:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:29:05 INFO - Reading from file tmpfile_stdout 17:29:05 INFO - Output received: 17:29:05 INFO - Usage: mozinstall [options] installer 17:29:05 INFO - Options: 17:29:05 INFO - -h, --help show this help message and exit 17:29:05 INFO - -d DEST, --destination=DEST 17:29:05 INFO - Directory to install application into. [default: 17:29:05 INFO - "/builds/slave/test"] 17:29:05 INFO - --app=APP Application being installed. [default: firefox] 17:29:05 INFO - mkdir: /builds/slave/test/build/application 17:29:05 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'] 17:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:29:20 INFO - Reading from file tmpfile_stdout 17:29:20 INFO - Output received: 17:29:20 INFO - /builds/slave/test/build/application/firefox/firefox 17:29:20 INFO - Running post-action listener: _resource_record_post_action 17:29:20 INFO - [mozharness: 2017-10-14 00:29:20.464633Z] Finished install step (success) 17:29:20 INFO - [mozharness: 2017-10-14 00:29:20.464894Z] Running setup-mitmproxy step. 17:29:20 INFO - Running pre-action listener: _resource_record_pre_action 17:29:20 INFO - Running main action method: setup_mitmproxy 17:29:20 INFO - Skipping: mitmproxy is not required 17:29:20 INFO - Running post-action listener: _resource_record_post_action 17:29:20 INFO - [mozharness: 2017-10-14 00:29:20.466022Z] Finished setup-mitmproxy step (success) 17:29:20 INFO - [mozharness: 2017-10-14 00:29:20.466243Z] Running run-tests step. 17:29:20 INFO - Running pre-action listener: _resource_record_pre_action 17:29:20 INFO - Running pre-action listener: _set_gcov_prefix 17:29:20 INFO - Running main action method: run_tests 17:29:20 WARNING - Try message not found. 17:29:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:29:20 INFO - Python 2.7.3 17:29:20 INFO - Return code: 0 17:29:20 INFO - grabbing minidump binary from tooltool 17:29: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')]} 17:29: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 0x2ba4090>, '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 0x2ba4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:29: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 17:29: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 17:29: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 17:29:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:29:20 INFO - Return code: 0 17:29:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:29:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:29:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:29:20 INFO - ENV: RUST_BACKTRACE is now full 17:29:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:29:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:29:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 17:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 17:29:20 INFO - Using env: {'DISPLAY': ':0', 17:29:20 INFO - 'HOME': '/home/cltbld', 17:29:20 INFO - 'LANG': 'en_US.UTF-8', 17:29:20 INFO - 'LANGUAGE': 'en_US:en', 17:29:20 INFO - 'LOGNAME': 'cltbld', 17:29:20 INFO - 'MAIL': '/var/mail/cltbld', 17:29:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:29:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:20 INFO - 'MOZ_NO_REMOTE': '1', 17:29:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:20 INFO - 'NO_EM_RESTART': '1', 17:29:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:20 INFO - 'PWD': '/builds/slave/test', 17:29:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:29:20 INFO - 'RUST_BACKTRACE': 'full', 17:29:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:29:20 INFO - 'SHELL': '/bin/bash', 17:29:20 INFO - 'SHLVL': '1', 17:29:20 INFO - 'TERM': 'linux', 17:29:20 INFO - 'TMOUT': '86400', 17:29:20 INFO - 'USER': 'cltbld', 17:29:20 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', 17:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:20 INFO - '_': '/tools/buildbot/bin/python'} 17:29:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 17:29:20 INFO - mozversion application_buildid: 20171013230515 17:29:20 INFO - mozversion application_changeset: 4a8c7830ff4822da140890800b401d462695ccc5 17:29:20 INFO - mozversion application_display_name: Firefox 17:29:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:29:20 INFO - mozversion application_name: Firefox 17:29:20 INFO - mozversion application_remotingname: firefox 17:29:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:29:20 INFO - mozversion application_vendor: Mozilla 17:29:20 INFO - mozversion application_version: 57.0 17:29:20 INFO - mozversion platform_buildid: 20171013230515 17:29:20 INFO - mozversion platform_changeset: 4a8c7830ff4822da140890800b401d462695ccc5 17:29:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:29:20 INFO - mozversion platform_version: 57.0 17:29:20 INFO - using testdate: 1507940960 17:29:20 INFO - actual date: 1507940960 17:29:20 INFO - starting webserver on 'localhost:33536' 17:29:20 INFO - SUITE-START | Running 2 tests 17:29:20 INFO - TEST-START | dromaeo_css 17:29:20 INFO - Initialising browser for dromaeo_css test... 17:29:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33536/getInfo.html -profile /tmp/tmpsmXcfR/profile 17:29:20 INFO - TEST-INFO | started process 27882 (/builds/slave/test/build/application/firefox/firefox http://localhost:33536/getInfo.html) 17:29:25 INFO - TEST-INFO | 27882: exit 0 17:29:25 INFO - Browser initialized. 17:29:25 INFO - Running cycle 1/1 for dromaeo_css test... 17:29:25 INFO - Using env: {'DISPLAY': ':0', 17:29:25 INFO - 'HOME': '/home/cltbld', 17:29:25 INFO - 'JSGC_DISABLE_POISONING': '1', 17:29:25 INFO - 'LANG': 'en_US.UTF-8', 17:29:25 INFO - 'LANGUAGE': 'en_US:en', 17:29:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:29:25 INFO - 'LOGNAME': 'cltbld', 17:29:25 INFO - 'MAIL': '/var/mail/cltbld', 17:29:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:29:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:29:25 INFO - 'MOZ_CRASHREPORTER': '1', 17:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:29:25 INFO - 'MOZ_NO_REMOTE': '1', 17:29:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:29:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:25 INFO - 'NO_EM_RESTART': '1', 17:29:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:25 INFO - 'PWD': '/builds/slave/test', 17:29:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:29:25 INFO - 'RUST_BACKTRACE': 'full', 17:29:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:29:25 INFO - 'SHELL': '/bin/bash', 17:29:25 INFO - 'SHLVL': '1', 17:29:25 INFO - 'TERM': 'linux', 17:29:25 INFO - 'TMOUT': '86400', 17:29:25 INFO - 'USER': 'cltbld', 17:29:25 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', 17:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:25 INFO - '_': '/tools/buildbot/bin/python'} 17:29:25 INFO - TEST-INFO | started process 28114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsmXcfR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:25 INFO - PID 28114 | 17:29:25 INFO - PID 28114 | (/builds/slave/test/build/application/firefox/firefox:28162): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:29:25 INFO - PID 28114 | 17:29:36 INFO - PID 28114 | RSS: Main: 143818752 17:29:36 INFO - PID 28114 | 17:32:33 INFO - PID 28114 | Cycle 1(1): loaded http://localhost:33536/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33536/tests/dromaeo/cssquery-ext.html) 17:32:34 INFO - PID 28114 | RSS: Main: 145977344 17:32:34 INFO - PID 28114 | 17:35:36 INFO - PID 28114 | Cycle 1(1): loaded http://localhost:33536/tests/dromaeo/cssquery-ext.html (next: http://localhost:33536/tests/dromaeo/cssquery-jquery.html) 17:35:37 INFO - PID 28114 | RSS: Main: 144101376 17:35:37 INFO - PID 28114 | 17:38:38 INFO - PID 28114 | Cycle 1(1): loaded http://localhost:33536/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33536/tests/dromaeo/cssquery-mootools.html) 17:38:39 INFO - PID 28114 | RSS: Main: 146427904 17:38:39 INFO - PID 28114 | 17:41:40 INFO - PID 28114 | Cycle 1(1): loaded http://localhost:33536/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33536/tests/dromaeo/cssquery-prototype.html) 17:41:41 INFO - PID 28114 | RSS: Main: 146444288 17:41:41 INFO - PID 28114 | 17:44:44 INFO - PID 28114 | Cycle 1(1): loaded http://localhost:33536/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33536/tests/dromaeo/cssquery-yui.html) 17:44:44 INFO - PID 28114 | RSS: Main: 147824640 17:44:44 INFO - PID 28114 | 17:47:46 INFO - PID 28114 | Cycle 1(1): loaded http://localhost:33536/tests/dromaeo/cssquery-yui.html (next: http://localhost:33536/tests/dromaeo/cssquery-dojo.html) 17:47:46 INFO - PID 28114 | RSS: Main: 149995520 17:47:46 INFO - PID 28114 | 17:47:46 INFO - PID 28114 | __start_tp_report 17:47:46 INFO - PID 28114 | _x_x_mozilla_page_load 17:47:46 INFO - PID 28114 | _x_x_mozilla_page_load_details 17:47:46 INFO - PID 28114 | |i|pagename|runs| 17:47:46 INFO - PID 28114 | |0;dojo.html;3974.463447434597;3982.6216509431597;4047.5750046245125;4049.574794646562;4076.429299898017;6525.641089740062;6542.443892269157;6557.311482294362;6618.205815302158;6646.136002319698;6539.247986481556;6581.177352830896;6589;6594.703238354274;6693.899591506131;5902.852428689295;5921.141434491996;5964.910526342087;5998.190244317005;6017.247844019497;5883.735231914553;5892.793752218673;5978.461938425541;6038.124471951564;6081.665508397058;5980.581359304851;5980.6112602680905;6042.637441753487;6051.485623721989;6060.151578778975;5849.561282903799;5878.50032747217;5929.851753706192;6052.21321228242;6069.180660610805;5859.501942334907;5863.677497737623;5909.9704501477645;5931.199288096095;5951.553633477506;6449.161608990848;6460.095586617877;6499.2850786413455;6542.34576542342;6589.901151482732;6929.341712537301;7065.399441047466;7067.22260551339;7173.497855150142;7184.820379490555;7031;7124.43004559634;7129.037579926696;7135.750248741321;7221.169565499982;6451.483881289532;6521;6643.56816806906;6670.4997125215805;6677.298883617199;7204.92795072053;7208.026916366223;7243.384312333405;7323.707051717978;7337.816554586071;7015.824604384829;7039.683214255371;7084.4686648501565;7097.680604372816;7111.573305601681;7062.717491300393;7122.465815063787;7163.820904477326;7170.96414517924;7215.819604509824;7097.148342198969;7123.430125590044;7133.750318738819;7146.892796608055;7158.141023077264;7050.612216328152;7056.082709247765;7147.571145731273;7166.211716711157;7169.426445884421;5264.184051472028;5280.471952804689;5332.626716129834;5350.143976963667;5355.678659280456;4741.952580474152;4803.951960480351;4815.446223684251;4839.467658557556;4880.267959805987;6674.332566743286;6741.056252124707;6779.762708305186;6782.660866956632;6789.049533065375;6999;7089.468289878279;7153.964230178815;7158.964205178941;7188.820279493055;6582.210134783857;6672.266050734415;6709.664516774142;6712.295209003082;6713.56361836479;5970.462658360769;5987.940120598738;5993.370696076936;6023.126646636213;6061.636301821904;7447.069116360455;7465.216152304039;7496.587687677121;7526.360259378014;7563.205863384265;7042.577445353295;7056.82357941035;7133.821654458472;7156.177039640508;7164.247753985756;7389.445791565547;7391.556506609406;7404.296591823768;7471.514351567131;7532.43506736986;7048.154221493453;7096.325849044332;7114.644267786486;7124.679389427384;7149.85700285981;7023.086998690138;7093.113360829896;7168.17565979919;7247.420206383371;7265;6844.863102737818;6921.792346229621;6922.688479018356;6927.064846245894;6976.5465244758925;6752.561083529751;6907.585544867324;6913.10129683138;6976.267491913276;7002.649867506706;6789.422899053636;6815.216250131299;6832.555883867532;6838.692258848264;6842.24735279109;6941.097657304518;6985.895211571728;7003.229644739176;7026.683799229149;7040.718371265297;6728.461723062242;6734.595924244365;6804.183497980274;6806.18325800907;6811.89782153278 17:47:46 INFO - PID 28114 | |1;ext.html;990.0297708245919;1020.9897901020992;1025.2105878473571;1025.6307729217485;1026.7022563456599;41892.37161442577;42628.57371426285;46853.062938741205;46926.2961055584;46933.765331173294;43998;44391.334129988;44465.110697786025;44498.77750611251;44507.77746111273;8172.795680108;8313.667453301861;8323.001239851195;8328.458650187718;8328.833423331529;8738.606762695694;8903.955480222623;8941.64233430662;8950.597223124974;8958;8912.598933048028;8931.866022009675;8942.374033817636;8950.731478055635;8973.147550982647;8862.645494180257;8907.242884354806;8946.597403116843;8951.328650351184;8968.820623587491;8583.484990900504;8634.481931084092;8641.697540586112;8667.133286671346;8741.7814554636;40272.19455610871;40563.39154912678;40622.18755624871;40685.79657101695;40694.796526017475;3770.604086570898;3796.2976849282695;3830.4637350770913;3839.6928245740273;3846.576876543578;33812.32375352479;34118.65881341205;34130;34254.65745342564;34280.14299642504;5442.319710036246;5557.360903496109;5568.3596386415675;5609.467100625475;5643.294588176478;234150;235318;235332;235400;235411;54555.18167227495;54599;54897.176542351895;56830;57557;59739.40260597338;59817.700911495165;59904.400955989884;59917;59949.70025149846;18878.056097195084;18961.620767584573;19106.33127840519;19153.13810878486;19153.80846191548;15485.30316135754;15513.06921584686;15538.844611553966;15544.844551554339;15561.688766224612;16072.276747546388;16097.436589719304;16106.436274730328;16119.355225790838;16236.431724889571;5970.223870896755;5992.191054207713;5998.610090344201;6115.724792384353;6213.254409470802;1108.4346983038708;1117.5082963496036;1118.2507719827736;1118.8433619293305;1122.8708698499777;26331.605025924626;26764;26836.865815670797;26849.463010739677;26858.194254172406;1224.8224007518859;1235.7034311765112;1245.0413181849924;1248.1013670157472;1251.7559075980278;13620.65948351299;13934.442622294995;13968.301584920713;14048.71902561943;14346.21095839718;315868;316467;316573;318361;318437;62954.370456295765;63063.36936630575;63158.36841631617;63230;63378.36621633817;1502.1512845242403;1510.3958416633434;1547.4274518428028;1558.1274486287716;1565.9530214093595;29464;31842.54397969575;31908.680913190572;31946.84026579852;32277.193070173435;57254.42745572491;57431;57495.712521437126;57720;57857.710711446176;268305;268640;270101;270126;270177;39732;39804.800975994935;39911.60088399079;40067.59932400638;40138.79930600328;49815.75092124516;51182.232266516774;51458.742706286226;51546.22680659718;51762;37349.81325093466;37354.626453735116;37500;37785;37819.62180378161;36873;37531.624683752816;37532.624673752915;37665.2466950654;37933;41977.790111049246;43794.34308485311;43799.56200438082;44067;44142;35949.82025089858;36143.45784813177;36250.63749362472;36518.4522232172;36820.63179368172;26149.346266343495;26562.86718566472;26829.463410731285;26901.865490672422;27240 17:47:46 INFO - PID 28114 | |2;jquery.html;608.9939100608996;635.3519410201594;636.5925807483209;654.3718030690537;662.0697919423209;20937.16251349948;24080.638790418136;24672.87663561682;24853.254402367937;25681.871590642066;26550.601740973852;26717.465650686976;26750.063747768832;26835;26836.19491415256;6757.222919364287;6777.7966661;6783.93216067838;6785.1518560179975;6785.25362210159;6579.868402631944;6821.624810635413;6825.215100263459;6834.111565496479;6835.658217089151;6767.729290828361;6769.830754231134;6781.966090169542;6790.253072162058;6794;6795.252522222551;6805.625690587016;6815.216250131224;6816.761413350534;6818.761343352959;6358;6370.490360771128;6377.2666143393635;6377.362263773632;6382.904256436157;30436.69563304383;32450.18874528132;32667.6733232667;32857.34285314304;32893.50659740106;2358.5282943411385;2388.5461762265113;2395.2574701842486;2395.4250979764906;2396.8202384821034;21407.892960535253;21747.565048698936;21873.78126218749;21889;21913.342599721873;2633.0784225520915;2662.188032650041;2677.9866100669565;2695.460907818444;2697.824641398303;147976.2601186998;148448;155208;162091;166995;16786;17147.884507718307;17257.309707611807;17468.301267949395;17697.734533982002;27246.182614521596;27296.727032729417;27436.862815685792;27465.31336716598;27498.587521187197;10685.786284274427;10827.458627068616;10893.400862952456;11075.224734268684;11091.059064663652;9765.267604929517;9863.506824658738;9894.60421583143;9911.504424778732;9925.3548519346;10153.847692284622;10233.641822536176;10404.739881502872;10463.68608941733;10673.679789606324;2798.874050667725;2843.843588602647;2888.1479963410843;2968.807027543246;2982.2544363909024;1045.6264280084167;1077.7305673581604;1079.983800242997;1082.2910993299402;1085.8751243606928;22898.65652015221;23041.88479057594;23321.300360989197;23324.533509329718;23467.53064938726;1129.4296380327883;1137.1585027080066;1138.635636596298;1148.5463242019355;1148.6381789736206;12340.197887137307;12604.495820167274;12942.482300708054;13018.414171362312;13024.674383140307;650921;653060;657551;681308;691677;135099;141380;141851;142843;143198;1110.117091157126;1225.6935766058486;1254.7615952968906;1269.282855186835;1279.5329704657734;24206.878965605058;24249.07803400426;24316;24445;24782.752172478766;64701.352986471415;65691;65896.99999999808;65940.34059659534;67182;75048.62475687805;77795;80358;80715.59642201751;81100;16937.237824298183;16996.915015424845;17016.404425845038;17118.14409279556;17157.142142893055;25813.483730325665;26287.868560657073;26454.470910582066;26535;26631.33421664474;21017.159313627897;21243.575128497036;21266.25568105109;21505.892470537547;21527.354179374644;17845.37541186052;17857.196426160594;18498.537536561154;18598.628027439645;18852.245910163987;20259.696104558738;20506.69239961372;20575.176992920115;20608.793912061286;22052.669209962183;16534.25595848214;16561.25474353633;16593.170341482637;16610.086445245626;16727.832721673116;20728.274510392668;20960.580788384454;21012.369628911158;21147.78852211458;21170.57658846845 17:47:46 INFO - PID 28114 | |3;mootools.html;1411.858814118588;1451.7967484552162;1476.291380137534;1482.3181336585171;1482.948096816611;17769.289228430862;18425.723614145783;18434;18446.98541580214;18452.261909523604;17895.463136105904;17916.731249031276;17949.28202871887;18067.72898406525;18115.54711132219;3142.5914631097926;3196.5524826524306;3243.2054146734085;3244.043007312848;3249.382617302705;3125.4374212641715;3128.296133369985;3143.497040473513;3143.622765268171;3150.732187764043;3125.1718294651937;3195.4407978603767;3196.6643502432257;3198.6641402652735;3200.5519227308196;3145.418097651942;3167.4615315396322;3198.184462961953;3199.8240096794666;3210.4702724050503;3055.2972816252163;3093.180307218589;3106.518489634088;3111.735502482292;3130.3426280481126;17261.482155535356;17300.307987680477;17315.480535583953;17334.91332543342;17335.04657243851;8994.595243214071;9270.953645231799;9342.2526197904;9348.252139828797;9355.76610584734;5628.662280263156;5891.234139561872;6003.429674180946;6026;6075.665838378887;2073.7200477935435;2095.7485101787884;2121.63932131538;2155.719756431654;2179.5422961178174;31887.52168717471;32192.35615287681;32320;32406.351872962645;32586.511202331985;8283.461574997726;8341.499510029418;8342.541160236124;8538.573071346407;8576;23886.283411497683;23919.282421527383;23940.40148996289;24041;24066.278011659677;9052.728418147466;9359.532023398802;9364;9370.062993700712;9372.531373431437;7688.269614386624;8194.672213111528;8305.916940830635;8348;8378.664853405917;6647.501437392215;6684.364985326483;6685.966570167118;6702.798916032527;6814.557053791487;1909.6658084835376;1994.411648563677;2038.5922815436973;2077.2418067405592;2088.2586681727767;985.6353149334792;998.3859926145368;1002.8295189817749;1004.2518323848633;1020.2552136940076;9807.803843923224;9888.901110988942;10006.09945104944;10039.4478303694;10056.899431005742;1066.8773091094467;1077.3051381858656;1096.2162054131175;1097.3415950429837;1099.5052226498108;5349.973250133802;5375.435579264199;5455.34535855692;6422.100905873182;6633.038209459602;25457.10900118487;25871.96512139531;26179.607305890426;26245.34386640349;26860.59709104326;25356;25756.742432575433;25878;25925.22224333273;26189.73810261911;12942.158759680591;12992.740145196854;13046.608601741962;13188.868111318763;13225.933870330588;9386.624535018524;9416.95291523538;9518.857217141609;9551.235901128031;9562.28282878773;22066.338009859086;22109.77890221077;22170.334889952683;22198.44610877223;22775.772242277366;22605.43486412853;22805.31584052481;23123.190688325827;23167.420814479774;23375.649365259196;13947.16317020982;14240.359183836545;14245.786313205517;14250.216238106588;14263.144211347353;14824.184669843262;14876.107433554022;15121.697566048837;15195;15220.391184352502;12200.084993625691;12354.196977196454;12500.874991250335;12524.686882828002;12738.426770795151;11847.289162650268;11893.821592675944;11976;12193.451294691937;12223.511059557874;10882.129429645767;11029.669109926715;11042.392668403316;11047.392393418439;11059.391733454737;8472.322214222724;8581.91418085836;8595.44129631572;8704.434211776213;8719.476831390137;7945.205479452008;8321.08468068524;8386.916130838614;8426.283765879969;8449.704260350858 17:47:46 INFO - PID 28114 | |4;prototype.html;581.4098689829824;591.8342863998082;594.9732262048208;617.8177437655892;623.3828509775321;6363.936360636398;6436.839079023027;6507.6095434273975;6509.535354545225;6554.90167647485;6283.874322513547;6290.773299206657;6391.360863913606;6399.264084630269;6423.839404014902;5359.651622644516;5363.785448582052;5363.973180134094;5389.8113566025195;5417.106177480711;5069.188929771238;5212.218167274901;5314.627976041678;5368.677879327252;5400.351957765074;5145.434002259748;5169.3279873616375;5216.921746173792;5219.243209734586;5220.869478263055;5147.150720131174;5164.586833053347;5182.875021241273;5219.71291578963;5228.686278823283;4687.367205427257;4699.859004229878;4706.9764651176865;4729.408823897013;4742.834000809989;6257.498200431909;6325.9051114233325;6327.398897104814;6338.778142764981;6416.230052393696;6006.639601623873;6083.7870674526175;6091.390860913873;6103.05402662588;6121.908171377433;6849.39039325763;6855.794326170173;6858.417034552019;6867.450603951672;6872.896906546406;5007.5993920486635;5226.92159617606;5227.111391063529;5234.084035293847;5237.47625237477;6997.615131167784;7038.331358520933;7043.753468628624;7047.647617619098;7069.540479868843;5278.287431196739;5331.93361327736;5345.705986170798;5370.194470829329;5377.247185394048;5417.214503896913;5460.535854452337;5463.535599474009;5465.672059676433;5500.3949565547755;5969.432903874125;6000.939990600125;6027.758889644453;6036.939630603725;6039.335673075958;6860.108185935796;6891.483138764613;6894.310568943166;6905.482088843357;6906.102206713095;1858.7026075827803;1859.525820915658;1879.1262063140432;1887.0092052884065;1887.452638734779;1306.2750173653712;1333.1867560787912;1343.2612063365111;1346.2326473909973;1356.4845358763607;6313.337099604567;6318.873622527523;6375.394337537927;6464.482841372679;6503.902441463382;6693.765718199937;6763.628000459924;6764.289749576322;6839.62382068991;6876.312368763083;6332.68336583169;6387.489000879918;6438.163038804925;6468.288488266287;6473.155150782099;3631.9818400908357;3657.3233951719017;3681.4109742441083;3692.1508053147927;3700.481932529448;7250.347468727839;7267.927320726831;7269.454790890704;7289.635518224068;7354.558726476428;6901.896471552931;7195.964020179866;7214.386777123898;7230.674619642129;7233.132024157135;7183.209846916835;7236.312550307713;7251.4923955323675;7317.670704818296;7336.999999999894;6897.103376561015;6901.274681329667;6945.965270173617;6964.686589103604;6991.265917078634;6812.931870681428;6815.454763618799;6919.169699636076;6923.515353925177;6957.965210173917;7145.141943222752;7231.602261875647;7252.709891604277;7272.200057993722;7277.3086556777025;5325.254464375068;5351.143816989263;5351.866203344947;5378.650387724785;5397.514223719884;6597.868042639217;6667.833129202273;6912.9284960831155;6976.930230697628;6984.4761642878;6643.56816806906;6652.334766523309;6687.966560167168;6693.196816382066;6732;6601.662404091933;6612.966935165294;6635.8009259722285;6674.232463266787;6704.631245281556;6549.541532092899;6583.80248592543;6646.540779911464;6657.234418041793;6679.23188833271;6700.966495167493;6723.9327606725265;6742.393184613408;6746.898796518154;6778.93221067783;6648.202215734143;6662.533622646562;6711.932880671131;6712.295209002984;6725.697343619647 17:47:46 INFO - PID 28114 | |5;yui.html;985.1183191044012;1011.6256984915586;1014.8629934958778;1017.0846238385453;1040.661784919901;16741.665166696657;17068.231929563168;17069.829301706995;17076.060816655077;17099.82900170998;16083.919580402111;16185.109818959952;16236.350545978175;16247.106409147493;17342;1074.1245884604043;1085.137315833914;1086.364476781084;1086.4622012104019;1086.7228856641545;1029.2897900448665;1100.125400306754;1101.7906597746403;1105.8230683090708;1108.0969010256656;1154.1228666213697;1154.4170194051992;1155.202909992107;1155.5493357590547;1176.9058475321997;1128.1707944660668;1128.531659361364;1129.7006293332274;1129.836173754805;1130.762539866629;829.2826704900218;832.1179549677362;833.5790425834975;835.0480452284401;838.8448137094657;18412.90793546037;18903.527411814677;19074.52313692155;19136.330228441937;19136.330228441937;19086.713699294523;19642.90178549098;19648.214071437127;19666;19670.901645491824;16109.83890161095;16343.182840858028;16473.83526164735;16514.6697066058;16515.92646477975;3711.777293362407;3743.1390780120723;3748.9437658435145;3750.1937083527173;3750.906227344311;151315;152594.23702881415;153506.23246883805;154448;156408;15092.773608395883;15258.160801156044;15258.923705381401;15335.079895206323;15338.386464541516;34394.82802585971;35448.82275588605;35588.46617300742;35657.64342356543;35679.10802229965;9080.727578172666;9100.408473449204;9111;9121.498317592463;9236.168744813;4430.335449682573;4556.612687921497;4570.908581828345;4593.242115051046;4597.471290801601;5443.918341224885;5483.917741233885;5497.285352904177;5513.58648101386;5517.420670829585;1032.390889375272;1042.6455005298235;1057.4342726641364;1060.7666313411037;1066.4188017530464;645.3417514135556;660.5145218264572;663.2074670768482;665.5740326191242;677.3091446724313;11328;11365.09079273656;11509.136814738928;11815.468303926344;12015.579454719043;726.8370607028818;731.5939653492363;739.3493725521614;750.2197714377096;752.5559919647325;5546.805861794818;5554.1113421853115;5561;5588.30146231721;5692;147669.26165369104;148760;151164;152494;153018.23490882476;127488.36255818847;128259;128943;129983;136350;112156;112427.87572124337;114285;114836;116249.41875290738;12589.496420143458;12738.617841464771;12794.744105118032;12866.163699359511;12908.8063679043;56384.15423768729;56946.7152664234;57513.42486575081;57742.13386799117;58036.54908627318;71295.20013187299;71322.28677713365;72124;74018.25981740329;74591.62704186444;17985.460436186935;18588.7211691822;18652.253909843454;18690.626187476446;18706.812931871053;18729.625407492047;18752;18819;18880.150393232612;18925.526861828563;17339.739903901198;17636.38272660451;17639;17703.64592708113;17742.556436089202;16282.592935176715;16346.182690865648;16381.754273685667;16414.26135823867;16426.096564689058;17938.103094845468;18048.63902721912;18055.909720451313;18184.727229091837;18246.817531824512;13114.278714670403;13375.665608359868;13387.866121338662;13442.260675662541;13697.726045478836;13372.598822035354;13399.732005360032;13457.798133027816;13570.185788852701;13648.522301719393 17:47:46 INFO - PID 28114 | __end_tp_report 17:47:46 INFO - PID 28114 | __start_cc_report 17:47:46 INFO - PID 28114 | _x_x_mozilla_cycle_collect,256 17:47:46 INFO - PID 28114 | __end_cc_report 17:47:46 INFO - PID 28114 | __startTimestamp1507942066499__endTimestamp 17:47:46 INFO - PID 28114 | 17:47:46 INFO - PID 28114 | ------- Summary: start ------- 17:47:46 INFO - PID 28114 | Number of tests: 6 17:47:46 INFO - PID 28114 | 17:47:46 INFO - PID 28114 | [#0] dojo.html Cycles:165 Average:6590.86 Median:6815.22 stddev:762.07 (11.2%) stddev-sans-first:736.25 17:47:46 INFO - PID 28114 | Values: 3974.5 3982.6 4047.6 4049.6 4076.4 6525.6 6542.4 6557.3 6618.2 6646.1 6539.2 6581.2 6589.0 6594.7 6693.9 5902.9 5921.1 5964.9 5998.2 6017.2 5883.7 5892.8 5978.5 6038.1 6081.7 5980.6 5980.6 6042.6 6051.5 6060.2 5849.6 5878.5 5929.9 6052.2 6069.2 5859.5 5863.7 5910.0 5931.2 5951.6 6449.2 6460.1 6499.3 6542.3 6589.9 6929.3 7065.4 7067.2 7173.5 7184.8 7031.0 7124.4 7129.0 7135.8 7221.2 6451.5 6521.0 6643.6 6670.5 6677.3 7204.9 7208.0 7243.4 7323.7 7337.8 7015.8 7039.7 7084.5 7097.7 7111.6 7062.7 7122.5 7163.8 7171.0 7215.8 7097.1 7123.4 7133.8 7146.9 7158.1 7050.6 7056.1 7147.6 7166.2 7169.4 5264.2 5280.5 5332.6 5350.1 5355.7 4742.0 4804.0 4815.4 4839.5 4880.3 6674.3 6741.1 6779.8 6782.7 6789.0 6999.0 7089.5 7154.0 7159.0 7188.8 6582.2 6672.3 6709.7 6712.3 6713.6 5970.5 5987.9 5993.4 6023.1 6061.6 7447.1 7465.2 7496.6 7526.4 7563.2 7042.6 7056.8 7133.8 7156.2 7164.2 7389.4 7391.6 7404.3 7471.5 7532.4 7048.2 7096.3 7114.6 7124.7 7149.9 7023.1 7093.1 7168.2 7247.4 7265.0 6844.9 6921.8 6922.7 6927.1 6976.5 6752.6 6907.6 6913.1 6976.3 7002.6 6789.4 6815.2 6832.6 6838.7 6842.2 6941.1 6985.9 7003.2 7026.7 7040.7 6728.5 6734.6 6804.2 6806.2 6811.9 17:47:46 INFO - PID 28114 | 17:47:46 INFO - PID 28114 | [#1] ext.html Cycles:180 Average:46718.20 Median:3813.38 stddev:71867.54 (1884.6%) stddev-sans-first:71987.13 17:47:46 INFO - PID 28114 | Values: 990.0 1021.0 1025.2 1025.6 1026.7 41892.4 42628.6 46853.1 46926.3 46933.8 43998.0 44391.3 44465.1 44498.8 44507.8 8172.8 8313.7 8323.0 8328.5 8328.8 8738.6 8904.0 8941.6 8950.6 8958.0 8912.6 8931.9 8942.4 8950.7 8973.1 8862.6 8907.2 8946.6 8951.3 8968.8 8583.5 8634.5 8641.7 8667.1 8741.8 40272.2 40563.4 40622.2 40685.8 40694.8 3770.6 3796.3 3830.5 3839.7 3846.6 33812.3 34118.7 34130.0 34254.7 34280.1 5442.3 5557.4 5568.4 5609.5 5643.3 234150.0 235318.0 235332.0 235400.0 235411.0 54555.2 54599.0 54897.2 56830.0 57557.0 59739.4 59817.7 59904.4 59917.0 59949.7 18878.1 18961.6 19106.3 19153.1 19153.8 15485.3 15513.1 15538.8 15544.8 15561.7 16072.3 16097.4 16106.4 16119.4 16236.4 5970.2 5992.2 5998.6 6115.7 6213.3 1108.4 1117.5 1118.3 1118.8 1122.9 26331.6 26764.0 26836.9 26849.5 26858.2 1224.8 1235.7 1245.0 1248.1 1251.8 13620.7 13934.4 13968.3 14048.7 14346.2 315868.0 316467.0 316573.0 318361.0 318437.0 62954.4 63063.4 63158.4 63230.0 63378.4 1502.2 1510.4 1547.4 1558.1 1566.0 29464.0 31842.5 31908.7 31946.8 32277.2 57254.4 57431.0 57495.7 57720.0 57857.7 268305.0 268640.0 270101.0 270126.0 270177.0 39732.0 39804.8 39911.6 40067.6 40138.8 49815.8 51182.2 51458.7 51546.2 51762.0 37349.8 37354.6 37500.0 37785.0 37819.6 36873.0 37531.6 37532.6 37665.2 37933.0 41977.8 43794.3 43799.6 44067.0 44142.0 35949.8 36143.5 36250.6 36518.5 36820.6 26149.3 26562.9 26829.5 26901.9 27240.0 17:47:46 INFO - PID 28114 | 17:47:46 INFO - PID 28114 | [#2] jquery.html Cycles:180 Average:42690.25 Median:13238.73 stddev:111234.75 (840.2%) stddev-sans-first:111501.92 17:47:46 INFO - PID 28114 | Values: 609.0 635.4 636.6 654.4 662.1 20937.2 24080.6 24672.9 24853.3 25681.9 26550.6 26717.5 26750.1 26835.0 26836.2 6757.2 6777.8 6783.9 6785.2 6785.3 6579.9 6821.6 6825.2 6834.1 6835.7 6767.7 6769.8 6782.0 6790.3 6794.0 6795.3 6805.6 6815.2 6816.8 6818.8 6358.0 6370.5 6377.3 6377.4 6382.9 30436.7 32450.2 32667.7 32857.3 32893.5 2358.5 2388.5 2395.3 2395.4 2396.8 21407.9 21747.6 21873.8 21889.0 21913.3 2633.1 2662.2 2678.0 2695.5 2697.8 147976.3 148448.0 155208.0 162091.0 166995.0 16786.0 17147.9 17257.3 17468.3 17697.7 27246.2 27296.7 27436.9 27465.3 27498.6 10685.8 10827.5 10893.4 11075.2 11091.1 9765.3 9863.5 9894.6 9911.5 9925.4 10153.8 10233.6 10404.7 10463.7 10673.7 2798.9 2843.8 2888.1 2968.8 2982.3 1045.6 1077.7 1080.0 1082.3 1085.9 22898.7 23041.9 23321.3 23324.5 23467.5 1129.4 1137.2 1138.6 1148.5 1148.6 12340.2 12604.5 12942.5 13018.4 13024.7 650921.0 653060.0 657551.0 681308.0 691677.0 135099.0 141380.0 141851.0 142843.0 143198.0 1110.1 1225.7 1254.8 1269.3 1279.5 24206.9 24249.1 24316.0 24445.0 24782.8 64701.4 65691.0 65897.0 65940.3 67182.0 75048.6 77795.0 80358.0 80715.6 81100.0 16937.2 16996.9 17016.4 17118.1 17157.1 25813.5 26287.9 26454.5 26535.0 26631.3 21017.2 21243.6 21266.3 21505.9 21527.4 17845.4 17857.2 18498.5 18598.6 18852.2 20259.7 20506.7 20575.2 20608.8 22052.7 16534.3 16561.3 16593.2 16610.1 16727.8 20728.3 20960.6 21012.4 21147.8 21170.6 17:47:46 INFO - PID 28114 | 17:47:46 INFO - PID 28114 | [#3] mootools.html Cycles:180 Average:11067.39 Median:25901.61 stddev:8155.16 (31.5%) stddev-sans-first:8145.77 17:47:46 INFO - PID 28114 | Values: 1411.9 1451.8 1476.3 1482.3 1482.9 17769.3 18425.7 18434.0 18447.0 18452.3 17895.5 17916.7 17949.3 18067.7 18115.5 3142.6 3196.6 3243.2 3244.0 3249.4 3125.4 3128.3 3143.5 3143.6 3150.7 3125.2 3195.4 3196.7 3198.7 3200.6 3145.4 3167.5 3198.2 3199.8 3210.5 3055.3 3093.2 3106.5 3111.7 3130.3 17261.5 17300.3 17315.5 17334.9 17335.0 8994.6 9271.0 9342.3 9348.3 9355.8 5628.7 5891.2 6003.4 6026.0 6075.7 2073.7 2095.7 2121.6 2155.7 2179.5 31887.5 32192.4 32320.0 32406.4 32586.5 8283.5 8341.5 8342.5 8538.6 8576.0 23886.3 23919.3 23940.4 24041.0 24066.3 9052.7 9359.5 9364.0 9370.1 9372.5 7688.3 8194.7 8305.9 8348.0 8378.7 6647.5 6684.4 6686.0 6702.8 6814.6 1909.7 1994.4 2038.6 2077.2 2088.3 985.6 998.4 1002.8 1004.3 1020.3 9807.8 9888.9 10006.1 10039.4 10056.9 1066.9 1077.3 1096.2 1097.3 1099.5 5350.0 5375.4 5455.3 6422.1 6633.0 25457.1 25872.0 26179.6 26245.3 26860.6 25356.0 25756.7 25878.0 25925.2 26189.7 12942.2 12992.7 13046.6 13188.9 13225.9 9386.6 9417.0 9518.9 9551.2 9562.3 22066.3 22109.8 22170.3 22198.4 22775.8 22605.4 22805.3 23123.2 23167.4 23375.6 13947.2 14240.4 14245.8 14250.2 14263.1 14824.2 14876.1 15121.7 15195.0 15220.4 12200.1 12354.2 12500.9 12524.7 12738.4 11847.3 11893.8 11976.0 12193.5 12223.5 10882.1 11029.7 11042.4 11047.4 11059.4 8472.3 8581.9 8595.4 8704.4 8719.5 7945.2 8321.1 8386.9 8426.3 8449.7 17:47:46 INFO - PID 28114 | 17:47:46 INFO - PID 28114 | [#4] prototype.html Cycles:180 Average:5811.61 Median:6430.34 stddev:1608.61 (25.0%) stddev-sans-first:1564.49 17:47:46 INFO - PID 28114 | Values: 581.4 591.8 595.0 617.8 623.4 6363.9 6436.8 6507.6 6509.5 6554.9 6283.9 6290.8 6391.4 6399.3 6423.8 5359.7 5363.8 5364.0 5389.8 5417.1 5069.2 5212.2 5314.6 5368.7 5400.4 5145.4 5169.3 5216.9 5219.2 5220.9 5147.2 5164.6 5182.9 5219.7 5228.7 4687.4 4699.9 4707.0 4729.4 4742.8 6257.5 6325.9 6327.4 6338.8 6416.2 6006.6 6083.8 6091.4 6103.1 6121.9 6849.4 6855.8 6858.4 6867.5 6872.9 5007.6 5226.9 5227.1 5234.1 5237.5 6997.6 7038.3 7043.8 7047.6 7069.5 5278.3 5331.9 5345.7 5370.2 5377.2 5417.2 5460.5 5463.5 5465.7 5500.4 5969.4 6000.9 6027.8 6036.9 6039.3 6860.1 6891.5 6894.3 6905.5 6906.1 1858.7 1859.5 1879.1 1887.0 1887.5 1306.3 1333.2 1343.3 1346.2 1356.5 6313.3 6318.9 6375.4 6464.5 6503.9 6693.8 6763.6 6764.3 6839.6 6876.3 6332.7 6387.5 6438.2 6468.3 6473.2 3632.0 3657.3 3681.4 3692.2 3700.5 7250.3 7267.9 7269.5 7289.6 7354.6 6901.9 7196.0 7214.4 7230.7 7233.1 7183.2 7236.3 7251.5 7317.7 7337.0 6897.1 6901.3 6946.0 6964.7 6991.3 6812.9 6815.5 6919.2 6923.5 6958.0 7145.1 7231.6 7252.7 7272.2 7277.3 5325.3 5351.1 5351.9 5378.7 5397.5 6597.9 6667.8 6912.9 6976.9 6984.5 6643.6 6652.3 6688.0 6693.2 6732.0 6601.7 6613.0 6635.8 6674.2 6704.6 6549.5 6583.8 6646.5 6657.2 6679.2 6701.0 6723.9 6742.4 6746.9 6778.9 6648.2 6662.5 6711.9 6712.3 6725.7 17:47:46 INFO - PID 28114 | 17:47:46 INFO - PID 28114 | [#5] yui.html Cycles:180 Average:27648.34 Median:17072.95 stddev:41888.25 (245.3%) stddev-sans-first:41957.91 17:47:46 INFO - PID 28114 | Values: 985.1 1011.6 1014.9 1017.1 1040.7 16741.7 17068.2 17069.8 17076.1 17099.8 16083.9 16185.1 16236.4 16247.1 17342.0 1074.1 1085.1 1086.4 1086.5 1086.7 1029.3 1100.1 1101.8 1105.8 1108.1 1154.1 1154.4 1155.2 1155.5 1176.9 1128.2 1128.5 1129.7 1129.8 1130.8 829.3 832.1 833.6 835.0 838.8 18412.9 18903.5 19074.5 19136.3 19136.3 19086.7 19642.9 19648.2 19666.0 19670.9 16109.8 16343.2 16473.8 16514.7 16515.9 3711.8 3743.1 3748.9 3750.2 3750.9 151315.0 152594.2 153506.2 154448.0 156408.0 15092.8 15258.2 15258.9 15335.1 15338.4 34394.8 35448.8 35588.5 35657.6 35679.1 9080.7 9100.4 9111.0 9121.5 9236.2 4430.3 4556.6 4570.9 4593.2 4597.5 5443.9 5483.9 5497.3 5513.6 5517.4 1032.4 1042.6 1057.4 1060.8 1066.4 645.3 660.5 663.2 665.6 677.3 11328.0 11365.1 11509.1 11815.5 12015.6 726.8 731.6 739.3 750.2 752.6 5546.8 5554.1 5561.0 5588.3 5692.0 147669.3 148760.0 151164.0 152494.0 153018.2 127488.4 128259.0 128943.0 129983.0 136350.0 112156.0 112427.9 114285.0 114836.0 116249.4 12589.5 12738.6 12794.7 12866.2 12908.8 56384.2 56946.7 57513.4 57742.1 58036.5 71295.2 71322.3 72124.0 74018.3 74591.6 17985.5 18588.7 18652.3 18690.6 18706.8 18729.6 18752.0 18819.0 18880.2 18925.5 17339.7 17636.4 17639.0 17703.6 17742.6 16282.6 16346.2 16381.8 16414.3 16426.1 17938.1 18048.6 18055.9 18184.7 18246.8 13114.3 13375.7 13387.9 13442.3 13697.7 13372.6 13399.7 13457.8 13570.2 13648.5 17:47:46 INFO - PID 28114 | -------- Summary: end -------- 17:47:46 INFO - PID 28114 | 17:47:47 INFO - TEST-INFO | 28114: exit 0 17:47:47 INFO - TEST-OK | dromaeo_css | took 1106249ms 17:47:47 INFO - TEST-START | kraken 17:47:47 INFO - Initialising browser for kraken test... 17:47:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33536/getInfo.html -profile /tmp/tmpBQTjxv/profile 17:47:47 INFO - TEST-INFO | started process 28474 (/builds/slave/test/build/application/firefox/firefox http://localhost:33536/getInfo.html) 17:47:51 INFO - TEST-INFO | 28474: exit 0 17:47:51 INFO - Browser initialized. 17:47:51 INFO - Running cycle 1/1 for kraken test... 17:47:51 INFO - Using env: {'DISPLAY': ':0', 17:47:51 INFO - 'HOME': '/home/cltbld', 17:47:51 INFO - 'JSGC_DISABLE_POISONING': '1', 17:47:51 INFO - 'LANG': 'en_US.UTF-8', 17:47:51 INFO - 'LANGUAGE': 'en_US:en', 17:47:51 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:47:51 INFO - 'LOGNAME': 'cltbld', 17:47:51 INFO - 'MAIL': '/var/mail/cltbld', 17:47:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:47:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:47:51 INFO - 'MOZ_CRASHREPORTER': '1', 17:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:51 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:47:51 INFO - 'MOZ_NO_REMOTE': '1', 17:47:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:51 INFO - 'NO_EM_RESTART': '1', 17:47:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:51 INFO - 'PWD': '/builds/slave/test', 17:47:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:47:51 INFO - 'RUST_BACKTRACE': 'full', 17:47:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:47:51 INFO - 'SHELL': '/bin/bash', 17:47:51 INFO - 'SHLVL': '1', 17:47:51 INFO - 'TERM': 'linux', 17:47:51 INFO - 'TMOUT': '86400', 17:47:51 INFO - 'USER': 'cltbld', 17:47:51 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756', 17:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:51 INFO - '_': '/tools/buildbot/bin/python'} 17:47:51 INFO - TEST-INFO | started process 28705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBQTjxv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:47:52 INFO - PID 28705 | 17:47:52 INFO - PID 28705 | (/builds/slave/test/build/application/firefox/firefox:28753): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:47:52 INFO - PID 28705 | 17:48:02 INFO - PID 28705 | RSS: Main: 143552512 17:48:02 INFO - PID 28705 | 17:48:05 INFO - PID 28705 | Cycle 1(1): loaded http://localhost:33536/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33536/tests/kraken/driver.html?testName=audio-beat-detection) 17:48:05 INFO - PID 28705 | RSS: Main: 149028864 17:48:05 INFO - PID 28705 | 17:48:08 INFO - PID 28705 | Cycle 1(1): loaded http://localhost:33536/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33536/tests/kraken/driver.html?testName=audio-dft) 17:48:09 INFO - PID 28705 | RSS: Main: 149929984 17:48:09 INFO - PID 28705 | 17:48:11 INFO - PID 28705 | Cycle 1(1): loaded http://localhost:33536/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33536/tests/kraken/driver.html?testName=audio-fft) 17:48:12 INFO - PID 28705 | RSS: Main: 151236608 17:48:12 INFO - PID 28705 | 17:48:14 INFO - PID 28705 | Cycle 1(1): loaded http://localhost:33536/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33536/tests/kraken/driver.html?testName=audio-oscillator) 17:48:15 INFO - PID 28705 | RSS: Main: 151052288 17:48:15 INFO - PID 28705 | 17:48:17 INFO - PID 28705 | Cycle 1(1): loaded http://localhost:33536/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33536/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:48:17 INFO - PID 28705 | RSS: Main: 151662592 17:48:17 INFO - PID 28705 | 17:48:20 INFO - PID 28705 | Cycle 1(1): loaded http://localhost:33536/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33536/tests/kraken/driver.html?testName=imaging-darkroom) 17:48:21 INFO - PID 28705 | RSS: Main: 151019520 17:48:21 INFO - PID 28705 | 17:48:24 INFO - PID 28705 | Cycle 1(1): loaded http://localhost:33536/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33536/tests/kraken/driver.html?testName=imaging-desaturate) 17:48:25 INFO - PID 28705 | RSS: Main: 153530368 17:48:25 INFO - PID 28705 | 17:48:28 INFO - PID 28705 | Cycle 1(1): loaded http://localhost:33536/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33536/tests/kraken/driver.html?testName=json-parse-financial) 17:48:29 INFO - PID 28705 | RSS: Main: 153907200 17:48:29 INFO - PID 28705 | 17:48:30 INFO - PID 28705 | Cycle 1(1): loaded http://localhost:33536/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33536/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:48:31 INFO - PID 28705 | RSS: Main: 153681920 17:48:31 INFO - PID 28705 | 17:48:32 INFO - PID 28705 | Cycle 1(1): loaded http://localhost:33536/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33536/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:48:33 INFO - PID 28705 | RSS: Main: 153808896 17:48:33 INFO - PID 28705 | 17:48:35 INFO - PID 28705 | Cycle 1(1): loaded http://localhost:33536/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33536/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:48:35 INFO - PID 28705 | RSS: Main: 150622208 17:48:35 INFO - PID 28705 | 17:48:38 INFO - PID 28705 | Cycle 1(1): loaded http://localhost:33536/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33536/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:48:38 INFO - PID 28705 | RSS: Main: 151166976 17:48:38 INFO - PID 28705 | 17:48:41 INFO - PID 28705 | Cycle 1(1): loaded http://localhost:33536/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33536/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:48:42 INFO - PID 28705 | RSS: Main: 152195072 17:48:42 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | Cycle 1(1): loaded http://localhost:33536/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33536/tests/kraken/driver.html?testName=ai-astar) 17:48:43 INFO - PID 28705 | RSS: Main: 152903680 17:48:43 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | __start_tp_report 17:48:43 INFO - PID 28705 | _x_x_mozilla_page_load 17:48:43 INFO - PID 28705 | _x_x_mozilla_page_load_details 17:48:43 INFO - PID 28705 | |i|pagename|runs| 17:48:43 INFO - PID 28705 | |0;ai-astar;103;105;105;107;105;95;105;107;105;109 17:48:43 INFO - PID 28705 | |1;audio-beat-detection;110;110;111;110;110;111;109;138;108;114 17:48:43 INFO - PID 28705 | |2;audio-dft;162;162;162;162;161;161;160;162;161;161 17:48:43 INFO - PID 28705 | |3;audio-fft;72;74;74;74;73;73;72;74;72;73 17:48:43 INFO - PID 28705 | |4;audio-oscillator;77;77;76;77;77;78;78;77;77;75 17:48:43 INFO - PID 28705 | |5;imaging-gaussian-blur;113;113;115;113;113;113;113;111;114;114 17:48:43 INFO - PID 28705 | |6;imaging-darkroom;149;148;150;149;149;150;148;148;149;148 17:48:43 INFO - PID 28705 | |7;imaging-desaturate;94;95;99;94;93;95;94;95;95;94 17:48:43 INFO - PID 28705 | |8;json-parse-financial;44;42;43;43;46;43;46;42;41;42 17:48:43 INFO - PID 28705 | |9;json-stringify-tinderbox;37;37;38;38;38;37;38;38;37;38 17:48:43 INFO - PID 28705 | |10;stanford-crypto-aes;72;73;69;70;75;70;83;72;69;67 17:48:43 INFO - PID 28705 | |11;stanford-crypto-ccm;103;110;98;102;108;104;109;106;101;106 17:48:43 INFO - PID 28705 | |12;stanford-crypto-pbkdf2;146;147;147;151;160;147;145;149;149;150 17:48:43 INFO - PID 28705 | |13;stanford-crypto-sha256-iterative;57;56;58;58;62;65;58;57;60;59 17:48:43 INFO - PID 28705 | __end_tp_report 17:48:43 INFO - PID 28705 | __start_cc_report 17:48:43 INFO - PID 28705 | _x_x_mozilla_cycle_collect,676 17:48:43 INFO - PID 28705 | __end_cc_report 17:48:43 INFO - PID 28705 | __startTimestamp1507942123945__endTimestamp 17:48:43 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | ------- Summary: start ------- 17:48:43 INFO - PID 28705 | Number of tests: 14 17:48:43 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | [#0] ai-astar Cycles:10 Average:104.60 Median:106.00 stddev:3.75 (3.5%) stddev-sans-first:3.93 17:48:43 INFO - PID 28705 | Values: 103.0 105.0 105.0 107.0 105.0 95.0 105.0 107.0 105.0 109.0 17:48:43 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | [#1] audio-beat-detection Cycles:10 Average:113.10 Median:110.50 stddev:8.89 (8.0%) stddev-sans-first:9.36 17:48:43 INFO - PID 28705 | Values: 110.0 110.0 111.0 110.0 110.0 111.0 109.0 138.0 108.0 114.0 17:48:43 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 17:48:43 INFO - PID 28705 | Values: 162.0 162.0 162.0 162.0 161.0 161.0 160.0 162.0 161.0 161.0 17:48:43 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | [#3] audio-fft Cycles:10 Average:73.10 Median:73.50 stddev:0.88 (1.2%) stddev-sans-first:0.83 17:48:43 INFO - PID 28705 | Values: 72.0 74.0 74.0 74.0 73.0 73.0 72.0 74.0 72.0 73.0 17:48:43 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:77.00 stddev:0.88 (1.1%) stddev-sans-first:0.93 17:48:43 INFO - PID 28705 | Values: 77.0 77.0 76.0 77.0 77.0 78.0 78.0 77.0 77.0 75.0 17:48:43 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:1.03 (0.9%) stddev-sans-first:1.09 17:48:43 INFO - PID 28705 | Values: 113.0 113.0 115.0 113.0 113.0 113.0 113.0 111.0 114.0 114.0 17:48:43 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 17:48:43 INFO - PID 28705 | Values: 149.0 148.0 150.0 149.0 149.0 150.0 148.0 148.0 149.0 148.0 17:48:43 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:1.62 (1.7%) stddev-sans-first:1.69 17:48:43 INFO - PID 28705 | Values: 94.0 95.0 99.0 94.0 93.0 95.0 94.0 95.0 95.0 94.0 17:48:43 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | [#8] json-parse-financial Cycles:10 Average:43.20 Median:43.00 stddev:1.69 (3.9%) stddev-sans-first:1.76 17:48:43 INFO - PID 28705 | Values: 44.0 42.0 43.0 43.0 46.0 43.0 46.0 42.0 41.0 42.0 17:48:43 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | [#9] json-stringify-tinderbox Cycles:10 Average:37.60 Median:38.00 stddev:0.52 (1.4%) stddev-sans-first:0.50 17:48:43 INFO - PID 28705 | Values: 37.0 37.0 38.0 38.0 38.0 37.0 38.0 38.0 37.0 38.0 17:48:43 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | [#10] stanford-crypto-aes Cycles:10 Average:72.00 Median:72.00 stddev:4.50 (6.2%) stddev-sans-first:4.77 17:48:43 INFO - PID 28705 | Values: 72.0 73.0 69.0 70.0 75.0 70.0 83.0 72.0 69.0 67.0 17:48:43 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | [#11] stanford-crypto-ccm Cycles:10 Average:104.70 Median:107.00 stddev:3.80 (3.6%) stddev-sans-first:3.98 17:48:43 INFO - PID 28705 | Values: 103.0 110.0 98.0 102.0 108.0 104.0 109.0 106.0 101.0 106.0 17:48:43 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.10 Median:149.00 stddev:4.25 (2.9%) stddev-sans-first:4.36 17:48:43 INFO - PID 28705 | Values: 146.0 147.0 147.0 151.0 160.0 147.0 145.0 149.0 149.0 150.0 17:48:43 INFO - PID 28705 | 17:48:43 INFO - PID 28705 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.00 Median:58.50 stddev:2.71 (4.6%) stddev-sans-first:2.77 17:48:43 INFO - PID 28705 | Values: 57.0 56.0 58.0 58.0 62.0 65.0 58.0 57.0 60.0 59.0 17:48:43 INFO - PID 28705 | -------- Summary: end -------- 17:48:43 INFO - PID 28705 | 17:48:44 INFO - PID 28705 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:48:44 INFO - TEST-INFO | 28705: exit 0 17:48:44 INFO - TEST-OK | kraken | took 57478ms 17:48:44 INFO - SUITE-END | took 1163s 17:48:44 INFO - Completed test suite (00:19:23) 17:48:44 INFO - javascript benchmark 17:48:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9429.325643155977, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3974.463447434597, 3982.6216509431597, 4047.5750046245125, 4049.574794646562, 4076.429299898017, 6525.641089740062, 6542.443892269157, 6557.311482294362, 6618.205815302158, 6646.136002319698, 6539.247986481556, 6581.177352830896, 6589.0, 6594.703238354274, 6693.899591506131, 5902.852428689295, 5921.141434491996, 5964.910526342087, 5998.190244317005, 6017.247844019497, 5883.735231914553, 5892.793752218673, 5978.461938425541, 6038.124471951564, 6081.665508397058, 5980.581359304851, 5980.6112602680905, 6042.637441753487, 6051.485623721989, 6060.151578778975, 5849.561282903799, 5878.50032747217, 5929.851753706192, 6052.21321228242, 6069.180660610805, 5859.501942334907, 5863.677497737623, 5909.9704501477645, 5931.199288096095, 5951.553633477506, 6449.161608990848, 6460.095586617877, 6499.2850786413455, 6542.34576542342, 6589.901151482732, 6929.341712537301, 7065.399441047466, 7067.22260551339, 7173.497855150142, 7184.820379490555, 7031.0, 7124.43004559634, 7129.037579926696, 7135.750248741321, 7221.169565499982, 6451.483881289532, 6521.0, 6643.56816806906, 6670.4997125215805, 6677.298883617199, 7204.92795072053, 7208.026916366223, 7243.384312333405, 7323.707051717978, 7337.816554586071, 7015.824604384829, 7039.683214255371, 7084.4686648501565, 7097.680604372816, 7111.573305601681, 7062.717491300393, 7122.465815063787, 7163.820904477326, 7170.96414517924, 7215.819604509824, 7097.148342198969, 7123.430125590044, 7133.750318738819, 7146.892796608055, 7158.141023077264, 7050.612216328152, 7056.082709247765, 7147.571145731273, 7166.211716711157, 7169.426445884421, 5264.184051472028, 5280.471952804689, 5332.626716129834, 5350.143976963667, 5355.678659280456, 4741.952580474152, 4803.951960480351, 4815.446223684251, 4839.467658557556, 4880.267959805987, 6674.332566743286, 6741.056252124707, 6779.762708305186, 6782.660866956632, 6789.049533065375, 6999.0, 7089.468289878279, 7153.964230178815, 7158.964205178941, 7188.820279493055, 6582.210134783857, 6672.266050734415, 6709.664516774142, 6712.295209003082, 6713.56361836479, 5970.462658360769, 5987.940120598738, 5993.370696076936, 6023.126646636213, 6061.636301821904, 7447.069116360455, 7465.216152304039, 7496.587687677121, 7526.360259378014, 7563.205863384265, 7042.577445353295, 7056.82357941035, 7133.821654458472, 7156.177039640508, 7164.247753985756, 7389.445791565547, 7391.556506609406, 7404.296591823768, 7471.514351567131, 7532.43506736986, 7048.154221493453, 7096.325849044332, 7114.644267786486, 7124.679389427384, 7149.85700285981, 7023.086998690138, 7093.113360829896, 7168.17565979919, 7247.420206383371, 7265.0, 6844.863102737818, 6921.792346229621, 6922.688479018356, 6927.064846245894, 6976.5465244758925, 6752.561083529751, 6907.585544867324, 6913.10129683138, 6976.267491913276, 7002.649867506706, 6789.422899053636, 6815.216250131299, 6832.555883867532, 6838.692258848264, 6842.24735279109, 6941.097657304518, 6985.895211571728, 7003.229644739176, 7026.683799229149, 7040.718371265297, 6728.461723062242, 6734.595924244365, 6804.183497980274, 6806.18325800907, 6811.89782153278], "value": 6540.06331302268, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [990.0297708245919, 1020.9897901020992, 1025.2105878473571, 1025.6307729217485, 1026.7022563456599, 41892.37161442577, 42628.57371426285, 46853.062938741205, 46926.2961055584, 46933.765331173294, 43998.0, 44391.334129988, 44465.110697786025, 44498.77750611251, 44507.77746111273, 8172.795680108, 8313.667453301861, 8323.001239851195, 8328.458650187718, 8328.833423331529, 8738.606762695694, 8903.955480222623, 8941.64233430662, 8950.597223124974, 8958.0, 8912.598933048028, 8931.866022009675, 8942.374033817636, 8950.731478055635, 8973.147550982647, 8862.645494180257, 8907.242884354806, 8946.597403116843, 8951.328650351184, 8968.820623587491, 8583.484990900504, 8634.481931084092, 8641.697540586112, 8667.133286671346, 8741.7814554636, 40272.19455610871, 40563.39154912678, 40622.18755624871, 40685.79657101695, 40694.796526017475, 3770.604086570898, 3796.2976849282695, 3830.4637350770913, 3839.6928245740273, 3846.576876543578, 33812.32375352479, 34118.65881341205, 34130.0, 34254.65745342564, 34280.14299642504, 5442.319710036246, 5557.360903496109, 5568.3596386415675, 5609.467100625475, 5643.294588176478, 234150.0, 235318.0, 235332.0, 235400.0, 235411.0, 54555.18167227495, 54599.0, 54897.176542351895, 56830.0, 57557.0, 59739.40260597338, 59817.700911495165, 59904.400955989884, 59917.0, 59949.70025149846, 18878.056097195084, 18961.620767584573, 19106.33127840519, 19153.13810878486, 19153.80846191548, 15485.30316135754, 15513.06921584686, 15538.844611553966, 15544.844551554339, 15561.688766224612, 16072.276747546388, 16097.436589719304, 16106.436274730328, 16119.355225790838, 16236.431724889571, 5970.223870896755, 5992.191054207713, 5998.610090344201, 6115.724792384353, 6213.254409470802, 1108.4346983038708, 1117.5082963496036, 1118.2507719827736, 1118.8433619293305, 1122.8708698499777, 26331.605025924626, 26764.0, 26836.865815670797, 26849.463010739677, 26858.194254172406, 1224.8224007518859, 1235.7034311765112, 1245.0413181849924, 1248.1013670157472, 1251.7559075980278, 13620.65948351299, 13934.442622294995, 13968.301584920713, 14048.71902561943, 14346.21095839718, 315868.0, 316467.0, 316573.0, 318361.0, 318437.0, 62954.370456295765, 63063.36936630575, 63158.36841631617, 63230.0, 63378.36621633817, 1502.1512845242403, 1510.3958416633434, 1547.4274518428028, 1558.1274486287716, 1565.9530214093595, 29464.0, 31842.54397969575, 31908.680913190572, 31946.84026579852, 32277.193070173435, 57254.42745572491, 57431.0, 57495.712521437126, 57720.0, 57857.710711446176, 268305.0, 268640.0, 270101.0, 270126.0, 270177.0, 39732.0, 39804.800975994935, 39911.60088399079, 40067.59932400638, 40138.79930600328, 49815.75092124516, 51182.232266516774, 51458.742706286226, 51546.22680659718, 51762.0, 37349.81325093466, 37354.626453735116, 37500.0, 37785.0, 37819.62180378161, 36873.0, 37531.624683752816, 37532.624673752915, 37665.2466950654, 37933.0, 41977.790111049246, 43794.34308485311, 43799.56200438082, 44067.0, 44142.0, 35949.82025089858, 36143.45784813177, 36250.63749362472, 36518.4522232172, 36820.63179368172, 26149.346266343495, 26562.86718566472, 26829.463410731285, 26901.865490672422, 27240.0], "value": 19975.302685141287, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.9939100608996, 635.3519410201594, 636.5925807483209, 654.3718030690537, 662.0697919423209, 20937.16251349948, 24080.638790418136, 24672.87663561682, 24853.254402367937, 25681.871590642066, 26550.601740973852, 26717.465650686976, 26750.063747768832, 26835.0, 26836.19491415256, 6757.222919364287, 6777.7966661, 6783.93216067838, 6785.1518560179975, 6785.25362210159, 6579.868402631944, 6821.624810635413, 6825.215100263459, 6834.111565496479, 6835.658217089151, 6767.729290828361, 6769.830754231134, 6781.966090169542, 6790.253072162058, 6794.0, 6795.252522222551, 6805.625690587016, 6815.216250131224, 6816.761413350534, 6818.761343352959, 6358.0, 6370.490360771128, 6377.2666143393635, 6377.362263773632, 6382.904256436157, 30436.69563304383, 32450.18874528132, 32667.6733232667, 32857.34285314304, 32893.50659740106, 2358.5282943411385, 2388.5461762265113, 2395.2574701842486, 2395.4250979764906, 2396.8202384821034, 21407.892960535253, 21747.565048698936, 21873.78126218749, 21889.0, 21913.342599721873, 2633.0784225520915, 2662.188032650041, 2677.9866100669565, 2695.460907818444, 2697.824641398303, 147976.2601186998, 148448.0, 155208.0, 162091.0, 166995.0, 16786.0, 17147.884507718307, 17257.309707611807, 17468.301267949395, 17697.734533982002, 27246.182614521596, 27296.727032729417, 27436.862815685792, 27465.31336716598, 27498.587521187197, 10685.786284274427, 10827.458627068616, 10893.400862952456, 11075.224734268684, 11091.059064663652, 9765.267604929517, 9863.506824658738, 9894.60421583143, 9911.504424778732, 9925.3548519346, 10153.847692284622, 10233.641822536176, 10404.739881502872, 10463.68608941733, 10673.679789606324, 2798.874050667725, 2843.843588602647, 2888.1479963410843, 2968.807027543246, 2982.2544363909024, 1045.6264280084167, 1077.7305673581604, 1079.983800242997, 1082.2910993299402, 1085.8751243606928, 22898.65652015221, 23041.88479057594, 23321.300360989197, 23324.533509329718, 23467.53064938726, 1129.4296380327883, 1137.1585027080066, 1138.635636596298, 1148.5463242019355, 1148.6381789736206, 12340.197887137307, 12604.495820167274, 12942.482300708054, 13018.414171362312, 13024.674383140307, 650921.0, 653060.0, 657551.0, 681308.0, 691677.0, 135099.0, 141380.0, 141851.0, 142843.0, 143198.0, 1110.117091157126, 1225.6935766058486, 1254.7615952968906, 1269.282855186835, 1279.5329704657734, 24206.878965605058, 24249.07803400426, 24316.0, 24445.0, 24782.752172478766, 64701.352986471415, 65691.0, 65896.99999999808, 65940.34059659534, 67182.0, 75048.62475687805, 77795.0, 80358.0, 80715.59642201751, 81100.0, 16937.237824298183, 16996.915015424845, 17016.404425845038, 17118.14409279556, 17157.142142893055, 25813.483730325665, 26287.868560657073, 26454.470910582066, 26535.0, 26631.33421664474, 21017.159313627897, 21243.575128497036, 21266.25568105109, 21505.892470537547, 21527.354179374644, 17845.37541186052, 17857.196426160594, 18498.537536561154, 18598.628027439645, 18852.245910163987, 20259.696104558738, 20506.69239961372, 20575.176992920115, 20608.793912061286, 22052.669209962183, 16534.25595848214, 16561.25474353633, 16593.170341482637, 16610.086445245626, 16727.832721673116, 20728.274510392668, 20960.580788384454, 21012.369628911158, 21147.78852211458, 21170.57658846845], "value": 13428.253990691876, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1411.858814118588, 1451.7967484552162, 1476.291380137534, 1482.3181336585171, 1482.948096816611, 17769.289228430862, 18425.723614145783, 18434.0, 18446.98541580214, 18452.261909523604, 17895.463136105904, 17916.731249031276, 17949.28202871887, 18067.72898406525, 18115.54711132219, 3142.5914631097926, 3196.5524826524306, 3243.2054146734085, 3244.043007312848, 3249.382617302705, 3125.4374212641715, 3128.296133369985, 3143.497040473513, 3143.622765268171, 3150.732187764043, 3125.1718294651937, 3195.4407978603767, 3196.6643502432257, 3198.6641402652735, 3200.5519227308196, 3145.418097651942, 3167.4615315396322, 3198.184462961953, 3199.8240096794666, 3210.4702724050503, 3055.2972816252163, 3093.180307218589, 3106.518489634088, 3111.735502482292, 3130.3426280481126, 17261.482155535356, 17300.307987680477, 17315.480535583953, 17334.91332543342, 17335.04657243851, 8994.595243214071, 9270.953645231799, 9342.2526197904, 9348.252139828797, 9355.76610584734, 5628.662280263156, 5891.234139561872, 6003.429674180946, 6026.0, 6075.665838378887, 2073.7200477935435, 2095.7485101787884, 2121.63932131538, 2155.719756431654, 2179.5422961178174, 31887.52168717471, 32192.35615287681, 32320.0, 32406.351872962645, 32586.511202331985, 8283.461574997726, 8341.499510029418, 8342.541160236124, 8538.573071346407, 8576.0, 23886.283411497683, 23919.282421527383, 23940.40148996289, 24041.0, 24066.278011659677, 9052.728418147466, 9359.532023398802, 9364.0, 9370.062993700712, 9372.531373431437, 7688.269614386624, 8194.672213111528, 8305.916940830635, 8348.0, 8378.664853405917, 6647.501437392215, 6684.364985326483, 6685.966570167118, 6702.798916032527, 6814.557053791487, 1909.6658084835376, 1994.411648563677, 2038.5922815436973, 2077.2418067405592, 2088.2586681727767, 985.6353149334792, 998.3859926145368, 1002.8295189817749, 1004.2518323848633, 1020.2552136940076, 9807.803843923224, 9888.901110988942, 10006.09945104944, 10039.4478303694, 10056.899431005742, 1066.8773091094467, 1077.3051381858656, 1096.2162054131175, 1097.3415950429837, 1099.5052226498108, 5349.973250133802, 5375.435579264199, 5455.34535855692, 6422.100905873182, 6633.038209459602, 25457.10900118487, 25871.96512139531, 26179.607305890426, 26245.34386640349, 26860.59709104326, 25356.0, 25756.742432575433, 25878.0, 25925.22224333273, 26189.73810261911, 12942.158759680591, 12992.740145196854, 13046.608601741962, 13188.868111318763, 13225.933870330588, 9386.624535018524, 9416.95291523538, 9518.857217141609, 9551.235901128031, 9562.28282878773, 22066.338009859086, 22109.77890221077, 22170.334889952683, 22198.44610877223, 22775.772242277366, 22605.43486412853, 22805.31584052481, 23123.190688325827, 23167.420814479774, 23375.649365259196, 13947.16317020982, 14240.359183836545, 14245.786313205517, 14250.216238106588, 14263.144211347353, 14824.184669843262, 14876.107433554022, 15121.697566048837, 15195.0, 15220.391184352502, 12200.084993625691, 12354.196977196454, 12500.874991250335, 12524.686882828002, 12738.426770795151, 11847.289162650268, 11893.821592675944, 11976.0, 12193.451294691937, 12223.511059557874, 10882.129429645767, 11029.669109926715, 11042.392668403316, 11047.392393418439, 11059.391733454737, 8472.322214222724, 8581.91418085836, 8595.44129631572, 8704.434211776213, 8719.476831390137, 7945.205479452008, 8321.08468068524, 8386.916130838614, 8426.283765879969, 8449.704260350858], "value": 7819.194226527129, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.4098689829824, 591.8342863998082, 594.9732262048208, 617.8177437655892, 623.3828509775321, 6363.936360636398, 6436.839079023027, 6507.6095434273975, 6509.535354545225, 6554.90167647485, 6283.874322513547, 6290.773299206657, 6391.360863913606, 6399.264084630269, 6423.839404014902, 5359.651622644516, 5363.785448582052, 5363.973180134094, 5389.8113566025195, 5417.106177480711, 5069.188929771238, 5212.218167274901, 5314.627976041678, 5368.677879327252, 5400.351957765074, 5145.434002259748, 5169.3279873616375, 5216.921746173792, 5219.243209734586, 5220.869478263055, 5147.150720131174, 5164.586833053347, 5182.875021241273, 5219.71291578963, 5228.686278823283, 4687.367205427257, 4699.859004229878, 4706.9764651176865, 4729.408823897013, 4742.834000809989, 6257.498200431909, 6325.9051114233325, 6327.398897104814, 6338.778142764981, 6416.230052393696, 6006.639601623873, 6083.7870674526175, 6091.390860913873, 6103.05402662588, 6121.908171377433, 6849.39039325763, 6855.794326170173, 6858.417034552019, 6867.450603951672, 6872.896906546406, 5007.5993920486635, 5226.92159617606, 5227.111391063529, 5234.084035293847, 5237.47625237477, 6997.615131167784, 7038.331358520933, 7043.753468628624, 7047.647617619098, 7069.540479868843, 5278.287431196739, 5331.93361327736, 5345.705986170798, 5370.194470829329, 5377.247185394048, 5417.214503896913, 5460.535854452337, 5463.535599474009, 5465.672059676433, 5500.3949565547755, 5969.432903874125, 6000.939990600125, 6027.758889644453, 6036.939630603725, 6039.335673075958, 6860.108185935796, 6891.483138764613, 6894.310568943166, 6905.482088843357, 6906.102206713095, 1858.7026075827803, 1859.525820915658, 1879.1262063140432, 1887.0092052884065, 1887.452638734779, 1306.2750173653712, 1333.1867560787912, 1343.2612063365111, 1346.2326473909973, 1356.4845358763607, 6313.337099604567, 6318.873622527523, 6375.394337537927, 6464.482841372679, 6503.902441463382, 6693.765718199937, 6763.628000459924, 6764.289749576322, 6839.62382068991, 6876.312368763083, 6332.68336583169, 6387.489000879918, 6438.163038804925, 6468.288488266287, 6473.155150782099, 3631.9818400908357, 3657.3233951719017, 3681.4109742441083, 3692.1508053147927, 3700.481932529448, 7250.347468727839, 7267.927320726831, 7269.454790890704, 7289.635518224068, 7354.558726476428, 6901.896471552931, 7195.964020179866, 7214.386777123898, 7230.674619642129, 7233.132024157135, 7183.209846916835, 7236.312550307713, 7251.4923955323675, 7317.670704818296, 7336.999999999894, 6897.103376561015, 6901.274681329667, 6945.965270173617, 6964.686589103604, 6991.265917078634, 6812.931870681428, 6815.454763618799, 6919.169699636076, 6923.515353925177, 6957.965210173917, 7145.141943222752, 7231.602261875647, 7252.709891604277, 7272.200057993722, 7277.3086556777025, 5325.254464375068, 5351.143816989263, 5351.866203344947, 5378.650387724785, 5397.514223719884, 6597.868042639217, 6667.833129202273, 6912.9284960831155, 6976.930230697628, 6984.4761642878, 6643.56816806906, 6652.334766523309, 6687.966560167168, 6693.196816382066, 6732.0, 6601.662404091933, 6612.966935165294, 6635.8009259722285, 6674.232463266787, 6704.631245281556, 6549.541532092899, 6583.80248592543, 6646.540779911464, 6657.234418041793, 6679.23188833271, 6700.966495167493, 6723.9327606725265, 6742.393184613408, 6746.898796518154, 6778.93221067783, 6648.202215734143, 6662.533622646562, 6711.932880671131, 6712.295209002984, 6725.697343619647], "value": 5353.418121499926, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [985.1183191044012, 1011.6256984915586, 1014.8629934958778, 1017.0846238385453, 1040.661784919901, 16741.665166696657, 17068.231929563168, 17069.829301706995, 17076.060816655077, 17099.82900170998, 16083.919580402111, 16185.109818959952, 16236.350545978175, 16247.106409147493, 17342.0, 1074.1245884604043, 1085.137315833914, 1086.364476781084, 1086.4622012104019, 1086.7228856641545, 1029.2897900448665, 1100.125400306754, 1101.7906597746403, 1105.8230683090708, 1108.0969010256656, 1154.1228666213697, 1154.4170194051992, 1155.202909992107, 1155.5493357590547, 1176.9058475321997, 1128.1707944660668, 1128.531659361364, 1129.7006293332274, 1129.836173754805, 1130.762539866629, 829.2826704900218, 832.1179549677362, 833.5790425834975, 835.0480452284401, 838.8448137094657, 18412.90793546037, 18903.527411814677, 19074.52313692155, 19136.330228441937, 19136.330228441937, 19086.713699294523, 19642.90178549098, 19648.214071437127, 19666.0, 19670.901645491824, 16109.83890161095, 16343.182840858028, 16473.83526164735, 16514.6697066058, 16515.92646477975, 3711.777293362407, 3743.1390780120723, 3748.9437658435145, 3750.1937083527173, 3750.906227344311, 151315.0, 152594.23702881415, 153506.23246883805, 154448.0, 156408.0, 15092.773608395883, 15258.160801156044, 15258.923705381401, 15335.079895206323, 15338.386464541516, 34394.82802585971, 35448.82275588605, 35588.46617300742, 35657.64342356543, 35679.10802229965, 9080.727578172666, 9100.408473449204, 9111.0, 9121.498317592463, 9236.168744813, 4430.335449682573, 4556.612687921497, 4570.908581828345, 4593.242115051046, 4597.471290801601, 5443.918341224885, 5483.917741233885, 5497.285352904177, 5513.58648101386, 5517.420670829585, 1032.390889375272, 1042.6455005298235, 1057.4342726641364, 1060.7666313411037, 1066.4188017530464, 645.3417514135556, 660.5145218264572, 663.2074670768482, 665.5740326191242, 677.3091446724313, 11328.0, 11365.09079273656, 11509.136814738928, 11815.468303926344, 12015.579454719043, 726.8370607028818, 731.5939653492363, 739.3493725521614, 750.2197714377096, 752.5559919647325, 5546.805861794818, 5554.1113421853115, 5561.0, 5588.30146231721, 5692.0, 147669.26165369104, 148760.0, 151164.0, 152494.0, 153018.23490882476, 127488.36255818847, 128259.0, 128943.0, 129983.0, 136350.0, 112156.0, 112427.87572124337, 114285.0, 114836.0, 116249.41875290738, 12589.496420143458, 12738.617841464771, 12794.744105118032, 12866.163699359511, 12908.8063679043, 56384.15423768729, 56946.7152664234, 57513.42486575081, 57742.13386799117, 58036.54908627318, 71295.20013187299, 71322.28677713365, 72124.0, 74018.25981740329, 74591.62704186444, 17985.460436186935, 18588.7211691822, 18652.253909843454, 18690.626187476446, 18706.812931871053, 18729.625407492047, 18752.0, 18819.0, 18880.150393232612, 18925.526861828563, 17339.739903901198, 17636.38272660451, 17639.0, 17703.64592708113, 17742.556436089202, 16282.592935176715, 16346.182690865648, 16381.754273685667, 16414.26135823867, 16426.096564689058, 17938.103094845468, 18048.63902721912, 18055.909720451313, 18184.727229091837, 18246.817531824512, 13114.278714670403, 13375.665608359868, 13387.866121338662, 13442.260675662541, 13697.726045478836, 13372.598822035354, 13399.732005360032, 13457.798133027816, 13570.185788852701, 13648.522301719393], "value": 9571.270595114109, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1351.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 105.0, 105.0, 107.0, 105.0, 95.0, 105.0, 107.0, 105.0, 109.0], "value": 104.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 109.0, 138.0, 108.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 161.0, 161.0, 160.0, 162.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 74.0, 74.0, 73.0, 73.0, 72.0, 74.0, 72.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 77.0, 77.0, 78.0, 78.0, 77.0, 77.0, 75.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 115.0, 113.0, 113.0, 113.0, 113.0, 111.0, 114.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 150.0, 149.0, 149.0, 150.0, 148.0, 148.0, 149.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 99.0, 94.0, 93.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 42.0, 43.0, 43.0, 46.0, 43.0, 46.0, 42.0, 41.0, 42.0], "value": 43.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 38.0, 38.0, 38.0, 37.0, 38.0, 38.0, 37.0, 38.0], "value": 37.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 69.0, 70.0, 75.0, 70.0, 83.0, 72.0, 69.0, 67.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 98.0, 102.0, 108.0, 104.0, 109.0, 106.0, 101.0, 106.0], "value": 104.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 151.0, 160.0, 147.0, 145.0, 149.0, 149.0, 150.0], "value": 149.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 58.0, 58.0, 62.0, 65.0, 58.0, 57.0, 60.0, 59.0], "value": 59.0, "unit": "score"}]}]} 17:48:44 INFO - Return code: 0 17:48:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:48:44 INFO - # TBPL SUCCESS # 17:48:44 INFO - Running post-action listener: _package_coverage_data 17:48:44 INFO - Running post-action listener: _resource_record_post_action 17:48:44 INFO - [mozharness: 2017-10-14 00:48:44.740697Z] Finished run-tests step (success) 17:48:44 INFO - Running post-run listener: _resource_record_post_run 17:48:44 INFO - Total resource usage - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281636864; Read time: 4; Write time: 134728 17:48:44 INFO - TinderboxPrint: CPU usage
13.0% 17:48:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 17:48:44 INFO - TinderboxPrint: I/O write bytes / time
281,636,864 / 134,728 17:48:44 INFO - TinderboxPrint: CPU idle
8,174.6 (86.9%) 17:48:44 INFO - TinderboxPrint: CPU user
1,178.6 (12.5%) 17:48:44 INFO - TinderboxPrint: Swap in / out
0 / 0 17:48:44 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9314304; Read time: 0; Write time: 684 17:48:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:48:44 INFO - run-tests - Wall time: 1164s; CPU: 13.0%; Read bytes: 4096; Write bytes: 272322560; Read time: 4; Write time: 134044 17:48:45 INFO - Running post-run listener: _upload_blobber_files 17:48:45 INFO - Blob upload gear active. 17:48:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:48:45 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 17:48:45 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:48:45 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:48:45 INFO - (blobuploader) - INFO - Open directory for files ... 17:48:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:48:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:48:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:46 INFO - (blobuploader) - INFO - Done attempting. 17:48:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:48:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:48:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:47 INFO - (blobuploader) - INFO - Done attempting. 17:48:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:48:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:48:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:54 INFO - (blobuploader) - INFO - Done attempting. 17:48:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:48:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:48:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:55 INFO - (blobuploader) - INFO - Done attempting. 17:48:55 INFO - (blobuploader) - INFO - Iteration through files over. 17:48:55 INFO - Return code: 0 17:48:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:48:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:48:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/58588d4237824aa9e244f0d1747f32ad4b6c88a9cb2d345e2d30349f98948da3c96af439dbd318a9823fd01236ecad952a487bc53ffe4dec9671a2d014938c73", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/895103ceaa8670d1ea839944797a9a66da8157e3f316f0aff59e6671d082255a250e445d12f3b062362991bafacee7ada1591ce82fa6864ce83b699f25dcf12f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea5b9333cd88bf721461576ec660aee336f37967763a69c42047553e24b65a8c404e55799c3553a16991c1cf1d80ccbf335ad37561a695e65c8aadb1e4bb484e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4bc7621dbc1894e0029cb7aaf2cf92472c6ee7f5230c664eb9b6a084924056ff65cda31112b71b92ed7cb12645baa3b41800f286521dab32c4a04e014148d971"} 17:48:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:48:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:48:55 INFO - Contents: 17:48:55 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/58588d4237824aa9e244f0d1747f32ad4b6c88a9cb2d345e2d30349f98948da3c96af439dbd318a9823fd01236ecad952a487bc53ffe4dec9671a2d014938c73", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/895103ceaa8670d1ea839944797a9a66da8157e3f316f0aff59e6671d082255a250e445d12f3b062362991bafacee7ada1591ce82fa6864ce83b699f25dcf12f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea5b9333cd88bf721461576ec660aee336f37967763a69c42047553e24b65a8c404e55799c3553a16991c1cf1d80ccbf335ad37561a695e65c8aadb1e4bb484e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4bc7621dbc1894e0029cb7aaf2cf92472c6ee7f5230c664eb9b6a084924056ff65cda31112b71b92ed7cb12645baa3b41800f286521dab32c4a04e014148d971"} 17:48:55 INFO - Running post-run listener: copy_logs_to_upload_dir 17:48:55 INFO - Copying logs to upload dir... 17:48:55 INFO - mkdir: /builds/slave/test/build/upload/logs 17:48:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.246313 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-10-13 17:48:55.745712) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-13 17:48:55.749830) ========= 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=826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/58588d4237824aa9e244f0d1747f32ad4b6c88a9cb2d345e2d30349f98948da3c96af439dbd318a9823fd01236ecad952a487bc53ffe4dec9671a2d014938c73", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/895103ceaa8670d1ea839944797a9a66da8157e3f316f0aff59e6671d082255a250e445d12f3b062362991bafacee7ada1591ce82fa6864ce83b699f25dcf12f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea5b9333cd88bf721461576ec660aee336f37967763a69c42047553e24b65a8c404e55799c3553a16991c1cf1d80ccbf335ad37561a695e65c8aadb1e4bb484e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4bc7621dbc1894e0029cb7aaf2cf92472c6ee7f5230c664eb9b6a084924056ff65cda31112b71b92ed7cb12645baa3b41800f286521dab32c4a04e014148d971"} build_url:https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/JyY7kw_hTTa3nrQVjxLbHg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/58588d4237824aa9e244f0d1747f32ad4b6c88a9cb2d345e2d30349f98948da3c96af439dbd318a9823fd01236ecad952a487bc53ffe4dec9671a2d014938c73", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/895103ceaa8670d1ea839944797a9a66da8157e3f316f0aff59e6671d082255a250e445d12f3b062362991bafacee7ada1591ce82fa6864ce83b699f25dcf12f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea5b9333cd88bf721461576ec660aee336f37967763a69c42047553e24b65a8c404e55799c3553a16991c1cf1d80ccbf335ad37561a695e65c8aadb1e4bb484e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4bc7621dbc1894e0029cb7aaf2cf92472c6ee7f5230c664eb9b6a084924056ff65cda31112b71b92ed7cb12645baa3b41800f286521dab32c4a04e014148d971"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-13 17:48:55.780406) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-13 17:48:55.780737) ========= 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=826874ccc97bd7bf541b4875000001d5-1507940903.494766-1885303756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004741 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-13 17:48:55.837759) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-13 17:48:55.838210) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-13 17:48:55.838628) ========= ========= Total master_lag: 0.19 =========