builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-028 starttime: 1505759064.93 results: success (0) revision: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:24.933529) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:24.933990) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:24.934433) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:25.012004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:25.012440) ========= 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=836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 11:24:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2017-09-18 11:24:25 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.079731 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:25.137299) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:25.140725) ========= 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=836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018933 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:25.229537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:25.229938) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 42151fcd6cfc216d147730d0f2c6a2acd52d22fd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 42151fcd6cfc216d147730d0f2c6a2acd52d22fd --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=836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 11:24:25,317 truncating revision to first 12 chars 2017-09-18 11:24:25,317 Setting DEBUG logging. 2017-09-18 11:24:25,317 attempt 1/10 2017-09-18 11:24:25,318 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/42151fcd6cfc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 11:24:25,689 unpacking tar archive at: mozilla-central-42151fcd6cfc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.726913 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:26.014973) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:26.015289) ========= script_repo_revision: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:26.015698) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:26.015960) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:26.032162) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-18 11:24:26.032546) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:26 INFO - MultiFileLogger online at 20170918 11:24:26 in /builds/slave/test 11:24:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:24:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:26 INFO - {'append_to_log': False, 11:24:26 INFO - 'base_work_dir': '/builds/slave/test', 11:24:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:24:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:26 INFO - 'branch': 'Firefox-Non-PGO', 11:24:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:26 INFO - 'code_coverage': False, 11:24:26 INFO - 'config_files': ('talos/linux_config.py',), 11:24:26 INFO - 'default_actions': ('clobber', 11:24:26 INFO - 'read-buildbot-config', 11:24:26 INFO - 'download-and-extract', 11:24:26 INFO - 'populate-webroot', 11:24:26 INFO - 'create-virtualenv', 11:24:26 INFO - 'install', 11:24:26 INFO - 'setup-mitmproxy', 11:24:26 INFO - 'run-tests'), 11:24:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:26 INFO - 'disable_ccov_upload': False, 11:24:26 INFO - 'disable_stylo': False, 11:24:26 INFO - 'download_minidump_stackwalk': True, 11:24:26 INFO - 'download_symbols': 'ondemand', 11:24:26 INFO - 'enable_stylo': False, 11:24:26 INFO - 'enable_webrender': False, 11:24:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:24:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:26 INFO - 'gecko_profile': False, 11:24:26 INFO - 'gecko_profile_interval': 0, 11:24:26 INFO - 'installer_path': 'installer.exe', 11:24:26 INFO - 'log_level': 'info', 11:24:26 INFO - 'log_name': 'talos', 11:24:26 INFO - 'log_to_console': True, 11:24:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:26 INFO - 'opt_config_files': (), 11:24:26 INFO - 'pip_index': False, 11:24:26 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:24:26 INFO - 'system_bits': '32', 11:24:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:26 INFO - 'title': 'talos-linux64-ix-028', 11:24:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:26 INFO - 'use_talos_json': True, 11:24:26 INFO - 'verify': 'False', 11:24:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:26 INFO - 'work_dir': 'build'} 11:24:26 INFO - [mozharness: 2017-09-18 18:24:26.225859Z] Running clobber step. 11:24:26 INFO - Running pre-action listener: _resource_record_pre_action 11:24:26 INFO - Running main action method: clobber 11:24:26 INFO - rmtree: /builds/slave/test/build 11:24:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:27 INFO - Running post-action listener: _resource_record_post_action 11:24:27 INFO - [mozharness: 2017-09-18 18:24:27.732651Z] Finished clobber step (success) 11:24:27 INFO - [mozharness: 2017-09-18 18:24:27.732748Z] Running read-buildbot-config step. 11:24:27 INFO - Running pre-action listener: _resource_record_pre_action 11:24:27 INFO - Running main action method: read_buildbot_config 11:24:27 INFO - Using buildbot properties: 11:24:27 INFO - { 11:24:27 INFO - "project": "", 11:24:27 INFO - "product": "firefox", 11:24:27 INFO - "who": "ffxbld@noreply.mozilla.org", 11:24:27 INFO - "installer_path": "public/build/target.tar.bz2", 11:24:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:24:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:24:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 11:24:27 INFO - "stage_platform": "linux64", 11:24:27 INFO - "basedir": "/builds/slave/test", 11:24:27 INFO - "buildnumber": 39, 11:24:27 INFO - "platform": "ubuntu64_hw", 11:24:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:24:27 INFO - "slavebuilddir": "test", 11:24:27 INFO - "taskId": "K0HUzcwaQv6ShSrDZToRrg", 11:24:27 INFO - "branch": "mozilla-central", 11:24:27 INFO - "script_repo_revision": "production", 11:24:27 INFO - "revision": "42151fcd6cfc216d147730d0f2c6a2acd52d22fd", 11:24:27 INFO - "slavename": "talos-linux64-ix-028", 11:24:27 INFO - "repo_path": "mozilla-central" 11:24:27 INFO - } 11:24:27 INFO - Finding installer, test and symbols from parent task. 11:24:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K0HUzcwaQv6ShSrDZToRrg'}, attempt #1 11:24:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K0HUzcwaQv6ShSrDZToRrg'}, attempt #1 11:24:28 INFO - Task dependencies: SnPiQaAJQmqSN7jo34Jbdw 11:24:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw'}, attempt #1 11:24:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 11:24:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.test_packages.json 11:24:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.crashreporter-symbols.zip 11:24:29 INFO - Running post-action listener: _resource_record_post_action 11:24:29 INFO - [mozharness: 2017-09-18 18:24:29.148499Z] Finished read-buildbot-config step (success) 11:24:29 INFO - [mozharness: 2017-09-18 18:24:29.148715Z] Running download-and-extract step. 11:24:29 INFO - Running pre-action listener: _resource_record_pre_action 11:24:29 INFO - Running main action method: download_and_extract 11:24:29 INFO - mkdir: /builds/slave/test/build/tests 11:24: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')]} 11:24:29 INFO - trying https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.test_packages.json 11:24:29 INFO - Downloading https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:24:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:24:29 INFO - Downloaded 989 bytes. 11:24:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:24:29 INFO - Using the following test package requirements: 11:24:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:24:29 INFO - u'common': [u'target.common.tests.zip'], 11:24:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:24:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:24:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:24:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:24:29 INFO - u'mozbase': [u'target.common.tests.zip'], 11:24:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:24:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:24:29 INFO - u'web-platform': [u'target.common.tests.zip', 11:24:29 INFO - u'target.web-platform.tests.tar.gz'], 11:24:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:24:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:24:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.common.tests.zip 11:24:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:24:29 INFO - Fetch https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.common.tests.zip into memory 11:24:31 INFO - Content-Length response header: 54731144 11:24:31 INFO - Bytes received: 54731144 11:24:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.talos.tests.zip 11:24:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:24:41 INFO - Fetch https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.talos.tests.zip into memory 11:24:42 INFO - Content-Length response header: 14508748 11:24:42 INFO - Bytes received: 14508748 11:24: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')]} 11:24:42 INFO - trying https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 11:24:42 INFO - Downloading https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:24:44 INFO - Downloaded 61505247 bytes. 11:24:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 11:24:44 INFO - mkdir: /builds/slave/test/properties 11:24:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:44 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:44 INFO - Contents: 11:24:44 INFO - build_url:https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 11:24:44 INFO - Running post-action listener: _resource_record_post_action 11:24:44 INFO - Running post-action listener: find_tests_for_verification 11:24:44 INFO - Running post-action listener: set_extra_try_arguments 11:24:44 INFO - [mozharness: 2017-09-18 18:24:44.318988Z] Finished download-and-extract step (success) 11:24:44 INFO - [mozharness: 2017-09-18 18:24:44.319090Z] Running populate-webroot step. 11:24:44 INFO - Running pre-action listener: _resource_record_pre_action 11:24:44 INFO - Running main action method: populate_webroot 11:24:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:44 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['tresize', 11:24:44 INFO - 'tcanvasmark']}, 11:24:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:44 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['dromaeo_css', 11:24:44 INFO - 'kraken']}, 11:24:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:44 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'tests': ['damp', 'tps']}, 11:24:44 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['damp', 'tps']}, 11:24:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:44 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['dromaeo_dom']}, 11:24:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:24:44 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['basic_compositor_video', 11:24:44 INFO - 'glvideo']}, 11:24:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:24:44 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['ts_paint_webext', 11:24:44 INFO - 'tp5o_webext']}, 11:24:44 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:44 INFO - 'ts_paint', 11:24:44 INFO - 'tpaint', 11:24:44 INFO - 'sessionrestore', 11:24:44 INFO - 'sessionrestore_many_windows', 11:24:44 INFO - 'sessionrestore_no_auto_restore', 11:24:44 INFO - 'tabpaint']}, 11:24:44 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['a11yr', 11:24:44 INFO - 'ts_paint', 11:24:44 INFO - 'tpaint', 11:24:44 INFO - 'sessionrestore', 11:24:44 INFO - 'sessionrestore_many_windows', 11:24:44 INFO - 'sessionrestore_no_auto_restore', 11:24:44 INFO - 'tabpaint']}, 11:24:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:24:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:24:44 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['perf_reftest_singletons']}, 11:24:44 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['bloom_basic']}, 11:24:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:44 INFO - 'tsvgr_opacity', 11:24:44 INFO - 'tart', 11:24:44 INFO - 'tscrollx', 11:24:44 INFO - 'tsvg_static']}, 11:24:44 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['tsvgx', 11:24:44 INFO - 'tsvgr_opacity', 11:24:44 INFO - 'tart', 11:24:44 INFO - 'tscrollx', 11:24:44 INFO - 'tsvg_static']}, 11:24:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:24:44 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['tp5o']}, 11:24:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:44 INFO - 'talos_options': ['--mitmproxy', 11:24:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:44 INFO - '--firstNonBlankPaint'], 11:24:44 INFO - 'tests': ['tp6_google', 11:24:44 INFO - 'tp6_youtube', 11:24:44 INFO - 'tp6_amazon', 11:24:44 INFO - 'tp6_facebook']}, 11:24:44 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:44 INFO - 'talos_options': ['--disable-stylo', 11:24:44 INFO - '--mitmproxy', 11:24:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:44 INFO - '--firstNonBlankPaint'], 11:24:44 INFO - 'tests': ['tp6_google', 11:24:44 INFO - 'tp6_youtube', 11:24:44 INFO - 'tp6_amazon', 11:24:44 INFO - 'tp6_facebook']}, 11:24:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:44 INFO - 'talos_options': ['--stylo-threads=1', 11:24:44 INFO - '--mitmproxy', 11:24:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:44 INFO - '--firstNonBlankPaint'], 11:24:44 INFO - 'tests': ['tp6_google', 11:24:44 INFO - 'tp6_youtube', 11:24:44 INFO - 'tp6_amazon', 11:24:44 INFO - 'tp6_facebook']}, 11:24:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'talos_options': ['--xperf_path', 11:24:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:44 INFO - 'tests': ['tp5n']}, 11:24:44 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'talos_options': ['--disable-stylo', 11:24:44 INFO - '--xperf_path', 11:24:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:44 INFO - 'tests': ['tp5n']}}} 11:24:44 INFO - Running post-action listener: _resource_record_post_action 11:24:44 INFO - [mozharness: 2017-09-18 18:24:44.337302Z] Finished populate-webroot step (success) 11:24:44 INFO - [mozharness: 2017-09-18 18:24:44.337391Z] Running create-virtualenv step. 11:24:44 INFO - Running pre-action listener: _resource_record_pre_action 11:24:44 INFO - Running main action method: create_virtualenv 11:24:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:24:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:24:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:24:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:45 INFO - Installing pip...............done. 11:24:45 INFO - Return code: 0 11:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:24:45 INFO - Reading from file tmpfile_stdout 11:24:45 INFO - Output received: 11:24: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) 11:24:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24: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')]} 11:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24: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 0x20821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f2090>, '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 0x23f2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ecf90>, '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': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24: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 11:24: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 11:24:45 INFO - Using env: {'DISPLAY': ':0', 11:24:45 INFO - 'HOME': '/home/cltbld', 11:24:45 INFO - 'LANG': 'en_US.UTF-8', 11:24:45 INFO - 'LANGUAGE': 'en_US:en', 11:24:45 INFO - 'LOGNAME': 'cltbld', 11:24:45 INFO - 'MAIL': '/var/mail/cltbld', 11:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:45 INFO - 'MOZ_NO_REMOTE': '1', 11:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:45 INFO - 'NO_EM_RESTART': '1', 11:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:45 INFO - 'PWD': '/builds/slave/test', 11:24:45 INFO - 'SHELL': '/bin/bash', 11:24:45 INFO - 'SHLVL': '1', 11:24:45 INFO - 'TERM': 'linux', 11:24:45 INFO - 'TMOUT': '86400', 11:24:45 INFO - 'USER': 'cltbld', 11:24:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 11:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:45 INFO - '_': '/tools/buildbot/bin/python'} 11:24:46 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:24:46 INFO - Downloading/unpacking pip>=1.5 11:24:46 INFO - Running setup.py egg_info for package pip 11:24:46 INFO - warning: no files found matching 'pip/cacert.pem' 11:24:46 INFO - warning: no files found matching '*.html' under directory 'docs' 11:24:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:24:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:24:46 INFO - Installing collected packages: pip 11:24:46 INFO - Found existing installation: pip 1.1 11:24:46 INFO - Uninstalling pip: 11:24:46 INFO - Successfully uninstalled pip 11:24:46 INFO - Running setup.py install for pip 11:24:46 INFO - warning: no files found matching 'pip/cacert.pem' 11:24:46 INFO - warning: no files found matching '*.html' under directory 'docs' 11:24:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:24:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:24:46 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:24:46 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:24:46 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:24:46 INFO - Successfully installed pip 11:24:46 INFO - Cleaning up... 11:24:46 INFO - Return code: 0 11:24:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24: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')]} 11:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24: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 0x20821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f2090>, '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 0x23f2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ecf90>, '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': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24: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 11:24: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 11:24:46 INFO - Using env: {'DISPLAY': ':0', 11:24:46 INFO - 'HOME': '/home/cltbld', 11:24:46 INFO - 'LANG': 'en_US.UTF-8', 11:24:46 INFO - 'LANGUAGE': 'en_US:en', 11:24:46 INFO - 'LOGNAME': 'cltbld', 11:24:46 INFO - 'MAIL': '/var/mail/cltbld', 11:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:46 INFO - 'MOZ_NO_REMOTE': '1', 11:24:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:46 INFO - 'NO_EM_RESTART': '1', 11:24:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:46 INFO - 'PWD': '/builds/slave/test', 11:24:46 INFO - 'SHELL': '/bin/bash', 11:24:46 INFO - 'SHLVL': '1', 11:24:46 INFO - 'TERM': 'linux', 11:24:46 INFO - 'TMOUT': '86400', 11:24:46 INFO - 'USER': 'cltbld', 11:24:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 11:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:46 INFO - '_': '/tools/buildbot/bin/python'} 11:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:46 INFO - Downloading/unpacking psutil>=3.1.1 11:24: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 11:24: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 11:24: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 11:24: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 11:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:47 INFO - Installing collected packages: psutil 11:24:47 INFO - Running setup.py install for psutil 11:24:48 INFO - building 'psutil._psutil_linux' extension 11:24: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 11:24: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 11:24:48 INFO - building 'psutil._psutil_posix' extension 11:24: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 11:24: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 11:24:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:48 INFO - Successfully installed psutil 11:24:48 INFO - Cleaning up... 11:24:48 INFO - Return code: 0 11:24:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24: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 0x20821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f2090>, '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 0x23f2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ecf90>, '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': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24: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 11:24: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 11:24:48 INFO - Using env: {'DISPLAY': ':0', 11:24:48 INFO - 'HOME': '/home/cltbld', 11:24:48 INFO - 'LANG': 'en_US.UTF-8', 11:24:48 INFO - 'LANGUAGE': 'en_US:en', 11:24:48 INFO - 'LOGNAME': 'cltbld', 11:24:48 INFO - 'MAIL': '/var/mail/cltbld', 11:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:48 INFO - 'MOZ_NO_REMOTE': '1', 11:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:48 INFO - 'NO_EM_RESTART': '1', 11:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:48 INFO - 'PWD': '/builds/slave/test', 11:24:48 INFO - 'SHELL': '/bin/bash', 11:24:48 INFO - 'SHLVL': '1', 11:24:48 INFO - 'TERM': 'linux', 11:24:48 INFO - 'TMOUT': '86400', 11:24:48 INFO - 'USER': 'cltbld', 11:24:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 11:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:48 INFO - '_': '/tools/buildbot/bin/python'} 11:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:24: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 11:24: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 11:24: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 11:24: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 11:24:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:24:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:24:49 INFO - Installing collected packages: mozsystemmonitor 11:24:49 INFO - Running setup.py install for mozsystemmonitor 11:24:50 INFO - Successfully installed mozsystemmonitor 11:24:50 INFO - Cleaning up... 11:24:52 INFO - Return code: 0 11:24:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f2090>, '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 0x23f2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ecf90>, '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': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:24:52 INFO - Using env: {'DISPLAY': ':0', 11:24:52 INFO - 'HOME': '/home/cltbld', 11:24:52 INFO - 'LANG': 'en_US.UTF-8', 11:24:52 INFO - 'LANGUAGE': 'en_US:en', 11:24:52 INFO - 'LOGNAME': 'cltbld', 11:24:52 INFO - 'MAIL': '/var/mail/cltbld', 11:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:52 INFO - 'MOZ_NO_REMOTE': '1', 11:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:52 INFO - 'NO_EM_RESTART': '1', 11:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:52 INFO - 'PWD': '/builds/slave/test', 11:24:52 INFO - 'SHELL': '/bin/bash', 11:24:52 INFO - 'SHLVL': '1', 11:24:52 INFO - 'TERM': 'linux', 11:24:52 INFO - 'TMOUT': '86400', 11:24:52 INFO - 'USER': 'cltbld', 11:24:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 11:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:52 INFO - '_': '/tools/buildbot/bin/python'} 11:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:52 INFO - Downloading/unpacking jsonschema==2.5.1 11:24: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 11:24: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 11:24: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 11:24: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 11:24:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:53 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:53 INFO - warning: no files found matching '*.txt' 11:24:53 INFO - no previously-included directories found matching 'build' 11:24:53 INFO - no previously-included directories found matching 'dist' 11:24:53 INFO - no previously-included directories found matching '.git*' 11:24:53 INFO - Installing collected packages: jsonschema, functools32 11:24:54 INFO - Running setup.py install for functools32 11:24:54 INFO - warning: no files found matching '*.txt' 11:24:54 INFO - no previously-included directories found matching 'build' 11:24:54 INFO - no previously-included directories found matching 'dist' 11:24:54 INFO - no previously-included directories found matching '.git*' 11:24:54 INFO - Successfully installed jsonschema functools32 11:24:54 INFO - Cleaning up... 11:24:54 INFO - Return code: 0 11:24:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24: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')]} 11:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24: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', '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 0x20821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f2090>, '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 0x23f2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ecf90>, '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': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:24: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 functools32==3.2.3-2 11:24:54 INFO - Using env: {'DISPLAY': ':0', 11:24:54 INFO - 'HOME': '/home/cltbld', 11:24:54 INFO - 'LANG': 'en_US.UTF-8', 11:24:54 INFO - 'LANGUAGE': 'en_US:en', 11:24:54 INFO - 'LOGNAME': 'cltbld', 11:24:54 INFO - 'MAIL': '/var/mail/cltbld', 11:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:54 INFO - 'MOZ_NO_REMOTE': '1', 11:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:54 INFO - 'NO_EM_RESTART': '1', 11:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:54 INFO - 'PWD': '/builds/slave/test', 11:24:54 INFO - 'SHELL': '/bin/bash', 11:24:54 INFO - 'SHLVL': '1', 11:24:54 INFO - 'TERM': 'linux', 11:24:54 INFO - 'TMOUT': '86400', 11:24:54 INFO - 'USER': 'cltbld', 11:24:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 11:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:54 INFO - '_': '/tools/buildbot/bin/python'} 11:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:24:55 INFO - Cleaning up... 11:24:55 INFO - Return code: 0 11:24:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:55 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 0x20821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f2090>, '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 0x23f2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ecf90>, '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': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:24:55 INFO - Using env: {'DISPLAY': ':0', 11:24:55 INFO - 'HOME': '/home/cltbld', 11:24:55 INFO - 'LANG': 'en_US.UTF-8', 11:24:55 INFO - 'LANGUAGE': 'en_US:en', 11:24:55 INFO - 'LOGNAME': 'cltbld', 11:24:55 INFO - 'MAIL': '/var/mail/cltbld', 11:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:55 INFO - 'MOZ_NO_REMOTE': '1', 11:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:55 INFO - 'NO_EM_RESTART': '1', 11:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:55 INFO - 'PWD': '/builds/slave/test', 11:24:55 INFO - 'SHELL': '/bin/bash', 11:24:55 INFO - 'SHLVL': '1', 11:24:55 INFO - 'TERM': 'linux', 11:24:55 INFO - 'TMOUT': '86400', 11:24:55 INFO - 'USER': 'cltbld', 11:24:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 11:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:55 INFO - '_': '/tools/buildbot/bin/python'} 11:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:55 INFO - Downloading/unpacking blobuploader==1.2.4 11:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:57 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:57 INFO - Downloading docopt-0.6.1.tar.gz 11:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:57 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:57 INFO - Running setup.py install for blobuploader 11:24:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:57 INFO - Running setup.py install for requests 11:24:58 INFO - Running setup.py install for docopt 11:24:58 INFO - Successfully installed blobuploader requests docopt 11:24:58 INFO - Cleaning up... 11:24:58 INFO - Return code: 0 11:24:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:58 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 0x20821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f2090>, '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 0x23f2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ecf90>, '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': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:24:58 INFO - Using env: {'DISPLAY': ':0', 11:24:58 INFO - 'HOME': '/home/cltbld', 11:24:58 INFO - 'LANG': 'en_US.UTF-8', 11:24:58 INFO - 'LANGUAGE': 'en_US:en', 11:24:58 INFO - 'LOGNAME': 'cltbld', 11:24:58 INFO - 'MAIL': '/var/mail/cltbld', 11:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:58 INFO - 'MOZ_NO_REMOTE': '1', 11:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:58 INFO - 'NO_EM_RESTART': '1', 11:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:58 INFO - 'PWD': '/builds/slave/test', 11:24:58 INFO - 'SHELL': '/bin/bash', 11:24:58 INFO - 'SHLVL': '1', 11:24:58 INFO - 'TERM': 'linux', 11:24:58 INFO - 'TMOUT': '86400', 11:24:58 INFO - 'USER': 'cltbld', 11:24:58 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 11:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:58 INFO - '_': '/tools/buildbot/bin/python'} 11:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:58 INFO - Running setup.py (path:/tmp/pip-e49G5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:58 INFO - Running setup.py (path:/tmp/pip-rPiQCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:58 INFO - Running setup.py (path:/tmp/pip-2gHlUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:58 INFO - Running setup.py (path:/tmp/pip-M5KoTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:58 INFO - Running setup.py (path:/tmp/pip-a6S9MD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:58 INFO - Running setup.py (path:/tmp/pip-WaGVe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:58 INFO - Running setup.py (path:/tmp/pip-qynHTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:58 INFO - Running setup.py (path:/tmp/pip-vLldbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:59 INFO - Running setup.py (path:/tmp/pip-uH5HJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:59 INFO - Running setup.py (path:/tmp/pip-yz5q6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:59 INFO - Running setup.py (path:/tmp/pip-UwjpFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:59 INFO - Running setup.py (path:/tmp/pip-y41b_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:59 INFO - Running setup.py (path:/tmp/pip-lx6bF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:59 INFO - Running setup.py (path:/tmp/pip-5zqUhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:59 INFO - Running setup.py (path:/tmp/pip-WHdMRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:59 INFO - Running setup.py (path:/tmp/pip-I4eNhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:59 INFO - Running setup.py (path:/tmp/pip-BEFvRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:59 INFO - Running setup.py install for manifestparser 11:24:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:59 INFO - Running setup.py install for mozcrash 11:24:59 INFO - Running setup.py install for mozdebug 11:24:59 INFO - Running setup.py install for mozdevice 11:25:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Running setup.py install for mozfile 11:25:00 INFO - Running setup.py install for mozhttpd 11:25:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Running setup.py install for mozinfo 11:25:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Running setup.py install for mozInstall 11:25:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Running setup.py install for mozleak 11:25:00 INFO - Running setup.py install for mozlog 11:25:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Running setup.py install for moznetwork 11:25:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Running setup.py install for mozprocess 11:25:00 INFO - Running setup.py install for mozprofile 11:25:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:25:01 INFO - Running setup.py install for mozrunner 11:25:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:25:01 INFO - Running setup.py install for mozscreenshot 11:25:01 INFO - Running setup.py install for moztest 11:25:01 INFO - Running setup.py install for mozversion 11:25:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:01 INFO - Cleaning up... 11:25:01 INFO - Return code: 0 11:25:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:01 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 0x20821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f2090>, '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 0x23f2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ecf90>, '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': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:25:01 INFO - Using env: {'DISPLAY': ':0', 11:25:01 INFO - 'HOME': '/home/cltbld', 11:25:01 INFO - 'LANG': 'en_US.UTF-8', 11:25:01 INFO - 'LANGUAGE': 'en_US:en', 11:25:01 INFO - 'LOGNAME': 'cltbld', 11:25:01 INFO - 'MAIL': '/var/mail/cltbld', 11:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:01 INFO - 'MOZ_NO_REMOTE': '1', 11:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:01 INFO - 'NO_EM_RESTART': '1', 11:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:01 INFO - 'PWD': '/builds/slave/test', 11:25:01 INFO - 'SHELL': '/bin/bash', 11:25:01 INFO - 'SHLVL': '1', 11:25:01 INFO - 'TERM': 'linux', 11:25:01 INFO - 'TMOUT': '86400', 11:25:01 INFO - 'USER': 'cltbld', 11:25:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 11:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:01 INFO - '_': '/tools/buildbot/bin/python'} 11:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:01 INFO - Running setup.py (path:/tmp/pip-MYlT9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:01 INFO - Running setup.py (path:/tmp/pip-sPvMiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:01 INFO - Running setup.py (path:/tmp/pip-kg86WS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:01 INFO - Running setup.py (path:/tmp/pip-gztjAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:01 INFO - Running setup.py (path:/tmp/pip-gwI_L6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:02 INFO - Running setup.py (path:/tmp/pip-PfrWHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:02 INFO - Running setup.py (path:/tmp/pip-wlLpPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:02 INFO - Running setup.py (path:/tmp/pip-F6nx9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:02 INFO - Running setup.py (path:/tmp/pip-q6lB44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:02 INFO - Running setup.py (path:/tmp/pip-Y0sNPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:02 INFO - Running setup.py (path:/tmp/pip-bpFE8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:02 INFO - Running setup.py (path:/tmp/pip-nYNsiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:02 INFO - Running setup.py (path:/tmp/pip-SGVSDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:02 INFO - Running setup.py (path:/tmp/pip-EEqLqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:02 INFO - Running setup.py (path:/tmp/pip-muUU3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:02 INFO - Running setup.py (path:/tmp/pip-ddk4CG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:02 INFO - Running setup.py (path:/tmp/pip-W2t_Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:25:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:03 INFO - Downloading blessings-1.6.tar.gz 11:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:04 INFO - Installing collected packages: blessings 11:25:04 INFO - Running setup.py install for blessings 11:25:04 INFO - Successfully installed blessings 11:25:04 INFO - Cleaning up... 11:25:04 INFO - Return code: 0 11:25:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:04 INFO - Reading from file tmpfile_stdout 11:25:04 INFO - Current package versions: 11:25:04 INFO - argparse == 1.2.1 11:25:04 INFO - blessings == 1.6 11:25:04 INFO - blobuploader == 1.2.4 11:25:04 INFO - docopt == 0.6.1 11:25:04 INFO - functools32 == 3.2.3-2 11:25:04 INFO - jsonschema == 2.5.1 11:25:04 INFO - manifestparser == 1.1 11:25:04 INFO - mozInstall == 1.13 11:25:04 INFO - mozcrash == 1.0 11:25:04 INFO - mozdebug == 0.1 11:25:04 INFO - mozdevice == 0.51 11:25:04 INFO - mozfile == 1.2 11:25:04 INFO - mozhttpd == 0.7 11:25:04 INFO - mozinfo == 0.10 11:25:04 INFO - mozleak == 0.1 11:25:04 INFO - mozlog == 3.5 11:25:04 INFO - moznetwork == 0.27 11:25:04 INFO - mozprocess == 0.25 11:25:04 INFO - mozprofile == 0.28 11:25:04 INFO - mozrunner == 6.13 11:25:04 INFO - mozscreenshot == 0.1 11:25:04 INFO - mozsystemmonitor == 0.3 11:25:04 INFO - moztest == 0.8 11:25:04 INFO - mozversion == 1.4 11:25:04 INFO - psutil == 3.1.1 11:25:04 INFO - requests == 1.2.3 11:25:04 INFO - wsgiref == 0.1.2 11:25:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:04 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 0x20821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f2090>, '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 0x23f2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ecf90>, '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': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:25:04 INFO - Using env: {'DISPLAY': ':0', 11:25:04 INFO - 'HOME': '/home/cltbld', 11:25:04 INFO - 'LANG': 'en_US.UTF-8', 11:25:04 INFO - 'LANGUAGE': 'en_US:en', 11:25:04 INFO - 'LOGNAME': 'cltbld', 11:25:04 INFO - 'MAIL': '/var/mail/cltbld', 11:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:04 INFO - 'MOZ_NO_REMOTE': '1', 11:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:04 INFO - 'NO_EM_RESTART': '1', 11:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:04 INFO - 'PWD': '/builds/slave/test', 11:25:04 INFO - 'SHELL': '/bin/bash', 11:25:04 INFO - 'SHLVL': '1', 11:25:04 INFO - 'TERM': 'linux', 11:25:04 INFO - 'TMOUT': '86400', 11:25:04 INFO - 'USER': 'cltbld', 11:25:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 11:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:04 INFO - '_': '/tools/buildbot/bin/python'} 11:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:25:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:25:05 INFO - Installing collected packages: simplejson 11:25:05 INFO - Running setup.py install for simplejson 11:25:05 INFO - building 'simplejson._speedups' extension 11:25:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:25:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:25:06 INFO - Successfully installed simplejson 11:25:06 INFO - Cleaning up... 11:25:06 INFO - Return code: 0 11:25:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:06 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 0x20821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f2090>, '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 0x23f2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ecf90>, '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': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:25:06 INFO - Using env: {'DISPLAY': ':0', 11:25:06 INFO - 'HOME': '/home/cltbld', 11:25:06 INFO - 'LANG': 'en_US.UTF-8', 11:25:06 INFO - 'LANGUAGE': 'en_US:en', 11:25:06 INFO - 'LOGNAME': 'cltbld', 11:25:06 INFO - 'MAIL': '/var/mail/cltbld', 11:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:06 INFO - 'MOZ_NO_REMOTE': '1', 11:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:06 INFO - 'NO_EM_RESTART': '1', 11:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:06 INFO - 'PWD': '/builds/slave/test', 11:25:06 INFO - 'SHELL': '/bin/bash', 11:25:06 INFO - 'SHLVL': '1', 11:25:06 INFO - 'TERM': 'linux', 11:25:06 INFO - 'TMOUT': '86400', 11:25:06 INFO - 'USER': 'cltbld', 11:25:06 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 11:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:06 INFO - '_': '/tools/buildbot/bin/python'} 11:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:25:07 INFO - Cleaning up... 11:25:07 INFO - Return code: 0 11:25:07 INFO - Running post-action listener: _resource_record_post_action 11:25:07 INFO - Running post-action listener: _start_resource_monitoring 11:25:07 INFO - Starting resource monitoring. 11:25:07 INFO - [mozharness: 2017-09-18 18:25:07.132162Z] Finished create-virtualenv step (success) 11:25:07 INFO - [mozharness: 2017-09-18 18:25:07.132675Z] Running install step. 11:25:07 INFO - Running pre-action listener: _resource_record_pre_action 11:25:07 INFO - Running main action method: install 11:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:07 INFO - Reading from file tmpfile_stdout 11:25:07 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:07 INFO - Reading from file tmpfile_stdout 11:25:07 INFO - Output received: 11:25:07 INFO - Usage: mozinstall [options] installer 11:25:07 INFO - Options: 11:25:07 INFO - -h, --help show this help message and exit 11:25:07 INFO - -d DEST, --destination=DEST 11:25:07 INFO - Directory to install application into. [default: 11:25:07 INFO - "/builds/slave/test"] 11:25:07 INFO - --app=APP Application being installed. [default: firefox] 11:25:07 INFO - mkdir: /builds/slave/test/build/application 11:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:25:25 INFO - Reading from file tmpfile_stdout 11:25:25 INFO - Output received: 11:25:25 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:25 INFO - Running post-action listener: _resource_record_post_action 11:25:25 INFO - [mozharness: 2017-09-18 18:25:25.260552Z] Finished install step (success) 11:25:25 INFO - [mozharness: 2017-09-18 18:25:25.260803Z] Running setup-mitmproxy step. 11:25:25 INFO - Running pre-action listener: _resource_record_pre_action 11:25:25 INFO - Running main action method: setup_mitmproxy 11:25:25 INFO - Skipping: mitmproxy is not required 11:25:25 INFO - Running post-action listener: _resource_record_post_action 11:25:25 INFO - [mozharness: 2017-09-18 18:25:25.261929Z] Finished setup-mitmproxy step (success) 11:25:25 INFO - [mozharness: 2017-09-18 18:25:25.262148Z] Running run-tests step. 11:25:25 INFO - Running pre-action listener: _resource_record_pre_action 11:25:25 INFO - Running pre-action listener: _set_gcov_prefix 11:25:25 INFO - Running main action method: run_tests 11:25:25 WARNING - Try message not found. 11:25:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:25 INFO - Python 2.7.3 11:25:25 INFO - Return code: 0 11:25:25 INFO - grabbing minidump binary from tooltool 11:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:25 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 0x23f2090>, '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 0x23f2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ecf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:25:25 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:25:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:25:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:25 INFO - Return code: 0 11:25:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:25 INFO - ENV: RUST_BACKTRACE is now full 11:25:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 11:25:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 11:25:25 INFO - Using env: {'DISPLAY': ':0', 11:25:25 INFO - 'HOME': '/home/cltbld', 11:25:25 INFO - 'LANG': 'en_US.UTF-8', 11:25:25 INFO - 'LANGUAGE': 'en_US:en', 11:25:25 INFO - 'LOGNAME': 'cltbld', 11:25:25 INFO - 'MAIL': '/var/mail/cltbld', 11:25:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:25 INFO - 'MOZ_NO_REMOTE': '1', 11:25:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:25 INFO - 'NO_EM_RESTART': '1', 11:25:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:25 INFO - 'PWD': '/builds/slave/test', 11:25:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:25 INFO - 'RUST_BACKTRACE': 'full', 11:25:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:25:25 INFO - 'SHELL': '/bin/bash', 11:25:25 INFO - 'SHLVL': '1', 11:25:25 INFO - 'TERM': 'linux', 11:25:25 INFO - 'TMOUT': '86400', 11:25:25 INFO - 'USER': 'cltbld', 11:25:25 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 11:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:25 INFO - '_': '/tools/buildbot/bin/python'} 11:25:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 11:25:25 INFO - mozversion application_buildid: 20170918173522 11:25:25 INFO - mozversion application_changeset: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd 11:25:25 INFO - mozversion application_display_name: Nightly 11:25:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:25 INFO - mozversion application_name: Firefox 11:25:25 INFO - mozversion application_remotingname: firefox 11:25:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:25:25 INFO - mozversion application_vendor: Mozilla 11:25:25 INFO - mozversion application_version: 57.0a1 11:25:25 INFO - mozversion platform_buildid: 20170918173522 11:25:25 INFO - mozversion platform_changeset: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd 11:25:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:25:25 INFO - mozversion platform_version: 57.0a1 11:25:25 INFO - using testdate: 1505759125 11:25:25 INFO - actual date: 1505759125 11:25:25 INFO - starting webserver on 'localhost:57123' 11:25:25 INFO - SUITE-START | Running 2 tests 11:25:25 INFO - TEST-START | dromaeo_css 11:25:25 INFO - Initialising browser for dromaeo_css test... 11:25:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57123/getInfo.html -profile /tmp/tmpymHnqZ/profile 11:25:25 INFO - TEST-INFO | started process 30560 (/builds/slave/test/build/application/firefox/firefox http://localhost:57123/getInfo.html) 11:25:31 INFO - TEST-INFO | 30560: exit 0 11:25:31 INFO - Browser initialized. 11:25:31 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:31 INFO - Using env: {'DISPLAY': ':0', 11:25:31 INFO - 'HOME': '/home/cltbld', 11:25:31 INFO - 'JSGC_DISABLE_POISONING': '1', 11:25:31 INFO - 'LANG': 'en_US.UTF-8', 11:25:31 INFO - 'LANGUAGE': 'en_US:en', 11:25:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:25:31 INFO - 'LOGNAME': 'cltbld', 11:25:31 INFO - 'MAIL': '/var/mail/cltbld', 11:25:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:31 INFO - 'MOZ_CRASHREPORTER': '1', 11:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:25:31 INFO - 'MOZ_NO_REMOTE': '1', 11:25:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:31 INFO - 'NO_EM_RESTART': '1', 11:25:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:31 INFO - 'PWD': '/builds/slave/test', 11:25:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:31 INFO - 'RUST_BACKTRACE': 'full', 11:25:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:25:31 INFO - 'SHELL': '/bin/bash', 11:25:31 INFO - 'SHLVL': '1', 11:25:31 INFO - 'STYLO_FORCE_DISABLED': '1', 11:25:31 INFO - 'TERM': 'linux', 11:25:31 INFO - 'TMOUT': '86400', 11:25:31 INFO - 'USER': 'cltbld', 11:25:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 11:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:31 INFO - '_': '/tools/buildbot/bin/python'} 11:25:31 INFO - TEST-INFO | started process 30796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpymHnqZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:32 INFO - PID 30796 | 11:25:32 INFO - PID 30796 | (/builds/slave/test/build/application/firefox/firefox:30845): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:25:32 INFO - PID 30796 | 11:25:42 INFO - PID 30796 | RSS: Main: 154587136 11:25:42 INFO - PID 30796 | 11:28:40 INFO - PID 30796 | Cycle 1(1): loaded http://localhost:57123/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57123/tests/dromaeo/cssquery-ext.html) 11:28:41 INFO - PID 30796 | RSS: Main: 155430912 11:28:41 INFO - PID 30796 | 11:31:43 INFO - PID 30796 | Cycle 1(1): loaded http://localhost:57123/tests/dromaeo/cssquery-ext.html (next: http://localhost:57123/tests/dromaeo/cssquery-jquery.html) 11:31:44 INFO - PID 30796 | RSS: Main: 153444352 11:31:44 INFO - PID 30796 | 11:34:46 INFO - PID 30796 | Cycle 1(1): loaded http://localhost:57123/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57123/tests/dromaeo/cssquery-mootools.html) 11:34:46 INFO - PID 30796 | RSS: Main: 155611136 11:34:46 INFO - PID 30796 | 11:37:48 INFO - PID 30796 | Cycle 1(1): loaded http://localhost:57123/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57123/tests/dromaeo/cssquery-prototype.html) 11:37:48 INFO - PID 30796 | RSS: Main: 155574272 11:37:48 INFO - PID 30796 | 11:40:52 INFO - PID 30796 | Cycle 1(1): loaded http://localhost:57123/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57123/tests/dromaeo/cssquery-yui.html) 11:40:53 INFO - PID 30796 | RSS: Main: 155230208 11:40:53 INFO - PID 30796 | 11:43:54 INFO - PID 30796 | Cycle 1(1): loaded http://localhost:57123/tests/dromaeo/cssquery-yui.html (next: http://localhost:57123/tests/dromaeo/cssquery-dojo.html) 11:43:54 INFO - PID 30796 | RSS: Main: 159301632 11:43:54 INFO - PID 30796 | 11:43:54 INFO - PID 30796 | __start_tp_report 11:43:54 INFO - PID 30796 | _x_x_mozilla_page_load 11:43:54 INFO - PID 30796 | _x_x_mozilla_page_load_details 11:43:54 INFO - PID 30796 | |i|pagename|runs| 11:43:54 INFO - PID 30796 | |0;dojo.html;3136.5138403547458;3146.323540438805;3146.4021835851186;3153.322035762311;3172.8572214250357;6207.937920620792;6248.531360147985;6267.0286105653695;6377;6393.840153996147;6287.559870809046;6299.2440907091095;6313.368663133684;6316.684165791715;6327.9367206327925;5824.330202026757;5828.300603927513;5837.328707198684;5848.766049358021;5986.580939334249;5899.115132730082;5951.821445356624;5994.580379373446;6007.15899774032;6077.574569780095;1240.787587152844;5816.912746308809;5943.375945525722;5996.2804463464445;6007.4893634041155;5813.128030795372;5822.417758224186;5846.853828654275;5915.201447804534;5916.408359164092;5842.094475356326;5844.22347310733;5874.206982057453;5916.083007133901;5936.673482958436;6333.651649159295;6379.617222966637;6398.200224971879;6443.452306553949;6476.514261430411;6819.318068193191;6841.144856892888;6907.309269073103;6910.516263861532;6973.616451095188;6667.499937504658;6787.524873258873;6825.829354266133;6921.930780692179;7018.192907815615;6317.084022816712;6320.4311611955145;6375.585586936834;6377.07532407803;6410.679466026727;7028.472864535181;7042.859142817218;7106.822329441702;7113.430925525946;7116.430685545144;6531.171272043835;6649.833754156185;6705;6728.461723062143;6774.45804335652;6765.357291057342;6765.42493888025;6769.729210831511;6778.525503214728;6783.660816959133;6704.698288577026;6732.225794033651;6737.764178253738;6739.663016849138;6752.155980502437;6700.463962882957;6788.219354774165;6789.490788190906;6791.2869148739655;6799.184097908283;5299.549538289211;5423.701696406657;5446.863828404322;5449.073657478239;5456.072467680504;4612.630989520897;4679.976600117046;4725.574698277172;4743.715377077387;4782.067496838153;5652.85867853307;5767.942320576741;5796.987027341745;5849.415058494202;5849.473547380671;6822.692978815965;6823.795286141423;6849.794506164823;6860.03959445678;6861.039454476378;5738.68437235956;5796.971015144897;5804.477597016289;5822.592418530747;5829.47534721877;5778.3354914184565;5817.7091145442555;5863.794767183128;5868.413158684098;5872.765089396376;6450.193725784277;6549.9345006550275;6589.439897608661;6677.065210870482;6722.193336799518;6774.220964589037;6787.762428314985;6788.355106264897;6792.72829086831;6798.694058767268;6411.871762564816;6541.443977261986;6541.542092053511;6562.5406221564035;6563.04835798816;6767.154105736783;6804;6809.38715515606;6835.906254999375;6836.555623884432;6864.347886950732;6874.106366172366;6945.062416573698;6968.965155174192;6981.406580440719;6494.253160886558;6617.966910165418;6625.569337993015;6716.059751634677;6725.4619630430425;6468.15913931186;6472.773452929125;6478.222613286247;6496.74013039492;6501.739930402731;6504.772332968323;6614.735410583523;6619.834504137435;6621.503387246072;6621.569597976116;6697.933020669926;6744.696488657924;6758.966205168943;6759.729610815512;6779;6455.61266324022;6467.450266727381;6482.870342593216;6537.607743535403;6551.868962620816 11:43:54 INFO - PID 30796 | |1;ext.html;777.2111307023372;803.5138741061661;805.9435839491238;807.4590024683463;807.9353651707864;39409;42932.570674293245;43043;43091.78454107725;43120.13759724804;37756;38083.238335233276;38084.61915380845;38104.80947595265;38105.428418573676;7001.929980700192;7150.320719531636;7778.4166187535875;7953.96023019887;7966.123726390092;7845.450818442711;7944.56304903233;7946;7946.602669866513;7948.125706172316;7931.603419828985;7953.642086106111;7968.800779980518;7969.760907172794;7992.720254791084;7845.372370210398;7929.841403171962;7934.206579342077;7939.047314322261;7944.6027698614835;7776.572288524186;7799.220077992212;7826.882596761053;7853.371730261565;7888.2506161914525;38379;38670.419943700865;38952.61047389547;39010.804945975375;39020.41469377962;3540.716742660581;3594.712423006153;3600.6939410150167;3611.115276757211;3612.602613712516;31375.686243137505;31535.526967095513;31723.52414713781;31856.20359491008;32047.51928721071;5171.922421163686;5195.870103247411;5228.006678731029;5239.607029472767;5240.3187585614005;194092;194337;195424;195481;195698;43278.35082473765;43842;50081.74959125181;50364.244536331986;50393;51091;51953.48046519562;52056.21915671268;52151.784821518304;52164.478355215964;15253.237338133049;15310.617234569003;15331.770023449433;15406.306716197798;15419.306131224123;12451.439685214187;12480.625581232396;12494.75010499785;12522.624321270376;12536.247825130522;13556.796648050287;13689.931550342184;13711.314434278247;13744.65638359049;13855.653608659662;5503.229547863302;5508.173773933861;5627.971860140673;5679.971600141973;5732.914006289909;997.1275134257525;1017.0897047142765;1017.801528701896;1028.3983869436463;1040.6929955663097;22803.805278032123;22882.084716611484;23021;23341;23529;1094.7372630568607;1112.449337577888;1123.43828085957;1126.774645070989;1135.6195674448986;11711.180217384872;11969.581064662694;12122.151449398458;12142.089343299287;12240.143189976794;220598;220812;221177;221305;221699;53236.46763532315;53323.733381332844;53349.73325133427;53412.732936335844;53433.198502022504;1402.6002589262216;1448.109412711196;1454.2365258239297;1464.9414023438942;1479;22012.789296588842;22148.446288842908;22279;22507.887460562593;22857.771422285565;37985.2402951945;38183.42724859185;38200.61799381971;38235.80882095572;38246.80876595599;187029;187902;188800;188890;189859;31184.37631247317;31899.043028709177;33516.832415837765;34769.30461390808;34973;42874.57125428706;43317.783411082746;43321.350179746696;43473;44260;32238.838805805823;32340;32411;32538.511922321657;33172;31329.68670313359;32005.839970799996;32138.71445142168;32430.35139297248;32646.34707305888;35761.46357804583;35778.821105894305;35872.10319742027;36049;36095;30996.69003309938;31146.844265778527;31276.687233127377;31540.588840190343;32135.67864321327;22931.018967534113;23491.530169396858;23523.529529409658;23680.407989799704;23767.405814854075 11:43:54 INFO - PID 30796 | |2;jquery.html;550.2296784501697;553.7203712125377;563.6223730100829;574.0900672434192;596.4006173795334;22016.559668806614;22867.77132228677;22933.4266643334;23021.884890575544;23088.30735077946;23441.531169376645;24186.516269674597;24630.75369246307;24994;25096.74903250967;6294.307626161119;6454.290028096905;6467.223933128032;6480.902786458207;6484.351564843501;6226.501879849601;6384;6463.870722585545;6470.579412338207;6497.577657452274;6469.708863101172;6479.967600162016;6481.870362592746;6482.254540727829;6485.83785405364;6463.353664633522;6478.319776423502;6479.1901012373455;6479.611223326616;6481.902771458432;5843.298804143487;5968.343482216953;6004;6071.908921366183;6081.969590152021;27303.590446143324;27955.58066629002;28017.85991070052;28081.438371232663;28118.859405703046;2010.2059686423781;2037.7860324665844;2043.3461292386442;2043.4074118505616;2044.2845004248395;17780.110994450224;18353.816461835344;18529.722054169062;18595.163217655238;18613.069346532753;2482.143660437146;2496.5631014572377;2535.2521006303186;2541.32654846464;2543.224316583441;116539.41730291379;121198.39400803027;135925;136115;143667;14311.45832318652;14546.345414456375;14563.563093107225;14612.465691102494;14655.780163297559;22361.329160125224;22415.663765043537;22422;22457.98939047747;22502.887485562795;9603.327767056238;9853.605855765689;9866.753331166634;9894;9952;9272.7681807954;9371.906280937103;9396.248300135972;9426.575804088696;9473.100055494717;8491.787705307417;8707.259882909897;8771.824563508693;8780.473171609723;8966.193042626195;2531.873406329676;2600.9349766255996;2613.1899111275566;2694.178275625953;2761.654793150856;937.6624415210518;956.7034219391871;966.3525437956586;968.0899954043177;974.9756256093655;18583;18814.153363098692;18881.716774248398;19120.426387208405;19128.521786955436;1015.2537884654773;1017.2624846985876;1027.6454623155;1035.9533820978074;1041.234692501011;10304.536295866705;10500.31747936397;10531.15750739939;10732.839007414896;10866;470064;470648;470703;495070;498933;113741;114433.4278328603;115087.42456287665;115910.42044789722;116381;991.7173605522391;1019.4342140112161;1139.3195037319888;1164.953401863916;1189.1854079955085;20506.487337816674;20759.377218683465;20765.480862977944;20827;20934.581308373443;58893.70553147378;58986.11520827277;60057.39942600693;60702.39297607144;60920.69539652274;72210;73196.63401683171;74207.62896185485;75378;76520.23479765131;18486.630267394845;19635.509112272306;19692.21231150738;19732;19868.006599670247;20825.271115510885;21259.68110478375;21903.12387504482;22165.22421715297;22417.551648966604;17608.38370657021;17701.734473983157;17738.201780919633;17793.644127117645;17989.730154047436;16067.678646426772;16271.511854643906;16439.589010274838;16539.421120260733;16552.255148518103;17972.460826175236;17984.100794959937;18095.36666216676;18253.634927301646;18364.632707346045;18958.43124706261;18981.62036759285;19018.52453688669;19034.904825475784;19239.711404328667;17577.209025593624;17767.555811104827;17794.199261033027;17824.732629010836;17829 11:43:54 INFO - PID 30796 | |3;mootools.html;1339.2790413791388;1378.6002059402774;1407.4510940733123;1415.7027024324898;1425.8859291256701;14939.402423903044;15560.61098472536;15582.065076095429;15639.530814075568;15647.217639118055;15288.617784555363;15311.234438278098;15352.61618459539;15444.382224711026;15464.84535154648;2705.4048109415994;2835.078599455185;2838.716128387155;2840.758535524483;2866.2261189478827;2704.688960769507;2776.1255204610484;2776.583512473125;2777.083562424395;2777.8333300001964;2622.8950841966393;2730.276476733657;2731.4673638640475;2736.261209473441;2736.480068786924;2788.9442211155765;2791.4835755385116;2793.4552762211274;2801.7618502427317;2824.2515733330683;2584.702759182699;2788.5538313869683;2795.0915952315577;2800.5519116941396;2804.25687192892;15236.771448428171;15332.923335383251;15393.846061539352;15411.22943852803;15421.845781542153;7847.372210223169;8155.755327340189;8218.260356567938;8233.217844304781;8256.711015114442;5541.113421852484;5575.609707320489;5667.404922483162;5679.091345384719;5713.914291285634;1901.7812951510616;1921.798211187819;1923.6056608395245;1933.5069557262948;1957.0410498855601;26063.609045864327;26447;26541.203763886922;26559.73440265592;26605.20184394452;6863.553868998499;6966.164060312795;7016.122984626922;7164.355208031198;7194.532355396883;17387.130643467775;17411.73882391765;17439.21523531444;17452.65094698099;17554.210060547306;7854.175311592315;8009.519428834288;8020.518768873886;8088.988876390451;8096.230858068474;7267.563946163247;7401.259874012663;7419.517731347553;7619.504732192389;7620.047494063242;4782.33047373368;4989.077020751172;5010.2735103409805;5027.949720502821;5063.645544811828;1397.5807257822817;1422.3386125451714;1422.7581311177125;1435.958929775925;1439.2228196773835;846.4540371460373;850.9404341696146;860.7331727164599;867.4361664917853;869.7347309070668;7271.272872712686;7297.379722723628;7908.84182316362;8461;8576.957115214384;670.4133882852504;710.9751158709524;714.5284112485734;735.9926400735924;743.4275607782085;5190.714510701872;5333.200019997032;5486.506214440719;5606.439356064361;5614.157876318585;20356.389308320773;20750;21013.159473620883;21455.141794328363;21785;21225.68161477579;21274.36176914695;21391.46521336979;21422.89288553547;21556.245531406326;10435.530401131968;10882.075023622923;11026.393548354918;11073.778524429628;11113.388763618079;8051.959740201261;8121.918780812116;8184.877226841483;8212.644913589429;8290.46112002718;17612;17658.91170544139;17802.46592602224;17982.37061702834;18305;18768.6246275071;19130.808691912902;19525.80474195297;19596.510087247934;19680.803191967898;10730.570777169138;10898.40058796742;11063.668089957315;11183.32900026001;11198.552057917592;13420.261885596386;13715.931420342835;13725.725485490433;13745.656358591115;13760;10942.17933654963;10945.562177512811;11031.669049928514;11095.5561777528;11279.32324060559;10642.946785266024;10643;10677.359358438518;10727.141828653845;10757.569697212024;9697.951510242687;9759.658411955548;9829.164521015793;9896.406215627085;9898.752531186778;7017.403520700594;7048.365647091787;7074.823129421806;7099.467539934422;7112.822179445555;6994.125734283215;7084.787456376317;7142.857142857009;7173.928260717326;7216.7113315466795 11:43:54 INFO - PID 30796 | |4;prototype.html;499.001996007984;499.9975822167204;509.38110196111717;523.2569750953645;532.6484520216655;6199.969000154999;6343;6363.681815909204;6382.297947225801;6412.166418365618;6183.752649893999;6274.086403646886;6356.491480681546;6378.872422551546;6423.357664233575;5213.810199716109;5244.527992480676;5266.499682530153;5292.311999440068;5313.628046036779;4833.226683730604;5207.297014902996;5227.424983251839;5276.551493123089;5286.31277933868;4992;4992.076465853828;5006;5033.84898453047;5037.874053148682;5006.424261209934;5009.148444764399;5016.272640467148;5054.9241761373605;5065.848024559269;4518.118966801475;4527.524609915944;4536.092781443692;4544;4564.794584243717;6290.301618562962;6313.494920406357;6322;6337.7781777637565;6341;5782;5813.128030795415;5816.069428891357;5826.883462330729;5840.766369345221;6613.338666133348;6636;6656.70044847983;6693.0964319816685;6696.363845434725;4883.413990321184;4887.535684110004;4900.754962251873;4925.088858561177;4946.678465899741;7019.89470157948;7029.26192749754;7089.893651595178;7091.858162836766;7100.964495177543;5009;5033.094043072282;5052.8484145475695;5070.416902056237;5079.466656001066;5119.564836988898;5136.844210052708;5160.251763494347;5160.709822544364;5194.1429664105;5798.449147330997;5818.650880947157;5842.532597392198;5848.3274423441;5858.502027327725;6693.497987650946;6711.724772293249;6722.831929201809;6732.697028633724;6734.56225345351;1665.4087798831483;1713.5116491800027;1724.4136993422046;1753.333733181383;1777.6711308407987;1208.293148508115;1220.408102070495;1237.2638280223252;1239.727260002798;1249.1693024138847;5639.746211420496;5661.971690141523;5724.16999535065;5738.741756620962;5739.397363276879;6406.67966601668;6725.41952641129;6725.831854203684;6729.596224226562;6767.93232067673;5637.351704553947;5675.574331925122;5719.914201286984;5722.083102160823;5739.335592678077;3537.2041290709385;3569.44729042862;3611.819409029538;3613.837377318027;3634.47300141478;6398.808035758934;6548.8362790930605;6560.573562718408;6576.86846263072;6612.966935165389;6891.552049116892;6950;6954.582725036413;6992.440604751608;7029.89455158173;6531.0856480092825;6601.603903765694;6624.337566243434;6673.432758215509;6698.531102822951;6799.966000169968;6810.148731408574;6886.586804791728;6899.275181204699;6926.826829329106;6869.484788640772;6880.862382752417;6909.89635155463;6914.55055421396;6922.757703480354;6534.150560427304;6658.172824702052;6688.431483323972;6698.933010670026;6725.562838415487;5014.297998280171;5045.392544330821;5055.747212639427;5071.492850715046;5089.211172268304;6854.417374523221;6860.965695171492;6921.6193109379465;6933.5493192942295;6962.477814163856;6629.801105966829;6631.767888124085;6697.765578204934;6703.597784132968;6706.631135287606;6522.28254891971;6587.901181482186;6604.504662150454;6646.83382915431;6654.238491026364;6239.1577137087725;6319.689608165248;6444.581102228341;6464.256610489854;6515.609063456208;6588.352911772057;6687.465002799861;6688.665566721547;6714.865702686016;6737.562058466184;6371;6429.807105786834;6485.124508191334;6517.732728008142;6542.658754955128 11:43:54 INFO - PID 30796 | |5;yui.html;901.6844104563402;922.1239822168933;944.4474982135446;953.1897886796224;955.9044095590442;17456.825431745678;17819.46541603754;18036.098195090257;18057.09714514274;18083.095845207754;17945.28218871247;18088.909555452236;18140;18233.726494102564;18746.81253187468;953.0612346838359;967.0812727908515;969.060011788564;969.5346233807777;970.3789574672215;975.5805003848342;978.5694294510429;981.0630847540617;981.7054883534911;982.2534873496123;979.6228452045978;1005.7234260578363;1011.6307547745093;1014.0873214107289;1032.7263275232033;1000.2148313573882;1003.7289931718432;1004.2016596805521;1004.2217281606777;1004.291974158224;710.8542748736496;728.6393235348484;728.8797348437502;731.5025782467919;744.7393412305704;19759.506012349808;19937.800621993738;19967;20037.49906252341;20067.1973121075;20876.582468350698;20994.685079723815;21220.893895530422;21255.893720531298;21430.035648395704;16627.66744665112;16787.91606041962;17005.404810831562;17066.48800535986;17353.132343382782;3724.571674257468;3771.07608635886;3771.7925514096714;3773.3773927301963;3775.0184951912424;137094.3145284267;137444.31277843547;138407.30796346054;140526.2973685125;142498;16321.918390407973;16478.09370484611;16493.505194843932;16678.33286668544;16685.24916378766;29798.55302170469;30233.546496802126;30285.394292114033;30321.848390757907;30412.54381184284;8400.075991640915;8487;8561.614727337284;8567.485950842969;8572.314214862796;4192.182524407772;4302.333138363559;4308.80610372534;4314.590113939171;4321.67587430944;5326.92009619856;5339.145736682112;5376.973115134399;5385.219143224211;5402.864928376744;968.0609808485758;989.2086330935223;1001.4942454060653;1006.3509036671306;1011.6661501704419;663.0485253660916;669.7689297192461;688.7795905310253;694.4409750151076;695.5200911371239;10819.78360432787;11656.650300491;11667.6499705009;12477.812832807514;12538.185017973985;657.6054367379534;687.1479365586637;694.035290945586;706.3466293678327;712.4478529139855;5562.527185189304;5642.463965923313;5686.545076393879;5735.11105778605;5760.654360738369;123839;124160;126746;127872;130573;110819;112266;113765;114578;115442;95070;99567.50216248873;101346;102426.48786756018;103256;10574.312669676447;10593.364398136137;10623.203259755395;10655.786884262427;10869.891301086887;42939.141217176104;43127.784361078;43865.78067109644;44170.558294416645;44326.335104974096;56877.431225687214;56929.71535142298;57582.424175759385;57796.422035780786;58059.41940580709;13884.375203116086;14065.859341406864;14212;14334.354954027302;14344.067635603653;17530.386436474662;17742.73385899187;17779.644407112042;17911.641767164325;18014.549636258675;15595.610109747347;15694;16014.119223442822;16031.198440078182;16088.195590220676;14591.562253132422;14624.634384140481;14738.778918316018;14772.48296309624;14808.407663693331;14046.929765351517;14174.645633859236;14191.574252772434;14254.714905702036;14259.786103208253;11404.372759498307;11458.713532161762;11587.942060289644;11924.582639607572;11942.522299108286;10731.809582757152;10862.185336099983;10880.67357979262;10967.122630189406;11044.834327485254 11:43:54 INFO - PID 30796 | __end_tp_report 11:43:54 INFO - PID 30796 | __start_cc_report 11:43:54 INFO - PID 30796 | _x_x_mozilla_cycle_collect,290 11:43:54 INFO - PID 30796 | __end_cc_report 11:43:54 INFO - PID 30796 | __startTimestamp1505760234819__endTimestamp 11:43:54 INFO - PID 30796 | 11:43:54 INFO - PID 30796 | ------- Summary: start ------- 11:43:54 INFO - PID 30796 | Number of tests: 6 11:43:54 INFO - PID 30796 | 11:43:54 INFO - PID 30796 | [#0] dojo.html Cycles:165 Average:6239.28 Median:6482.87 stddev:849.28 (13.1%) stddev-sans-first:816.26 11:43:54 INFO - PID 30796 | Values: 3136.5 3146.3 3146.4 3153.3 3172.9 6207.9 6248.5 6267.0 6377.0 6393.8 6287.6 6299.2 6313.4 6316.7 6327.9 5824.3 5828.3 5837.3 5848.8 5986.6 5899.1 5951.8 5994.6 6007.2 6077.6 1240.8 5816.9 5943.4 5996.3 6007.5 5813.1 5822.4 5846.9 5915.2 5916.4 5842.1 5844.2 5874.2 5916.1 5936.7 6333.7 6379.6 6398.2 6443.5 6476.5 6819.3 6841.1 6907.3 6910.5 6973.6 6667.5 6787.5 6825.8 6921.9 7018.2 6317.1 6320.4 6375.6 6377.1 6410.7 7028.5 7042.9 7106.8 7113.4 7116.4 6531.2 6649.8 6705.0 6728.5 6774.5 6765.4 6765.4 6769.7 6778.5 6783.7 6704.7 6732.2 6737.8 6739.7 6752.2 6700.5 6788.2 6789.5 6791.3 6799.2 5299.5 5423.7 5446.9 5449.1 5456.1 4612.6 4680.0 4725.6 4743.7 4782.1 5652.9 5767.9 5797.0 5849.4 5849.5 6822.7 6823.8 6849.8 6860.0 6861.0 5738.7 5797.0 5804.5 5822.6 5829.5 5778.3 5817.7 5863.8 5868.4 5872.8 6450.2 6549.9 6589.4 6677.1 6722.2 6774.2 6787.8 6788.4 6792.7 6798.7 6411.9 6541.4 6541.5 6562.5 6563.0 6767.2 6804.0 6809.4 6835.9 6836.6 6864.3 6874.1 6945.1 6969.0 6981.4 6494.3 6618.0 6625.6 6716.1 6725.5 6468.2 6472.8 6478.2 6496.7 6501.7 6504.8 6614.7 6619.8 6621.5 6621.6 6697.9 6744.7 6759.0 6759.7 6779.0 6455.6 6467.5 6482.9 6537.6 6551.9 11:43:54 INFO - PID 30796 | 11:43:54 INFO - PID 30796 | [#1] ext.html Cycles:180 Average:37103.77 Median:35770.14 stddev:52313.27 (146.2%) stddev-sans-first:52388.91 11:43:54 INFO - PID 30796 | Values: 777.2 803.5 805.9 807.5 807.9 39409.0 42932.6 43043.0 43091.8 43120.1 37756.0 38083.2 38084.6 38104.8 38105.4 7001.9 7150.3 7778.4 7954.0 7966.1 7845.5 7944.6 7946.0 7946.6 7948.1 7931.6 7953.6 7968.8 7969.8 7992.7 7845.4 7929.8 7934.2 7939.0 7944.6 7776.6 7799.2 7826.9 7853.4 7888.3 38379.0 38670.4 38952.6 39010.8 39020.4 3540.7 3594.7 3600.7 3611.1 3612.6 31375.7 31535.5 31723.5 31856.2 32047.5 5171.9 5195.9 5228.0 5239.6 5240.3 194092.0 194337.0 195424.0 195481.0 195698.0 43278.4 43842.0 50081.7 50364.2 50393.0 51091.0 51953.5 52056.2 52151.8 52164.5 15253.2 15310.6 15331.8 15406.3 15419.3 12451.4 12480.6 12494.8 12522.6 12536.2 13556.8 13689.9 13711.3 13744.7 13855.7 5503.2 5508.2 5628.0 5680.0 5732.9 997.1 1017.1 1017.8 1028.4 1040.7 22803.8 22882.1 23021.0 23341.0 23529.0 1094.7 1112.4 1123.4 1126.8 1135.6 11711.2 11969.6 12122.2 12142.1 12240.1 220598.0 220812.0 221177.0 221305.0 221699.0 53236.5 53323.7 53349.7 53412.7 53433.2 1402.6 1448.1 1454.2 1464.9 1479.0 22012.8 22148.4 22279.0 22507.9 22857.8 37985.2 38183.4 38200.6 38235.8 38246.8 187029.0 187902.0 188800.0 188890.0 189859.0 31184.4 31899.0 33516.8 34769.3 34973.0 42874.6 43317.8 43321.4 43473.0 44260.0 32238.8 32340.0 32411.0 32538.5 33172.0 31329.7 32005.8 32138.7 32430.4 32646.3 35761.5 35778.8 35872.1 36049.0 36095.0 30996.7 31146.8 31276.7 31540.6 32135.7 22931.0 23491.5 23523.5 23680.4 23767.4 11:43:54 INFO - PID 30796 | 11:43:54 INFO - PID 30796 | [#2] jquery.html Cycles:180 Average:34520.39 Median:22900.60 stddev:81026.31 (353.8%) stddev-sans-first:81213.47 11:43:54 INFO - PID 30796 | Values: 550.2 553.7 563.6 574.1 596.4 22016.6 22867.8 22933.4 23021.9 23088.3 23441.5 24186.5 24630.8 24994.0 25096.7 6294.3 6454.3 6467.2 6480.9 6484.4 6226.5 6384.0 6463.9 6470.6 6497.6 6469.7 6480.0 6481.9 6482.3 6485.8 6463.4 6478.3 6479.2 6479.6 6481.9 5843.3 5968.3 6004.0 6071.9 6082.0 27303.6 27955.6 28017.9 28081.4 28118.9 2010.2 2037.8 2043.3 2043.4 2044.3 17780.1 18353.8 18529.7 18595.2 18613.1 2482.1 2496.6 2535.3 2541.3 2543.2 116539.4 121198.4 135925.0 136115.0 143667.0 14311.5 14546.3 14563.6 14612.5 14655.8 22361.3 22415.7 22422.0 22458.0 22502.9 9603.3 9853.6 9866.8 9894.0 9952.0 9272.8 9371.9 9396.2 9426.6 9473.1 8491.8 8707.3 8771.8 8780.5 8966.2 2531.9 2600.9 2613.2 2694.2 2761.7 937.7 956.7 966.4 968.1 975.0 18583.0 18814.2 18881.7 19120.4 19128.5 1015.3 1017.3 1027.6 1036.0 1041.2 10304.5 10500.3 10531.2 10732.8 10866.0 470064.0 470648.0 470703.0 495070.0 498933.0 113741.0 114433.4 115087.4 115910.4 116381.0 991.7 1019.4 1139.3 1165.0 1189.2 20506.5 20759.4 20765.5 20827.0 20934.6 58893.7 58986.1 60057.4 60702.4 60920.7 72210.0 73196.6 74207.6 75378.0 76520.2 18486.6 19635.5 19692.2 19732.0 19868.0 20825.3 21259.7 21903.1 22165.2 22417.6 17608.4 17701.7 17738.2 17793.6 17989.7 16067.7 16271.5 16439.6 16539.4 16552.3 17972.5 17984.1 18095.4 18253.6 18364.6 18958.4 18981.6 19018.5 19034.9 19239.7 17577.2 17767.6 17794.2 17824.7 17829.0 11:43:54 INFO - PID 30796 | 11:43:54 INFO - PID 30796 | [#3] mootools.html Cycles:180 Average:9279.66 Median:2733.86 stddev:6622.81 (242.3%) stddev-sans-first:6614.51 11:43:54 INFO - PID 30796 | Values: 1339.3 1378.6 1407.5 1415.7 1425.9 14939.4 15560.6 15582.1 15639.5 15647.2 15288.6 15311.2 15352.6 15444.4 15464.8 2705.4 2835.1 2838.7 2840.8 2866.2 2704.7 2776.1 2776.6 2777.1 2777.8 2622.9 2730.3 2731.5 2736.3 2736.5 2788.9 2791.5 2793.5 2801.8 2824.3 2584.7 2788.6 2795.1 2800.6 2804.3 15236.8 15332.9 15393.8 15411.2 15421.8 7847.4 8155.8 8218.3 8233.2 8256.7 5541.1 5575.6 5667.4 5679.1 5713.9 1901.8 1921.8 1923.6 1933.5 1957.0 26063.6 26447.0 26541.2 26559.7 26605.2 6863.6 6966.2 7016.1 7164.4 7194.5 17387.1 17411.7 17439.2 17452.7 17554.2 7854.2 8009.5 8020.5 8089.0 8096.2 7267.6 7401.3 7419.5 7619.5 7620.0 4782.3 4989.1 5010.3 5027.9 5063.6 1397.6 1422.3 1422.8 1436.0 1439.2 846.5 850.9 860.7 867.4 869.7 7271.3 7297.4 7908.8 8461.0 8577.0 670.4 711.0 714.5 736.0 743.4 5190.7 5333.2 5486.5 5606.4 5614.2 20356.4 20750.0 21013.2 21455.1 21785.0 21225.7 21274.4 21391.5 21422.9 21556.2 10435.5 10882.1 11026.4 11073.8 11113.4 8052.0 8121.9 8184.9 8212.6 8290.5 17612.0 17658.9 17802.5 17982.4 18305.0 18768.6 19130.8 19525.8 19596.5 19680.8 10730.6 10898.4 11063.7 11183.3 11198.6 13420.3 13715.9 13725.7 13745.7 13760.0 10942.2 10945.6 11031.7 11095.6 11279.3 10642.9 10643.0 10677.4 10727.1 10757.6 9698.0 9759.7 9829.2 9896.4 9898.8 7017.4 7048.4 7074.8 7099.5 7112.8 6994.1 7084.8 7142.9 7173.9 7216.7 11:43:54 INFO - PID 30796 | 11:43:54 INFO - PID 30796 | [#4] prototype.html Cycles:180 Average:5602.24 Median:6316.59 stddev:1581.19 (25.0%) stddev-sans-first:1538.53 11:43:54 INFO - PID 30796 | Values: 499.0 500.0 509.4 523.3 532.6 6200.0 6343.0 6363.7 6382.3 6412.2 6183.8 6274.1 6356.5 6378.9 6423.4 5213.8 5244.5 5266.5 5292.3 5313.6 4833.2 5207.3 5227.4 5276.6 5286.3 4992.0 4992.1 5006.0 5033.8 5037.9 5006.4 5009.1 5016.3 5054.9 5065.8 4518.1 4527.5 4536.1 4544.0 4564.8 6290.3 6313.5 6322.0 6337.8 6341.0 5782.0 5813.1 5816.1 5826.9 5840.8 6613.3 6636.0 6656.7 6693.1 6696.4 4883.4 4887.5 4900.8 4925.1 4946.7 7019.9 7029.3 7089.9 7091.9 7101.0 5009.0 5033.1 5052.8 5070.4 5079.5 5119.6 5136.8 5160.3 5160.7 5194.1 5798.4 5818.7 5842.5 5848.3 5858.5 6693.5 6711.7 6722.8 6732.7 6734.6 1665.4 1713.5 1724.4 1753.3 1777.7 1208.3 1220.4 1237.3 1239.7 1249.2 5639.7 5662.0 5724.2 5738.7 5739.4 6406.7 6725.4 6725.8 6729.6 6767.9 5637.4 5675.6 5719.9 5722.1 5739.3 3537.2 3569.4 3611.8 3613.8 3634.5 6398.8 6548.8 6560.6 6576.9 6613.0 6891.6 6950.0 6954.6 6992.4 7029.9 6531.1 6601.6 6624.3 6673.4 6698.5 6800.0 6810.1 6886.6 6899.3 6926.8 6869.5 6880.9 6909.9 6914.6 6922.8 6534.2 6658.2 6688.4 6698.9 6725.6 5014.3 5045.4 5055.7 5071.5 5089.2 6854.4 6861.0 6921.6 6933.5 6962.5 6629.8 6631.8 6697.8 6703.6 6706.6 6522.3 6587.9 6604.5 6646.8 6654.2 6239.2 6319.7 6444.6 6464.3 6515.6 6588.4 6687.5 6688.7 6714.9 6737.6 6371.0 6429.8 6485.1 6517.7 6542.7 11:43:54 INFO - PID 30796 | 11:43:54 INFO - PID 30796 | [#5] yui.html Cycles:180 Average:24417.12 Median:18086.00 stddev:36211.10 (200.2%) stddev-sans-first:36269.64 11:43:54 INFO - PID 30796 | Values: 901.7 922.1 944.4 953.2 955.9 17456.8 17819.5 18036.1 18057.1 18083.1 17945.3 18088.9 18140.0 18233.7 18746.8 953.1 967.1 969.1 969.5 970.4 975.6 978.6 981.1 981.7 982.3 979.6 1005.7 1011.6 1014.1 1032.7 1000.2 1003.7 1004.2 1004.2 1004.3 710.9 728.6 728.9 731.5 744.7 19759.5 19937.8 19967.0 20037.5 20067.2 20876.6 20994.7 21220.9 21255.9 21430.0 16627.7 16787.9 17005.4 17066.5 17353.1 3724.6 3771.1 3771.8 3773.4 3775.0 137094.3 137444.3 138407.3 140526.3 142498.0 16321.9 16478.1 16493.5 16678.3 16685.2 29798.6 30233.5 30285.4 30321.8 30412.5 8400.1 8487.0 8561.6 8567.5 8572.3 4192.2 4302.3 4308.8 4314.6 4321.7 5326.9 5339.1 5377.0 5385.2 5402.9 968.1 989.2 1001.5 1006.4 1011.7 663.0 669.8 688.8 694.4 695.5 10819.8 11656.7 11667.6 12477.8 12538.2 657.6 687.1 694.0 706.3 712.4 5562.5 5642.5 5686.5 5735.1 5760.7 123839.0 124160.0 126746.0 127872.0 130573.0 110819.0 112266.0 113765.0 114578.0 115442.0 95070.0 99567.5 101346.0 102426.5 103256.0 10574.3 10593.4 10623.2 10655.8 10869.9 42939.1 43127.8 43865.8 44170.6 44326.3 56877.4 56929.7 57582.4 57796.4 58059.4 13884.4 14065.9 14212.0 14334.4 14344.1 17530.4 17742.7 17779.6 17911.6 18014.5 15595.6 15694.0 16014.1 16031.2 16088.2 14591.6 14624.6 14738.8 14772.5 14808.4 14046.9 14174.6 14191.6 14254.7 14259.8 11404.4 11458.7 11587.9 11924.6 11942.5 10731.8 10862.2 10880.7 10967.1 11044.8 11:43:54 INFO - PID 30796 | -------- Summary: end -------- 11:43:54 INFO - PID 30796 | 11:43:55 INFO - TEST-INFO | 30796: exit 0 11:43:55 INFO - TEST-OK | dromaeo_css | took 1109940ms 11:43:55 INFO - TEST-START | kraken 11:43:55 INFO - Initialising browser for kraken test... 11:43:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57123/getInfo.html -profile /tmp/tmpughE9R/profile 11:43:55 INFO - TEST-INFO | started process 31160 (/builds/slave/test/build/application/firefox/firefox http://localhost:57123/getInfo.html) 11:44:01 INFO - TEST-INFO | 31160: exit 0 11:44:01 INFO - Browser initialized. 11:44:01 INFO - Running cycle 1/1 for kraken test... 11:44:01 INFO - Using env: {'DISPLAY': ':0', 11:44:01 INFO - 'HOME': '/home/cltbld', 11:44:01 INFO - 'JSGC_DISABLE_POISONING': '1', 11:44:01 INFO - 'LANG': 'en_US.UTF-8', 11:44:01 INFO - 'LANGUAGE': 'en_US:en', 11:44:01 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:44:01 INFO - 'LOGNAME': 'cltbld', 11:44:01 INFO - 'MAIL': '/var/mail/cltbld', 11:44:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:44:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:44:01 INFO - 'MOZ_CRASHREPORTER': '1', 11:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:01 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:44:01 INFO - 'MOZ_NO_REMOTE': '1', 11:44:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:01 INFO - 'NO_EM_RESTART': '1', 11:44:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:01 INFO - 'PWD': '/builds/slave/test', 11:44:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:44:01 INFO - 'RUST_BACKTRACE': 'full', 11:44:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:44:01 INFO - 'SHELL': '/bin/bash', 11:44:01 INFO - 'SHLVL': '1', 11:44:01 INFO - 'STYLO_FORCE_DISABLED': '1', 11:44:01 INFO - 'TERM': 'linux', 11:44:01 INFO - 'TMOUT': '86400', 11:44:01 INFO - 'USER': 'cltbld', 11:44:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792', 11:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:01 INFO - '_': '/tools/buildbot/bin/python'} 11:44:01 INFO - TEST-INFO | started process 31397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpughE9R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:02 INFO - PID 31397 | 11:44:02 INFO - PID 31397 | (/builds/slave/test/build/application/firefox/firefox:31446): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:44:02 INFO - PID 31397 | 11:44:12 INFO - PID 31397 | RSS: Main: 154820608 11:44:12 INFO - PID 31397 | 11:44:15 INFO - PID 31397 | Cycle 1(1): loaded http://localhost:57123/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57123/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:16 INFO - PID 31397 | RSS: Main: 160157696 11:44:16 INFO - PID 31397 | 11:44:18 INFO - PID 31397 | Cycle 1(1): loaded http://localhost:57123/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57123/tests/kraken/driver.html?testName=audio-dft) 11:44:19 INFO - PID 31397 | RSS: Main: 160440320 11:44:19 INFO - PID 31397 | 11:44:22 INFO - PID 31397 | Cycle 1(1): loaded http://localhost:57123/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57123/tests/kraken/driver.html?testName=audio-fft) 11:44:23 INFO - PID 31397 | RSS: Main: 157659136 11:44:23 INFO - PID 31397 | 11:44:25 INFO - PID 31397 | Cycle 1(1): loaded http://localhost:57123/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57123/tests/kraken/driver.html?testName=audio-oscillator) 11:44:25 INFO - PID 31397 | RSS: Main: 157683712 11:44:25 INFO - PID 31397 | 11:44:27 INFO - PID 31397 | Cycle 1(1): loaded http://localhost:57123/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57123/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:28 INFO - PID 31397 | RSS: Main: 157786112 11:44:28 INFO - PID 31397 | 11:44:31 INFO - PID 31397 | Cycle 1(1): loaded http://localhost:57123/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57123/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:32 INFO - PID 31397 | RSS: Main: 160231424 11:44:32 INFO - PID 31397 | 11:44:35 INFO - PID 31397 | Cycle 1(1): loaded http://localhost:57123/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57123/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:36 INFO - PID 31397 | RSS: Main: 160186368 11:44:36 INFO - PID 31397 | 11:44:39 INFO - PID 31397 | Cycle 1(1): loaded http://localhost:57123/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57123/tests/kraken/driver.html?testName=json-parse-financial) 11:44:40 INFO - PID 31397 | RSS: Main: 160407552 11:44:40 INFO - PID 31397 | 11:44:41 INFO - PID 31397 | Cycle 1(1): loaded http://localhost:57123/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57123/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:42 INFO - PID 31397 | RSS: Main: 160661504 11:44:42 INFO - PID 31397 | 11:44:44 INFO - PID 31397 | Cycle 1(1): loaded http://localhost:57123/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57123/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:44 INFO - PID 31397 | RSS: Main: 157790208 11:44:44 INFO - PID 31397 | 11:44:46 INFO - PID 31397 | Cycle 1(1): loaded http://localhost:57123/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57123/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:47 INFO - PID 31397 | RSS: Main: 157466624 11:44:47 INFO - PID 31397 | 11:44:50 INFO - PID 31397 | Cycle 1(1): loaded http://localhost:57123/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57123/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:50 INFO - PID 31397 | RSS: Main: 158089216 11:44:50 INFO - PID 31397 | 11:44:53 INFO - PID 31397 | Cycle 1(1): loaded http://localhost:57123/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57123/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:54 INFO - PID 31397 | RSS: Main: 158240768 11:44:54 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | Cycle 1(1): loaded http://localhost:57123/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57123/tests/kraken/driver.html?testName=ai-astar) 11:44:56 INFO - PID 31397 | RSS: Main: 159260672 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | __start_tp_report 11:44:56 INFO - PID 31397 | _x_x_mozilla_page_load 11:44:56 INFO - PID 31397 | _x_x_mozilla_page_load_details 11:44:56 INFO - PID 31397 | |i|pagename|runs| 11:44:56 INFO - PID 31397 | |0;ai-astar;108;108;108;107;107;115;108;107;108;109 11:44:56 INFO - PID 31397 | |1;audio-beat-detection;122;117;117;117;117;118;119;147;116;115 11:44:56 INFO - PID 31397 | |2;audio-dft;164;164;164;165;163;164;164;166;169;184 11:44:56 INFO - PID 31397 | |3;audio-fft;73;75;76;73;74;75;75;74;73;75 11:44:56 INFO - PID 31397 | |4;audio-oscillator;79;80;79;79;79;79;79;84;82;80 11:44:56 INFO - PID 31397 | |5;imaging-gaussian-blur;114;115;112;114;114;114;114;114;114;114 11:44:56 INFO - PID 31397 | |6;imaging-darkroom;147;147;150;148;148;149;150;149;148;149 11:44:56 INFO - PID 31397 | |7;imaging-desaturate;98;94;94;95;94;98;94;94;94;95 11:44:56 INFO - PID 31397 | |8;json-parse-financial;57;56;54;53;55;53;59;54;54;54 11:44:56 INFO - PID 31397 | |9;json-stringify-tinderbox;38;38;38;37;38;38;37;37;38;38 11:44:56 INFO - PID 31397 | |10;stanford-crypto-aes;74;75;81;77;76;80;75;74;79;75 11:44:56 INFO - PID 31397 | |11;stanford-crypto-ccm;115;122;110;114;118;111;118;113;111;116 11:44:56 INFO - PID 31397 | |12;stanford-crypto-pbkdf2;169;180;179;174;167;169;174;175;169;175 11:44:56 INFO - PID 31397 | |13;stanford-crypto-sha256-iterative;71;64;67;65;69;69;65;69;69;65 11:44:56 INFO - PID 31397 | __end_tp_report 11:44:56 INFO - PID 31397 | __start_cc_report 11:44:56 INFO - PID 31397 | _x_x_mozilla_cycle_collect,766 11:44:56 INFO - PID 31397 | __end_cc_report 11:44:56 INFO - PID 31397 | __startTimestamp1505760296329__endTimestamp 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | ------- Summary: start ------- 11:44:56 INFO - PID 31397 | Number of tests: 14 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | [#0] ai-astar Cycles:10 Average:108.50 Median:108.00 stddev:2.37 (2.2%) stddev-sans-first:2.51 11:44:56 INFO - PID 31397 | Values: 108.0 108.0 108.0 107.0 107.0 115.0 108.0 107.0 108.0 109.0 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | [#1] audio-beat-detection Cycles:10 Average:120.50 Median:117.50 stddev:9.50 (8.1%) stddev-sans-first:10.06 11:44:56 INFO - PID 31397 | Values: 122.0 117.0 117.0 117.0 117.0 118.0 119.0 147.0 116.0 115.0 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | [#2] audio-dft Cycles:10 Average:166.70 Median:164.50 stddev:6.31 (3.8%) stddev-sans-first:6.61 11:44:56 INFO - PID 31397 | Values: 164.0 164.0 164.0 165.0 163.0 164.0 164.0 166.0 169.0 184.0 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | [#3] audio-fft Cycles:10 Average:74.30 Median:75.00 stddev:1.06 (1.4%) stddev-sans-first:1.01 11:44:56 INFO - PID 31397 | Values: 73.0 75.0 76.0 73.0 74.0 75.0 75.0 74.0 73.0 75.0 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | [#4] audio-oscillator Cycles:10 Average:80.00 Median:79.50 stddev:1.70 (2.1%) stddev-sans-first:1.76 11:44:56 INFO - PID 31397 | Values: 79.0 80.0 79.0 79.0 79.0 79.0 79.0 84.0 82.0 80.0 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 11:44:56 INFO - PID 31397 | Values: 114.0 115.0 112.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 11:44:56 INFO - PID 31397 | Values: 147.0 147.0 150.0 148.0 148.0 149.0 150.0 149.0 148.0 149.0 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.50 stddev:1.63 (1.7%) stddev-sans-first:1.32 11:44:56 INFO - PID 31397 | Values: 98.0 94.0 94.0 95.0 94.0 98.0 94.0 94.0 94.0 95.0 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.50 stddev:1.91 (3.5%) stddev-sans-first:1.87 11:44:56 INFO - PID 31397 | Values: 57.0 56.0 54.0 53.0 55.0 53.0 59.0 54.0 54.0 54.0 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 11:44:56 INFO - PID 31397 | Values: 38.0 38.0 38.0 37.0 38.0 38.0 37.0 37.0 38.0 38.0 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.50 stddev:2.55 (3.3%) stddev-sans-first:2.52 11:44:56 INFO - PID 31397 | Values: 74.0 75.0 81.0 77.0 76.0 80.0 75.0 74.0 79.0 75.0 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | [#11] stanford-crypto-ccm Cycles:10 Average:114.80 Median:115.50 stddev:3.79 (3.3%) stddev-sans-first:4.02 11:44:56 INFO - PID 31397 | Values: 115.0 122.0 110.0 114.0 118.0 111.0 118.0 113.0 111.0 116.0 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:174.50 stddev:4.46 (2.6%) stddev-sans-first:4.48 11:44:56 INFO - PID 31397 | Values: 169.0 180.0 179.0 174.0 167.0 169.0 174.0 175.0 169.0 175.0 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:69.00 stddev:2.41 (3.5%) stddev-sans-first:2.15 11:44:56 INFO - PID 31397 | Values: 71.0 64.0 67.0 65.0 69.0 69.0 65.0 69.0 69.0 65.0 11:44:56 INFO - PID 31397 | -------- Summary: end -------- 11:44:56 INFO - PID 31397 | 11:44:56 INFO - PID 31397 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:44:57 INFO - TEST-INFO | 31397: exit 0 11:44:57 INFO - TEST-OK | kraken | took 61510ms 11:44:57 INFO - SUITE-END | took 1171s 11:44:57 INFO - Completed test suite (00:19:31) 11:44:57 INFO - javascript benchmark 11:44:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8497.339060635351, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3136.5138403547458, 3146.323540438805, 3146.4021835851186, 3153.322035762311, 3172.8572214250357, 6207.937920620792, 6248.531360147985, 6267.0286105653695, 6377.0, 6393.840153996147, 6287.559870809046, 6299.2440907091095, 6313.368663133684, 6316.684165791715, 6327.9367206327925, 5824.330202026757, 5828.300603927513, 5837.328707198684, 5848.766049358021, 5986.580939334249, 5899.115132730082, 5951.821445356624, 5994.580379373446, 6007.15899774032, 6077.574569780095, 1240.787587152844, 5816.912746308809, 5943.375945525722, 5996.2804463464445, 6007.4893634041155, 5813.128030795372, 5822.417758224186, 5846.853828654275, 5915.201447804534, 5916.408359164092, 5842.094475356326, 5844.22347310733, 5874.206982057453, 5916.083007133901, 5936.673482958436, 6333.651649159295, 6379.617222966637, 6398.200224971879, 6443.452306553949, 6476.514261430411, 6819.318068193191, 6841.144856892888, 6907.309269073103, 6910.516263861532, 6973.616451095188, 6667.499937504658, 6787.524873258873, 6825.829354266133, 6921.930780692179, 7018.192907815615, 6317.084022816712, 6320.4311611955145, 6375.585586936834, 6377.07532407803, 6410.679466026727, 7028.472864535181, 7042.859142817218, 7106.822329441702, 7113.430925525946, 7116.430685545144, 6531.171272043835, 6649.833754156185, 6705.0, 6728.461723062143, 6774.45804335652, 6765.357291057342, 6765.42493888025, 6769.729210831511, 6778.525503214728, 6783.660816959133, 6704.698288577026, 6732.225794033651, 6737.764178253738, 6739.663016849138, 6752.155980502437, 6700.463962882957, 6788.219354774165, 6789.490788190906, 6791.2869148739655, 6799.184097908283, 5299.549538289211, 5423.701696406657, 5446.863828404322, 5449.073657478239, 5456.072467680504, 4612.630989520897, 4679.976600117046, 4725.574698277172, 4743.715377077387, 4782.067496838153, 5652.85867853307, 5767.942320576741, 5796.987027341745, 5849.415058494202, 5849.473547380671, 6822.692978815965, 6823.795286141423, 6849.794506164823, 6860.03959445678, 6861.039454476378, 5738.68437235956, 5796.971015144897, 5804.477597016289, 5822.592418530747, 5829.47534721877, 5778.3354914184565, 5817.7091145442555, 5863.794767183128, 5868.413158684098, 5872.765089396376, 6450.193725784277, 6549.9345006550275, 6589.439897608661, 6677.065210870482, 6722.193336799518, 6774.220964589037, 6787.762428314985, 6788.355106264897, 6792.72829086831, 6798.694058767268, 6411.871762564816, 6541.443977261986, 6541.542092053511, 6562.5406221564035, 6563.04835798816, 6767.154105736783, 6804.0, 6809.38715515606, 6835.906254999375, 6836.555623884432, 6864.347886950732, 6874.106366172366, 6945.062416573698, 6968.965155174192, 6981.406580440719, 6494.253160886558, 6617.966910165418, 6625.569337993015, 6716.059751634677, 6725.4619630430425, 6468.15913931186, 6472.773452929125, 6478.222613286247, 6496.74013039492, 6501.739930402731, 6504.772332968323, 6614.735410583523, 6619.834504137435, 6621.503387246072, 6621.569597976116, 6697.933020669926, 6744.696488657924, 6758.966205168943, 6759.729610815512, 6779.0, 6455.61266324022, 6467.450266727381, 6482.870342593216, 6537.607743535403, 6551.868962620816], "value": 6177.243480113684, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.2111307023372, 803.5138741061661, 805.9435839491238, 807.4590024683463, 807.9353651707864, 39409.0, 42932.570674293245, 43043.0, 43091.78454107725, 43120.13759724804, 37756.0, 38083.238335233276, 38084.61915380845, 38104.80947595265, 38105.428418573676, 7001.929980700192, 7150.320719531636, 7778.4166187535875, 7953.96023019887, 7966.123726390092, 7845.450818442711, 7944.56304903233, 7946.0, 7946.602669866513, 7948.125706172316, 7931.603419828985, 7953.642086106111, 7968.800779980518, 7969.760907172794, 7992.720254791084, 7845.372370210398, 7929.841403171962, 7934.206579342077, 7939.047314322261, 7944.6027698614835, 7776.572288524186, 7799.220077992212, 7826.882596761053, 7853.371730261565, 7888.2506161914525, 38379.0, 38670.419943700865, 38952.61047389547, 39010.804945975375, 39020.41469377962, 3540.716742660581, 3594.712423006153, 3600.6939410150167, 3611.115276757211, 3612.602613712516, 31375.686243137505, 31535.526967095513, 31723.52414713781, 31856.20359491008, 32047.51928721071, 5171.922421163686, 5195.870103247411, 5228.006678731029, 5239.607029472767, 5240.3187585614005, 194092.0, 194337.0, 195424.0, 195481.0, 195698.0, 43278.35082473765, 43842.0, 50081.74959125181, 50364.244536331986, 50393.0, 51091.0, 51953.48046519562, 52056.21915671268, 52151.784821518304, 52164.478355215964, 15253.237338133049, 15310.617234569003, 15331.770023449433, 15406.306716197798, 15419.306131224123, 12451.439685214187, 12480.625581232396, 12494.75010499785, 12522.624321270376, 12536.247825130522, 13556.796648050287, 13689.931550342184, 13711.314434278247, 13744.65638359049, 13855.653608659662, 5503.229547863302, 5508.173773933861, 5627.971860140673, 5679.971600141973, 5732.914006289909, 997.1275134257525, 1017.0897047142765, 1017.801528701896, 1028.3983869436463, 1040.6929955663097, 22803.805278032123, 22882.084716611484, 23021.0, 23341.0, 23529.0, 1094.7372630568607, 1112.449337577888, 1123.43828085957, 1126.774645070989, 1135.6195674448986, 11711.180217384872, 11969.581064662694, 12122.151449398458, 12142.089343299287, 12240.143189976794, 220598.0, 220812.0, 221177.0, 221305.0, 221699.0, 53236.46763532315, 53323.733381332844, 53349.73325133427, 53412.732936335844, 53433.198502022504, 1402.6002589262216, 1448.109412711196, 1454.2365258239297, 1464.9414023438942, 1479.0, 22012.789296588842, 22148.446288842908, 22279.0, 22507.887460562593, 22857.771422285565, 37985.2402951945, 38183.42724859185, 38200.61799381971, 38235.80882095572, 38246.80876595599, 187029.0, 187902.0, 188800.0, 188890.0, 189859.0, 31184.37631247317, 31899.043028709177, 33516.832415837765, 34769.30461390808, 34973.0, 42874.57125428706, 43317.783411082746, 43321.350179746696, 43473.0, 44260.0, 32238.838805805823, 32340.0, 32411.0, 32538.511922321657, 33172.0, 31329.68670313359, 32005.839970799996, 32138.71445142168, 32430.35139297248, 32646.34707305888, 35761.46357804583, 35778.821105894305, 35872.10319742027, 36049.0, 36095.0, 30996.69003309938, 31146.844265778527, 31276.687233127377, 31540.588840190343, 32135.67864321327, 22931.018967534113, 23491.530169396858, 23523.529529409658, 23680.407989799704, 23767.405814854075], "value": 17048.704209200874, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.2296784501697, 553.7203712125377, 563.6223730100829, 574.0900672434192, 596.4006173795334, 22016.559668806614, 22867.77132228677, 22933.4266643334, 23021.884890575544, 23088.30735077946, 23441.531169376645, 24186.516269674597, 24630.75369246307, 24994.0, 25096.74903250967, 6294.307626161119, 6454.290028096905, 6467.223933128032, 6480.902786458207, 6484.351564843501, 6226.501879849601, 6384.0, 6463.870722585545, 6470.579412338207, 6497.577657452274, 6469.708863101172, 6479.967600162016, 6481.870362592746, 6482.254540727829, 6485.83785405364, 6463.353664633522, 6478.319776423502, 6479.1901012373455, 6479.611223326616, 6481.902771458432, 5843.298804143487, 5968.343482216953, 6004.0, 6071.908921366183, 6081.969590152021, 27303.590446143324, 27955.58066629002, 28017.85991070052, 28081.438371232663, 28118.859405703046, 2010.2059686423781, 2037.7860324665844, 2043.3461292386442, 2043.4074118505616, 2044.2845004248395, 17780.110994450224, 18353.816461835344, 18529.722054169062, 18595.163217655238, 18613.069346532753, 2482.143660437146, 2496.5631014572377, 2535.2521006303186, 2541.32654846464, 2543.224316583441, 116539.41730291379, 121198.39400803027, 135925.0, 136115.0, 143667.0, 14311.45832318652, 14546.345414456375, 14563.563093107225, 14612.465691102494, 14655.780163297559, 22361.329160125224, 22415.663765043537, 22422.0, 22457.98939047747, 22502.887485562795, 9603.327767056238, 9853.605855765689, 9866.753331166634, 9894.0, 9952.0, 9272.7681807954, 9371.906280937103, 9396.248300135972, 9426.575804088696, 9473.100055494717, 8491.787705307417, 8707.259882909897, 8771.824563508693, 8780.473171609723, 8966.193042626195, 2531.873406329676, 2600.9349766255996, 2613.1899111275566, 2694.178275625953, 2761.654793150856, 937.6624415210518, 956.7034219391871, 966.3525437956586, 968.0899954043177, 974.9756256093655, 18583.0, 18814.153363098692, 18881.716774248398, 19120.426387208405, 19128.521786955436, 1015.2537884654773, 1017.2624846985876, 1027.6454623155, 1035.9533820978074, 1041.234692501011, 10304.536295866705, 10500.31747936397, 10531.15750739939, 10732.839007414896, 10866.0, 470064.0, 470648.0, 470703.0, 495070.0, 498933.0, 113741.0, 114433.4278328603, 115087.42456287665, 115910.42044789722, 116381.0, 991.7173605522391, 1019.4342140112161, 1139.3195037319888, 1164.953401863916, 1189.1854079955085, 20506.487337816674, 20759.377218683465, 20765.480862977944, 20827.0, 20934.581308373443, 58893.70553147378, 58986.11520827277, 60057.39942600693, 60702.39297607144, 60920.69539652274, 72210.0, 73196.63401683171, 74207.62896185485, 75378.0, 76520.23479765131, 18486.630267394845, 19635.509112272306, 19692.21231150738, 19732.0, 19868.006599670247, 20825.271115510885, 21259.68110478375, 21903.12387504482, 22165.22421715297, 22417.551648966604, 17608.38370657021, 17701.734473983157, 17738.201780919633, 17793.644127117645, 17989.730154047436, 16067.678646426772, 16271.511854643906, 16439.589010274838, 16539.421120260733, 16552.255148518103, 17972.460826175236, 17984.100794959937, 18095.36666216676, 18253.634927301646, 18364.632707346045, 18958.43124706261, 18981.62036759285, 19018.52453688669, 19034.904825475784, 19239.711404328667, 17577.209025593624, 17767.555811104827, 17794.199261033027, 17824.732629010836, 17829.0], "value": 11977.380144529112, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.2790413791388, 1378.6002059402774, 1407.4510940733123, 1415.7027024324898, 1425.8859291256701, 14939.402423903044, 15560.61098472536, 15582.065076095429, 15639.530814075568, 15647.217639118055, 15288.617784555363, 15311.234438278098, 15352.61618459539, 15444.382224711026, 15464.84535154648, 2705.4048109415994, 2835.078599455185, 2838.716128387155, 2840.758535524483, 2866.2261189478827, 2704.688960769507, 2776.1255204610484, 2776.583512473125, 2777.083562424395, 2777.8333300001964, 2622.8950841966393, 2730.276476733657, 2731.4673638640475, 2736.261209473441, 2736.480068786924, 2788.9442211155765, 2791.4835755385116, 2793.4552762211274, 2801.7618502427317, 2824.2515733330683, 2584.702759182699, 2788.5538313869683, 2795.0915952315577, 2800.5519116941396, 2804.25687192892, 15236.771448428171, 15332.923335383251, 15393.846061539352, 15411.22943852803, 15421.845781542153, 7847.372210223169, 8155.755327340189, 8218.260356567938, 8233.217844304781, 8256.711015114442, 5541.113421852484, 5575.609707320489, 5667.404922483162, 5679.091345384719, 5713.914291285634, 1901.7812951510616, 1921.798211187819, 1923.6056608395245, 1933.5069557262948, 1957.0410498855601, 26063.609045864327, 26447.0, 26541.203763886922, 26559.73440265592, 26605.20184394452, 6863.553868998499, 6966.164060312795, 7016.122984626922, 7164.355208031198, 7194.532355396883, 17387.130643467775, 17411.73882391765, 17439.21523531444, 17452.65094698099, 17554.210060547306, 7854.175311592315, 8009.519428834288, 8020.518768873886, 8088.988876390451, 8096.230858068474, 7267.563946163247, 7401.259874012663, 7419.517731347553, 7619.504732192389, 7620.047494063242, 4782.33047373368, 4989.077020751172, 5010.2735103409805, 5027.949720502821, 5063.645544811828, 1397.5807257822817, 1422.3386125451714, 1422.7581311177125, 1435.958929775925, 1439.2228196773835, 846.4540371460373, 850.9404341696146, 860.7331727164599, 867.4361664917853, 869.7347309070668, 7271.272872712686, 7297.379722723628, 7908.84182316362, 8461.0, 8576.957115214384, 670.4133882852504, 710.9751158709524, 714.5284112485734, 735.9926400735924, 743.4275607782085, 5190.714510701872, 5333.200019997032, 5486.506214440719, 5606.439356064361, 5614.157876318585, 20356.389308320773, 20750.0, 21013.159473620883, 21455.141794328363, 21785.0, 21225.68161477579, 21274.36176914695, 21391.46521336979, 21422.89288553547, 21556.245531406326, 10435.530401131968, 10882.075023622923, 11026.393548354918, 11073.778524429628, 11113.388763618079, 8051.959740201261, 8121.918780812116, 8184.877226841483, 8212.644913589429, 8290.46112002718, 17612.0, 17658.91170544139, 17802.46592602224, 17982.37061702834, 18305.0, 18768.6246275071, 19130.808691912902, 19525.80474195297, 19596.510087247934, 19680.803191967898, 10730.570777169138, 10898.40058796742, 11063.668089957315, 11183.32900026001, 11198.552057917592, 13420.261885596386, 13715.931420342835, 13725.725485490433, 13745.656358591115, 13760.0, 10942.17933654963, 10945.562177512811, 11031.669049928514, 11095.5561777528, 11279.32324060559, 10642.946785266024, 10643.0, 10677.359358438518, 10727.141828653845, 10757.569697212024, 9697.951510242687, 9759.658411955548, 9829.164521015793, 9896.406215627085, 9898.752531186778, 7017.403520700594, 7048.365647091787, 7074.823129421806, 7099.467539934422, 7112.822179445555, 6994.125734283215, 7084.787456376317, 7142.857142857009, 7173.928260717326, 7216.7113315466795], "value": 6604.560154933646, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.001996007984, 499.9975822167204, 509.38110196111717, 523.2569750953645, 532.6484520216655, 6199.969000154999, 6343.0, 6363.681815909204, 6382.297947225801, 6412.166418365618, 6183.752649893999, 6274.086403646886, 6356.491480681546, 6378.872422551546, 6423.357664233575, 5213.810199716109, 5244.527992480676, 5266.499682530153, 5292.311999440068, 5313.628046036779, 4833.226683730604, 5207.297014902996, 5227.424983251839, 5276.551493123089, 5286.31277933868, 4992.0, 4992.076465853828, 5006.0, 5033.84898453047, 5037.874053148682, 5006.424261209934, 5009.148444764399, 5016.272640467148, 5054.9241761373605, 5065.848024559269, 4518.118966801475, 4527.524609915944, 4536.092781443692, 4544.0, 4564.794584243717, 6290.301618562962, 6313.494920406357, 6322.0, 6337.7781777637565, 6341.0, 5782.0, 5813.128030795415, 5816.069428891357, 5826.883462330729, 5840.766369345221, 6613.338666133348, 6636.0, 6656.70044847983, 6693.0964319816685, 6696.363845434725, 4883.413990321184, 4887.535684110004, 4900.754962251873, 4925.088858561177, 4946.678465899741, 7019.89470157948, 7029.26192749754, 7089.893651595178, 7091.858162836766, 7100.964495177543, 5009.0, 5033.094043072282, 5052.8484145475695, 5070.416902056237, 5079.466656001066, 5119.564836988898, 5136.844210052708, 5160.251763494347, 5160.709822544364, 5194.1429664105, 5798.449147330997, 5818.650880947157, 5842.532597392198, 5848.3274423441, 5858.502027327725, 6693.497987650946, 6711.724772293249, 6722.831929201809, 6732.697028633724, 6734.56225345351, 1665.4087798831483, 1713.5116491800027, 1724.4136993422046, 1753.333733181383, 1777.6711308407987, 1208.293148508115, 1220.408102070495, 1237.2638280223252, 1239.727260002798, 1249.1693024138847, 5639.746211420496, 5661.971690141523, 5724.16999535065, 5738.741756620962, 5739.397363276879, 6406.67966601668, 6725.41952641129, 6725.831854203684, 6729.596224226562, 6767.93232067673, 5637.351704553947, 5675.574331925122, 5719.914201286984, 5722.083102160823, 5739.335592678077, 3537.2041290709385, 3569.44729042862, 3611.819409029538, 3613.837377318027, 3634.47300141478, 6398.808035758934, 6548.8362790930605, 6560.573562718408, 6576.86846263072, 6612.966935165389, 6891.552049116892, 6950.0, 6954.582725036413, 6992.440604751608, 7029.89455158173, 6531.0856480092825, 6601.603903765694, 6624.337566243434, 6673.432758215509, 6698.531102822951, 6799.966000169968, 6810.148731408574, 6886.586804791728, 6899.275181204699, 6926.826829329106, 6869.484788640772, 6880.862382752417, 6909.89635155463, 6914.55055421396, 6922.757703480354, 6534.150560427304, 6658.172824702052, 6688.431483323972, 6698.933010670026, 6725.562838415487, 5014.297998280171, 5045.392544330821, 5055.747212639427, 5071.492850715046, 5089.211172268304, 6854.417374523221, 6860.965695171492, 6921.6193109379465, 6933.5493192942295, 6962.477814163856, 6629.801105966829, 6631.767888124085, 6697.765578204934, 6703.597784132968, 6706.631135287606, 6522.28254891971, 6587.901181482186, 6604.504662150454, 6646.83382915431, 6654.238491026364, 6239.1577137087725, 6319.689608165248, 6444.581102228341, 6464.256610489854, 6515.609063456208, 6588.352911772057, 6687.465002799861, 6688.665566721547, 6714.865702686016, 6737.562058466184, 6371.0, 6429.807105786834, 6485.124508191334, 6517.732728008142, 6542.658754955128], "value": 5132.262399787608, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.6844104563402, 922.1239822168933, 944.4474982135446, 953.1897886796224, 955.9044095590442, 17456.825431745678, 17819.46541603754, 18036.098195090257, 18057.09714514274, 18083.095845207754, 17945.28218871247, 18088.909555452236, 18140.0, 18233.726494102564, 18746.81253187468, 953.0612346838359, 967.0812727908515, 969.060011788564, 969.5346233807777, 970.3789574672215, 975.5805003848342, 978.5694294510429, 981.0630847540617, 981.7054883534911, 982.2534873496123, 979.6228452045978, 1005.7234260578363, 1011.6307547745093, 1014.0873214107289, 1032.7263275232033, 1000.2148313573882, 1003.7289931718432, 1004.2016596805521, 1004.2217281606777, 1004.291974158224, 710.8542748736496, 728.6393235348484, 728.8797348437502, 731.5025782467919, 744.7393412305704, 19759.506012349808, 19937.800621993738, 19967.0, 20037.49906252341, 20067.1973121075, 20876.582468350698, 20994.685079723815, 21220.893895530422, 21255.893720531298, 21430.035648395704, 16627.66744665112, 16787.91606041962, 17005.404810831562, 17066.48800535986, 17353.132343382782, 3724.571674257468, 3771.07608635886, 3771.7925514096714, 3773.3773927301963, 3775.0184951912424, 137094.3145284267, 137444.31277843547, 138407.30796346054, 140526.2973685125, 142498.0, 16321.918390407973, 16478.09370484611, 16493.505194843932, 16678.33286668544, 16685.24916378766, 29798.55302170469, 30233.546496802126, 30285.394292114033, 30321.848390757907, 30412.54381184284, 8400.075991640915, 8487.0, 8561.614727337284, 8567.485950842969, 8572.314214862796, 4192.182524407772, 4302.333138363559, 4308.80610372534, 4314.590113939171, 4321.67587430944, 5326.92009619856, 5339.145736682112, 5376.973115134399, 5385.219143224211, 5402.864928376744, 968.0609808485758, 989.2086330935223, 1001.4942454060653, 1006.3509036671306, 1011.6661501704419, 663.0485253660916, 669.7689297192461, 688.7795905310253, 694.4409750151076, 695.5200911371239, 10819.78360432787, 11656.650300491, 11667.6499705009, 12477.812832807514, 12538.185017973985, 657.6054367379534, 687.1479365586637, 694.035290945586, 706.3466293678327, 712.4478529139855, 5562.527185189304, 5642.463965923313, 5686.545076393879, 5735.11105778605, 5760.654360738369, 123839.0, 124160.0, 126746.0, 127872.0, 130573.0, 110819.0, 112266.0, 113765.0, 114578.0, 115442.0, 95070.0, 99567.50216248873, 101346.0, 102426.48786756018, 103256.0, 10574.312669676447, 10593.364398136137, 10623.203259755395, 10655.786884262427, 10869.891301086887, 42939.141217176104, 43127.784361078, 43865.78067109644, 44170.558294416645, 44326.335104974096, 56877.431225687214, 56929.71535142298, 57582.424175759385, 57796.422035780786, 58059.41940580709, 13884.375203116086, 14065.859341406864, 14212.0, 14334.354954027302, 14344.067635603653, 17530.386436474662, 17742.73385899187, 17779.644407112042, 17911.641767164325, 18014.549636258675, 15595.610109747347, 15694.0, 16014.119223442822, 16031.198440078182, 16088.195590220676, 14591.562253132422, 14624.634384140481, 14738.778918316018, 14772.48296309624, 14808.407663693331, 14046.929765351517, 14174.645633859236, 14191.574252772434, 14254.714905702036, 14259.786103208253, 11404.372759498307, 11458.713532161762, 11587.942060289644, 11924.582639607572, 11942.522299108286, 10731.809582757152, 10862.185336099983, 10880.67357979262, 10967.122630189406, 11044.834327485254], "value": 8803.835543742245, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1431.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 108.0, 107.0, 107.0, 115.0, 108.0, 107.0, 108.0, 109.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 117.0, 117.0, 117.0, 117.0, 118.0, 119.0, 147.0, 116.0, 115.0], "value": 120.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 165.0, 163.0, 164.0, 164.0, 166.0, 169.0, 184.0], "value": 166.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 76.0, 73.0, 74.0, 75.0, 75.0, 74.0, 73.0, 75.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 79.0, 79.0, 79.0, 79.0, 84.0, 82.0, 80.0], "value": 80.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 112.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 150.0, 148.0, 148.0, 149.0, 150.0, 149.0, 148.0, 149.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 94.0, 95.0, 94.0, 98.0, 94.0, 94.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 54.0, 53.0, 55.0, 53.0, 59.0, 54.0, 54.0, 54.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 37.0, 38.0, 38.0, 37.0, 37.0, 38.0, 38.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 81.0, 77.0, 76.0, 80.0, 75.0, 74.0, 79.0, 75.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 122.0, 110.0, 114.0, 118.0, 111.0, 118.0, 113.0, 111.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 180.0, 179.0, 174.0, 167.0, 169.0, 174.0, 175.0, 169.0, 175.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 64.0, 67.0, 65.0, 69.0, 69.0, 65.0, 69.0, 69.0, 65.0], "value": 67.3, "unit": "score"}]}]} 11:44:57 INFO - Return code: 0 11:44:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:44:57 INFO - # TBPL SUCCESS # 11:44:57 INFO - Running post-action listener: _package_coverage_data 11:44:57 INFO - Running post-action listener: _resource_record_post_action 11:44:57 INFO - [mozharness: 2017-09-18 18:44:57.595286Z] Finished run-tests step (success) 11:44:57 INFO - Running post-run listener: _resource_record_post_run 11:44:57 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 338137088; Read time: 12; Write time: 363704 11:44:57 INFO - TinderboxPrint: CPU usage
13.1% 11:44:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:44:57 INFO - TinderboxPrint: I/O write bytes / time
338,137,088 / 363,704 11:44:57 INFO - TinderboxPrint: CPU idle
8,241.9 (86.9%) 11:44:57 INFO - TinderboxPrint: CPU user
1,194.0 (12.6%) 11:44:57 INFO - TinderboxPrint: Swap in / out
0 / 0 11:44:57 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13000704; Read time: 0; Write time: 2368 11:44:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:44:57 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 324333568; Read time: 0; Write time: 361256 11:44:58 INFO - Running post-run listener: _upload_blobber_files 11:44:58 INFO - Blob upload gear active. 11:44:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:58 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 11:44:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:44:58 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 11:44:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 11:44:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:59 INFO - (blobuploader) - INFO - Done attempting. 11:44:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:44:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:45:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:01 INFO - (blobuploader) - INFO - Done attempting. 11:45:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:45:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:45:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:09 INFO - (blobuploader) - INFO - Done attempting. 11:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 11:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 11:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:10 INFO - (blobuploader) - INFO - Done attempting. 11:45:10 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:10 INFO - Return code: 0 11:45:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:10 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8699308d37a1c6e34b2fe9aa08b8f8ea47337f4520aefec96415ac560c67791115717464263406930bcd9db11766d61dbc589d5e382e5a40ca8c4f56ac02ce48", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bb34a47e205610112da79fd5aa2d6166ef987d925fe9fb449e321a2cd971960a9680fe8a3b328032689512b0e1ea20571fcff1bb991c3fdd76562f95e372ead", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/116d3d54ceead23484d0ee8662f00a4e2690c517a1b7c252a961882cdb1b451443201027c15ec12f9aa518c2b20377a407b52213ed16742c15692ac3f6c8c62b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7345e49357195eb7b5490baaf1a0e5e9263dc911078b82e1c1b804ff176ca0afde93bf2fedeb650090678a9f4eed7f4112dd15642d5cba2fc45a75502397acd"} 11:45:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:10 INFO - Contents: 11:45:10 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8699308d37a1c6e34b2fe9aa08b8f8ea47337f4520aefec96415ac560c67791115717464263406930bcd9db11766d61dbc589d5e382e5a40ca8c4f56ac02ce48", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bb34a47e205610112da79fd5aa2d6166ef987d925fe9fb449e321a2cd971960a9680fe8a3b328032689512b0e1ea20571fcff1bb991c3fdd76562f95e372ead", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/116d3d54ceead23484d0ee8662f00a4e2690c517a1b7c252a961882cdb1b451443201027c15ec12f9aa518c2b20377a407b52213ed16742c15692ac3f6c8c62b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7345e49357195eb7b5490baaf1a0e5e9263dc911078b82e1c1b804ff176ca0afde93bf2fedeb650090678a9f4eed7f4112dd15642d5cba2fc45a75502397acd"} 11:45:10 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:10 INFO - Copying logs to upload dir... 11:45:10 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.596729 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-18 11:45:10.676056) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 11:45:10.680709) ========= 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=836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8699308d37a1c6e34b2fe9aa08b8f8ea47337f4520aefec96415ac560c67791115717464263406930bcd9db11766d61dbc589d5e382e5a40ca8c4f56ac02ce48", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bb34a47e205610112da79fd5aa2d6166ef987d925fe9fb449e321a2cd971960a9680fe8a3b328032689512b0e1ea20571fcff1bb991c3fdd76562f95e372ead", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/116d3d54ceead23484d0ee8662f00a4e2690c517a1b7c252a961882cdb1b451443201027c15ec12f9aa518c2b20377a407b52213ed16742c15692ac3f6c8c62b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7345e49357195eb7b5490baaf1a0e5e9263dc911078b82e1c1b804ff176ca0afde93bf2fedeb650090678a9f4eed7f4112dd15642d5cba2fc45a75502397acd"} build_url:https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8699308d37a1c6e34b2fe9aa08b8f8ea47337f4520aefec96415ac560c67791115717464263406930bcd9db11766d61dbc589d5e382e5a40ca8c4f56ac02ce48", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bb34a47e205610112da79fd5aa2d6166ef987d925fe9fb449e321a2cd971960a9680fe8a3b328032689512b0e1ea20571fcff1bb991c3fdd76562f95e372ead", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/116d3d54ceead23484d0ee8662f00a4e2690c517a1b7c252a961882cdb1b451443201027c15ec12f9aa518c2b20377a407b52213ed16742c15692ac3f6c8c62b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7345e49357195eb7b5490baaf1a0e5e9263dc911078b82e1c1b804ff176ca0afde93bf2fedeb650090678a9f4eed7f4112dd15642d5cba2fc45a75502397acd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 11:45:10.711754) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:45:10.712072) ========= 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=836cfdc75598d54cb747368e000001a9-1505757809.298534-773154792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:45:10.791586) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 11:45:10.791895) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 11:45:10.792202) ========= ========= Total master_lag: 0.31 =========