builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-070 starttime: 1505845225.16 results: success (0) revision: ba69e294fc80f23d54fc68050f1b7d63d341aa9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:25.163911) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:25.164343) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:25.164615) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:25.249924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:25.250202) ========= 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=2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-19 11:20: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% 46.6M=0s 2017-09-19 11:20:25 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.223805 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:25.509922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:25.510232) ========= 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=2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017310 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:25.584670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:25.585009) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ba69e294fc80f23d54fc68050f1b7d63d341aa9c --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 ba69e294fc80f23d54fc68050f1b7d63d341aa9c --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=2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-19 11:20:25,659 truncating revision to first 12 chars 2017-09-19 11:20:25,659 Setting DEBUG logging. 2017-09-19 11:20:25,659 attempt 1/10 2017-09-19 11:20:25,659 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ba69e294fc80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-19 11:20:26,070 unpacking tar archive at: mozilla-central-ba69e294fc80/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727731 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.356657) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.356943) ========= script_repo_revision: ba69e294fc80f23d54fc68050f1b7d63d341aa9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.357290) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.357563) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.416313) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-19 11:20:26.416599) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:20:26 INFO - MultiFileLogger online at 20170919 11:20:26 in /builds/slave/test 11:20:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:20:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:26 INFO - {'append_to_log': False, 11:20:26 INFO - 'base_work_dir': '/builds/slave/test', 11:20:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:20:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:26 INFO - 'branch': 'Firefox-Non-PGO', 11:20:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:26 INFO - 'code_coverage': False, 11:20:26 INFO - 'config_files': ('talos/linux_config.py',), 11:20:26 INFO - 'default_actions': ('clobber', 11:20:26 INFO - 'read-buildbot-config', 11:20:26 INFO - 'download-and-extract', 11:20:26 INFO - 'populate-webroot', 11:20:26 INFO - 'create-virtualenv', 11:20:26 INFO - 'install', 11:20:26 INFO - 'setup-mitmproxy', 11:20:26 INFO - 'run-tests'), 11:20:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:26 INFO - 'disable_ccov_upload': False, 11:20:26 INFO - 'disable_stylo': False, 11:20:26 INFO - 'download_minidump_stackwalk': True, 11:20:26 INFO - 'download_symbols': 'ondemand', 11:20:26 INFO - 'enable_stylo': False, 11:20:26 INFO - 'enable_webrender': False, 11:20:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:20:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:26 INFO - 'gecko_profile': False, 11:20:26 INFO - 'gecko_profile_interval': 0, 11:20:26 INFO - 'installer_path': 'installer.exe', 11:20:26 INFO - 'log_level': 'info', 11:20:26 INFO - 'log_name': 'talos', 11:20:26 INFO - 'log_to_console': True, 11:20:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:20:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:20:26 INFO - 'opt_config_files': (), 11:20:26 INFO - 'pip_index': False, 11:20:26 INFO - 'suite': 'dromaeojs-e10s', 11:20:26 INFO - 'system_bits': '32', 11:20:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:26 INFO - 'title': 'talos-linux64-ix-070', 11:20:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:26 INFO - 'use_talos_json': True, 11:20:26 INFO - 'verify': 'False', 11:20:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:26 INFO - 'work_dir': 'build'} 11:20:26 INFO - [mozharness: 2017-09-19 18:20:26.614535Z] Running clobber step. 11:20:26 INFO - Running pre-action listener: _resource_record_pre_action 11:20:26 INFO - Running main action method: clobber 11:20:26 INFO - rmtree: /builds/slave/test/build 11:20:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:27 INFO - Running post-action listener: _resource_record_post_action 11:20:27 INFO - [mozharness: 2017-09-19 18:20:27.608743Z] Finished clobber step (success) 11:20:27 INFO - [mozharness: 2017-09-19 18:20:27.608840Z] Running read-buildbot-config step. 11:20:27 INFO - Running pre-action listener: _resource_record_pre_action 11:20:27 INFO - Running main action method: read_buildbot_config 11:20:27 INFO - Using buildbot properties: 11:20:27 INFO - { 11:20:27 INFO - "project": "", 11:20:27 INFO - "product": "firefox", 11:20:27 INFO - "who": "ffxbld@noreply.mozilla.org", 11:20:27 INFO - "installer_path": "public/build/target.tar.bz2", 11:20:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:20:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:20:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:20:27 INFO - "stage_platform": "linux64", 11:20:27 INFO - "basedir": "/builds/slave/test", 11:20:27 INFO - "buildnumber": 847, 11:20:27 INFO - "platform": "ubuntu64_hw", 11:20:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:20:27 INFO - "slavebuilddir": "test", 11:20:27 INFO - "taskId": "FvgDKOa0QJmRlxvcqR98vw", 11:20:27 INFO - "branch": "mozilla-central", 11:20:27 INFO - "script_repo_revision": "production", 11:20:27 INFO - "revision": "ba69e294fc80f23d54fc68050f1b7d63d341aa9c", 11:20:27 INFO - "slavename": "talos-linux64-ix-070", 11:20:27 INFO - "repo_path": "mozilla-central" 11:20:27 INFO - } 11:20:27 INFO - Finding installer, test and symbols from parent task. 11:20:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FvgDKOa0QJmRlxvcqR98vw'}, attempt #1 11:20:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FvgDKOa0QJmRlxvcqR98vw'}, attempt #1 11:20:28 INFO - Task dependencies: L7l39DLCQeO5S_9KbepNFA 11:20:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA'}, attempt #1 11:20:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 11:20:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.test_packages.json 11:20:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.crashreporter-symbols.zip 11:20:28 INFO - Running post-action listener: _resource_record_post_action 11:20:28 INFO - [mozharness: 2017-09-19 18:20:28.943843Z] Finished read-buildbot-config step (success) 11:20:28 INFO - [mozharness: 2017-09-19 18:20:28.944059Z] Running download-and-extract step. 11:20:28 INFO - Running pre-action listener: _resource_record_pre_action 11:20:28 INFO - Running main action method: download_and_extract 11:20:28 INFO - mkdir: /builds/slave/test/build/tests 11:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:28 INFO - trying https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.test_packages.json 11:20:28 INFO - Downloading https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:20:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:20:29 INFO - Downloaded 989 bytes. 11:20:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:20:29 INFO - Using the following test package requirements: 11:20:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:20:29 INFO - u'common': [u'target.common.tests.zip'], 11:20:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:20:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:20:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:20:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:20:29 INFO - u'mozbase': [u'target.common.tests.zip'], 11:20:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:20:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:20:29 INFO - u'web-platform': [u'target.common.tests.zip', 11:20:29 INFO - u'target.web-platform.tests.tar.gz'], 11:20:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:20:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:20:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.common.tests.zip 11:20:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:20:29 INFO - Fetch https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.common.tests.zip into memory 11:20:30 INFO - Content-Length response header: 54731465 11:20:30 INFO - Bytes received: 54731465 11:20:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.talos.tests.zip 11:20:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:20:41 INFO - Fetch https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.talos.tests.zip into memory 11:20:42 INFO - Content-Length response header: 14508787 11:20:42 INFO - Bytes received: 14508787 11:20: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:20:42 INFO - trying https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 11:20:42 INFO - Downloading https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:20:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:20:43 INFO - Downloaded 61613416 bytes. 11:20:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 11:20:43 INFO - mkdir: /builds/slave/test/properties 11:20:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:43 INFO - Contents: 11:20:43 INFO - build_url:https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 11:20:43 INFO - Running post-action listener: _resource_record_post_action 11:20:43 INFO - Running post-action listener: find_tests_for_verification 11:20:43 INFO - Running post-action listener: set_extra_try_arguments 11:20:43 INFO - [mozharness: 2017-09-19 18:20:43.518195Z] Finished download-and-extract step (success) 11:20:43 INFO - [mozharness: 2017-09-19 18:20:43.518293Z] Running populate-webroot step. 11:20:43 INFO - Running pre-action listener: _resource_record_pre_action 11:20:43 INFO - Running main action method: populate_webroot 11:20:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:20:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:43 INFO - 'tests': ['tresize', 11:20:43 INFO - 'tcanvasmark']}, 11:20:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:20:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:43 INFO - 'tests': ['dromaeo_css', 11:20:43 INFO - 'kraken']}, 11:20:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:20:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:43 INFO - 'talos_options': ['--disable-stylo'], 11:20:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:20:43 INFO - 'tests': ['damp', 'tps']}, 11:20:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:43 INFO - 'talos_options': ['--disable-stylo'], 11:20:43 INFO - 'tests': ['damp', 'tps']}, 11:20:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:43 INFO - 'tests': ['dromaeo_dom']}, 11:20:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:20:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:43 INFO - 'tests': ['basic_compositor_video', 11:20:43 INFO - 'glvideo']}, 11:20:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:20:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:20:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:43 INFO - 'talos_options': ['--disable-stylo'], 11:20:43 INFO - 'tests': ['ts_paint_webext', 11:20:43 INFO - 'tp5o_webext']}, 11:20:43 INFO - 'other-e10s': {'tests': ['a11yr', 11:20:43 INFO - 'ts_paint', 11:20:43 INFO - 'tpaint', 11:20:43 INFO - 'sessionrestore', 11:20:43 INFO - 'sessionrestore_many_windows', 11:20:43 INFO - 'sessionrestore_no_auto_restore', 11:20:43 INFO - 'tabpaint']}, 11:20:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:43 INFO - 'tests': ['a11yr', 11:20:43 INFO - 'ts_paint', 11:20:43 INFO - 'tpaint', 11:20:43 INFO - 'sessionrestore', 11:20:43 INFO - 'sessionrestore_many_windows', 11:20:43 INFO - 'sessionrestore_no_auto_restore', 11:20:43 INFO - 'tabpaint']}, 11:20:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:20:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:20:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:43 INFO - 'tests': ['perf_reftest_singletons']}, 11:20:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:43 INFO - 'tests': ['bloom_basic']}, 11:20:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:20:43 INFO - 'tsvgr_opacity', 11:20:43 INFO - 'tart', 11:20:43 INFO - 'tscrollx', 11:20:43 INFO - 'tsvg_static']}, 11:20:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:43 INFO - 'tests': ['tsvgx', 11:20:43 INFO - 'tsvgr_opacity', 11:20:43 INFO - 'tart', 11:20:43 INFO - 'tscrollx', 11:20:43 INFO - 'tsvg_static']}, 11:20:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:20:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:43 INFO - 'talos_options': ['--disable-stylo'], 11:20:43 INFO - 'tests': ['tp5o']}, 11:20:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:43 INFO - 'talos_options': ['--mitmproxy', 11:20:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:43 INFO - '--firstNonBlankPaint'], 11:20:43 INFO - 'tests': ['tp6_google', 11:20:43 INFO - 'tp6_youtube', 11:20:43 INFO - 'tp6_amazon', 11:20:43 INFO - 'tp6_facebook']}, 11:20:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:43 INFO - 'talos_options': ['--disable-stylo', 11:20:43 INFO - '--mitmproxy', 11:20:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:43 INFO - '--firstNonBlankPaint'], 11:20:43 INFO - 'tests': ['tp6_google', 11:20:43 INFO - 'tp6_youtube', 11:20:43 INFO - 'tp6_amazon', 11:20:43 INFO - 'tp6_facebook']}, 11:20:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:43 INFO - 'talos_options': ['--stylo-threads=1', 11:20:43 INFO - '--mitmproxy', 11:20:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:43 INFO - '--firstNonBlankPaint'], 11:20:43 INFO - 'tests': ['tp6_google', 11:20:43 INFO - 'tp6_youtube', 11:20:43 INFO - 'tp6_amazon', 11:20:43 INFO - 'tp6_facebook']}, 11:20:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:20:43 INFO - 'talos_options': ['--xperf_path', 11:20:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:43 INFO - 'tests': ['tp5n']}, 11:20:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:43 INFO - 'talos_options': ['--disable-stylo', 11:20:43 INFO - '--xperf_path', 11:20:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:43 INFO - 'tests': ['tp5n']}}} 11:20:43 INFO - Running post-action listener: _resource_record_post_action 11:20:43 INFO - [mozharness: 2017-09-19 18:20:43.533186Z] Finished populate-webroot step (success) 11:20:43 INFO - [mozharness: 2017-09-19 18:20:43.533275Z] Running create-virtualenv step. 11:20:43 INFO - Running pre-action listener: _resource_record_pre_action 11:20:43 INFO - Running main action method: create_virtualenv 11:20:43 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:20:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:20:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:20:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:44 INFO - Installing pip...............done. 11:20:44 INFO - Return code: 0 11:20:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:20:44 INFO - Reading from file tmpfile_stdout 11:20:44 INFO - Output received: 11:20:44 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:20:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e090>, '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 0x168ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1688f90>, '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': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', '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:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:20:44 INFO - Using env: {'DISPLAY': ':0', 11:20:44 INFO - 'HOME': '/home/cltbld', 11:20:44 INFO - 'LANG': 'en_US.UTF-8', 11:20:44 INFO - 'LANGUAGE': 'en_US:en', 11:20:44 INFO - 'LOGNAME': 'cltbld', 11:20:44 INFO - 'MAIL': '/var/mail/cltbld', 11:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:44 INFO - 'MOZ_NO_REMOTE': '1', 11:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:44 INFO - 'NO_EM_RESTART': '1', 11:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:44 INFO - 'PWD': '/builds/slave/test', 11:20:44 INFO - 'SHELL': '/bin/bash', 11:20:44 INFO - 'SHLVL': '1', 11:20:44 INFO - 'TERM': 'linux', 11:20:44 INFO - 'TMOUT': '86400', 11:20:44 INFO - 'USER': 'cltbld', 11:20:44 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', 11:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:44 INFO - '_': '/tools/buildbot/bin/python'} 11:20:45 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:20:45 INFO - Downloading/unpacking pip>=1.5 11:20:45 INFO - Running setup.py egg_info for package pip 11:20:45 INFO - warning: no files found matching 'pip/cacert.pem' 11:20:45 INFO - warning: no files found matching '*.html' under directory 'docs' 11:20:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:20:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:20:45 INFO - Installing collected packages: pip 11:20:45 INFO - Found existing installation: pip 1.1 11:20:45 INFO - Uninstalling pip: 11:20:45 INFO - Successfully uninstalled pip 11:20:45 INFO - Running setup.py install for pip 11:20:45 INFO - warning: no files found matching 'pip/cacert.pem' 11:20:45 INFO - warning: no files found matching '*.html' under directory 'docs' 11:20:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:20:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:20:45 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:20:45 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:20:45 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:20:45 INFO - Successfully installed pip 11:20:45 INFO - Cleaning up... 11:20:45 INFO - Return code: 0 11:20:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:20: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:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20: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:20:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20: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', '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 0x131e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e090>, '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 0x168ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1688f90>, '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': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', '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:20: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:20: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 psutil>=3.1.1 11:20:45 INFO - Using env: {'DISPLAY': ':0', 11:20:45 INFO - 'HOME': '/home/cltbld', 11:20:45 INFO - 'LANG': 'en_US.UTF-8', 11:20:45 INFO - 'LANGUAGE': 'en_US:en', 11:20:45 INFO - 'LOGNAME': 'cltbld', 11:20:45 INFO - 'MAIL': '/var/mail/cltbld', 11:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:45 INFO - 'MOZ_NO_REMOTE': '1', 11:20:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:45 INFO - 'NO_EM_RESTART': '1', 11:20:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:45 INFO - 'PWD': '/builds/slave/test', 11:20:45 INFO - 'SHELL': '/bin/bash', 11:20:45 INFO - 'SHLVL': '1', 11:20:45 INFO - 'TERM': 'linux', 11:20:45 INFO - 'TMOUT': '86400', 11:20:45 INFO - 'USER': 'cltbld', 11:20:45 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', 11:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:45 INFO - '_': '/tools/buildbot/bin/python'} 11:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:46 INFO - Downloading/unpacking psutil>=3.1.1 11:20: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:20: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:20: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:20: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:20:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:47 INFO - Installing collected packages: psutil 11:20:47 INFO - Running setup.py install for psutil 11:20:47 INFO - building 'psutil._psutil_linux' extension 11:20:47 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:20:47 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:20:47 INFO - building 'psutil._psutil_posix' extension 11:20:47 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:20:47 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:20:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:47 INFO - Successfully installed psutil 11:20:47 INFO - Cleaning up... 11:20:47 INFO - Return code: 0 11:20:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:20:47 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:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:47 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:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:47 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 0x131e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e090>, '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 0x168ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1688f90>, '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': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', '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:20:47 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:20:47 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:20:47 INFO - Using env: {'DISPLAY': ':0', 11:20:47 INFO - 'HOME': '/home/cltbld', 11:20:47 INFO - 'LANG': 'en_US.UTF-8', 11:20:47 INFO - 'LANGUAGE': 'en_US:en', 11:20:47 INFO - 'LOGNAME': 'cltbld', 11:20:47 INFO - 'MAIL': '/var/mail/cltbld', 11:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:47 INFO - 'MOZ_NO_REMOTE': '1', 11:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:47 INFO - 'NO_EM_RESTART': '1', 11:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:47 INFO - 'PWD': '/builds/slave/test', 11:20:47 INFO - 'SHELL': '/bin/bash', 11:20:47 INFO - 'SHLVL': '1', 11:20:47 INFO - 'TERM': 'linux', 11:20:47 INFO - 'TMOUT': '86400', 11:20:47 INFO - 'USER': 'cltbld', 11:20:47 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', 11:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:47 INFO - '_': '/tools/buildbot/bin/python'} 11:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:20:47 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:20:47 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:20:47 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:20:47 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:20:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:20: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:20:49 INFO - Installing collected packages: mozsystemmonitor 11:20:49 INFO - Running setup.py install for mozsystemmonitor 11:20:49 INFO - Successfully installed mozsystemmonitor 11:20:49 INFO - Cleaning up... 11:20:50 INFO - Return code: 0 11:20:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e090>, '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 0x168ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1688f90>, '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': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', '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:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:20:50 INFO - Using env: {'DISPLAY': ':0', 11:20:50 INFO - 'HOME': '/home/cltbld', 11:20:50 INFO - 'LANG': 'en_US.UTF-8', 11:20:50 INFO - 'LANGUAGE': 'en_US:en', 11:20:50 INFO - 'LOGNAME': 'cltbld', 11:20:50 INFO - 'MAIL': '/var/mail/cltbld', 11:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:50 INFO - 'MOZ_NO_REMOTE': '1', 11:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:50 INFO - 'NO_EM_RESTART': '1', 11:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:50 INFO - 'PWD': '/builds/slave/test', 11:20:50 INFO - 'SHELL': '/bin/bash', 11:20:50 INFO - 'SHLVL': '1', 11:20:50 INFO - 'TERM': 'linux', 11:20:50 INFO - 'TMOUT': '86400', 11:20:50 INFO - 'USER': 'cltbld', 11:20:50 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', 11:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:50 INFO - '_': '/tools/buildbot/bin/python'} 11:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:50 INFO - Downloading/unpacking jsonschema==2.5.1 11:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:20:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:51 INFO - Downloading functools32-3.2.3-2.tar.gz 11:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:20:51 INFO - warning: no files found matching '*.txt' 11:20:51 INFO - no previously-included directories found matching 'build' 11:20:51 INFO - no previously-included directories found matching 'dist' 11:20:51 INFO - no previously-included directories found matching '.git*' 11:20:51 INFO - Installing collected packages: jsonschema, functools32 11:20:52 INFO - Running setup.py install for functools32 11:20:52 INFO - warning: no files found matching '*.txt' 11:20:52 INFO - no previously-included directories found matching 'build' 11:20:52 INFO - no previously-included directories found matching 'dist' 11:20:52 INFO - no previously-included directories found matching '.git*' 11:20:53 INFO - Successfully installed jsonschema functools32 11:20:53 INFO - Cleaning up... 11:20:53 INFO - Return code: 0 11:20:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e090>, '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 0x168ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1688f90>, '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': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', '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:20:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:20:53 INFO - Using env: {'DISPLAY': ':0', 11:20:53 INFO - 'HOME': '/home/cltbld', 11:20:53 INFO - 'LANG': 'en_US.UTF-8', 11:20:53 INFO - 'LANGUAGE': 'en_US:en', 11:20:53 INFO - 'LOGNAME': 'cltbld', 11:20:53 INFO - 'MAIL': '/var/mail/cltbld', 11:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:53 INFO - 'MOZ_NO_REMOTE': '1', 11:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:53 INFO - 'NO_EM_RESTART': '1', 11:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:53 INFO - 'PWD': '/builds/slave/test', 11:20:53 INFO - 'SHELL': '/bin/bash', 11:20:53 INFO - 'SHLVL': '1', 11:20:53 INFO - 'TERM': 'linux', 11:20:53 INFO - 'TMOUT': '86400', 11:20:53 INFO - 'USER': 'cltbld', 11:20:53 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', 11:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:53 INFO - '_': '/tools/buildbot/bin/python'} 11:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:20:53 INFO - Cleaning up... 11:20:53 INFO - Return code: 0 11:20:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x131e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e090>, '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 0x168ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1688f90>, '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': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', '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:20:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:20:53 INFO - Using env: {'DISPLAY': ':0', 11:20:53 INFO - 'HOME': '/home/cltbld', 11:20:53 INFO - 'LANG': 'en_US.UTF-8', 11:20:53 INFO - 'LANGUAGE': 'en_US:en', 11:20:53 INFO - 'LOGNAME': 'cltbld', 11:20:53 INFO - 'MAIL': '/var/mail/cltbld', 11:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:53 INFO - 'MOZ_NO_REMOTE': '1', 11:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:53 INFO - 'NO_EM_RESTART': '1', 11:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:53 INFO - 'PWD': '/builds/slave/test', 11:20:53 INFO - 'SHELL': '/bin/bash', 11:20:53 INFO - 'SHLVL': '1', 11:20:53 INFO - 'TERM': 'linux', 11:20:53 INFO - 'TMOUT': '86400', 11:20:53 INFO - 'USER': 'cltbld', 11:20:53 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', 11:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:53 INFO - '_': '/tools/buildbot/bin/python'} 11:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:53 INFO - Downloading/unpacking blobuploader==1.2.4 11:20: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:20: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:20: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:20: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:20:54 INFO - Downloading blobuploader-1.2.4.tar.gz 11:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:20:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:20:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:55 INFO - Downloading docopt-0.6.1.tar.gz 11:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:20:55 INFO - Installing collected packages: blobuploader, requests, docopt 11:20:55 INFO - Running setup.py install for blobuploader 11:20:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:20:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:20:55 INFO - Running setup.py install for requests 11:20:55 INFO - Running setup.py install for docopt 11:20:55 INFO - Successfully installed blobuploader requests docopt 11:20:55 INFO - Cleaning up... 11:20:55 INFO - Return code: 0 11:20:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20: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:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20: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:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:55 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 0x131e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e090>, '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 0x168ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1688f90>, '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': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', '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:20:55 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:20:55 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:20:55 INFO - Using env: {'DISPLAY': ':0', 11:20:55 INFO - 'HOME': '/home/cltbld', 11:20:55 INFO - 'LANG': 'en_US.UTF-8', 11:20:55 INFO - 'LANGUAGE': 'en_US:en', 11:20:55 INFO - 'LOGNAME': 'cltbld', 11:20:55 INFO - 'MAIL': '/var/mail/cltbld', 11:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:55 INFO - 'MOZ_NO_REMOTE': '1', 11:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:55 INFO - 'NO_EM_RESTART': '1', 11:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:55 INFO - 'PWD': '/builds/slave/test', 11:20:55 INFO - 'SHELL': '/bin/bash', 11:20:55 INFO - 'SHLVL': '1', 11:20:55 INFO - 'TERM': 'linux', 11:20:55 INFO - 'TMOUT': '86400', 11:20:55 INFO - 'USER': 'cltbld', 11:20:55 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', 11:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:55 INFO - '_': '/tools/buildbot/bin/python'} 11:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:56 INFO - Running setup.py (path:/tmp/pip-8_Ge9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:56 INFO - Running setup.py (path:/tmp/pip-ZTYnQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:56 INFO - Running setup.py (path:/tmp/pip-lAoulL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:56 INFO - Running setup.py (path:/tmp/pip-6k6P6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:56 INFO - Running setup.py (path:/tmp/pip-Ug1BBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:56 INFO - Running setup.py (path:/tmp/pip-LfrPLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:56 INFO - Running setup.py (path:/tmp/pip-NMtWiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:56 INFO - Running setup.py (path:/tmp/pip-rjilIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:56 INFO - Running setup.py (path:/tmp/pip-tkzYSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:56 INFO - Running setup.py (path:/tmp/pip-BqswLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:56 INFO - Running setup.py (path:/tmp/pip-gYY4zX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:56 INFO - Running setup.py (path:/tmp/pip-oPeIIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:56 INFO - Running setup.py (path:/tmp/pip-ALTE4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:56 INFO - Running setup.py (path:/tmp/pip-ejXYGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:57 INFO - Running setup.py (path:/tmp/pip-nw3r4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:57 INFO - Running setup.py (path:/tmp/pip-GkabdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:57 INFO - Running setup.py (path:/tmp/pip-iU79Ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:20:57 INFO - Running setup.py install for manifestparser 11:20:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:20:57 INFO - Running setup.py install for mozcrash 11:20:57 INFO - Running setup.py install for mozdebug 11:20:57 INFO - Running setup.py install for mozdevice 11:20:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:20:57 INFO - Running setup.py install for mozfile 11:20:57 INFO - Running setup.py install for mozhttpd 11:20:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:20:57 INFO - Running setup.py install for mozinfo 11:20:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:20:57 INFO - Running setup.py install for mozInstall 11:20:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:20:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:20:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:20:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:20:58 INFO - Running setup.py install for mozleak 11:20:58 INFO - Running setup.py install for mozlog 11:20:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:20:58 INFO - Running setup.py install for moznetwork 11:20:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:20:58 INFO - Running setup.py install for mozprocess 11:20:58 INFO - Running setup.py install for mozprofile 11:20:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:20:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:20:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:20:58 INFO - Running setup.py install for mozrunner 11:20:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:20:58 INFO - Running setup.py install for mozscreenshot 11:20:58 INFO - Running setup.py install for moztest 11:20:58 INFO - Running setup.py install for mozversion 11:20:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:20:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:20:58 INFO - Cleaning up... 11:20:58 INFO - Return code: 0 11:20:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20: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:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20: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:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e090>, '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 0x168ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1688f90>, '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': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', '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:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:20:59 INFO - Using env: {'DISPLAY': ':0', 11:20:59 INFO - 'HOME': '/home/cltbld', 11:20:59 INFO - 'LANG': 'en_US.UTF-8', 11:20:59 INFO - 'LANGUAGE': 'en_US:en', 11:20:59 INFO - 'LOGNAME': 'cltbld', 11:20:59 INFO - 'MAIL': '/var/mail/cltbld', 11:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:59 INFO - 'MOZ_NO_REMOTE': '1', 11:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:59 INFO - 'NO_EM_RESTART': '1', 11:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:59 INFO - 'PWD': '/builds/slave/test', 11:20:59 INFO - 'SHELL': '/bin/bash', 11:20:59 INFO - 'SHLVL': '1', 11:20:59 INFO - 'TERM': 'linux', 11:20:59 INFO - 'TMOUT': '86400', 11:20:59 INFO - 'USER': 'cltbld', 11:20:59 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', 11:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:59 INFO - '_': '/tools/buildbot/bin/python'} 11:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:59 INFO - Running setup.py (path:/tmp/pip-26pUez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:59 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:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:59 INFO - Running setup.py (path:/tmp/pip-qlsaQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:59 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:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:59 INFO - Running setup.py (path:/tmp/pip-hfrsI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:59 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:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:59 INFO - Running setup.py (path:/tmp/pip-zNNc7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:59 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:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:59 INFO - Running setup.py (path:/tmp/pip-0Rx47S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:59 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:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:59 INFO - Running setup.py (path:/tmp/pip-mWluVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:59 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:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:59 INFO - Running setup.py (path:/tmp/pip-MZDXy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:59 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:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:59 INFO - Running setup.py (path:/tmp/pip-BTJueg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:59 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:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:59 INFO - Running setup.py (path:/tmp/pip-kQLoU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:59 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:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:59 INFO - Running setup.py (path:/tmp/pip-OZoN_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:59 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:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:59 INFO - Running setup.py (path:/tmp/pip-duoCR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:59 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:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:00 INFO - Running setup.py (path:/tmp/pip-6H_CYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:00 INFO - Running setup.py (path:/tmp/pip-fYWx2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:00 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:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:00 INFO - Running setup.py (path:/tmp/pip-YzwOzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:00 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:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:00 INFO - Running setup.py (path:/tmp/pip-RBxkKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:00 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:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:00 INFO - Running setup.py (path:/tmp/pip-3OpQ20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:00 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:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:00 INFO - Running setup.py (path:/tmp/pip-pzFoPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:00 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:21:00 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:21:00 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:21:00 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:21:00 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:21:00 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:21:00 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:21:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:01 INFO - Downloading blessings-1.6.tar.gz 11:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:21:01 INFO - Installing collected packages: blessings 11:21:01 INFO - Running setup.py install for blessings 11:21:01 INFO - Successfully installed blessings 11:21:01 INFO - Cleaning up... 11:21:01 INFO - Return code: 0 11:21:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:21:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:01 INFO - Reading from file tmpfile_stdout 11:21:01 INFO - Current package versions: 11:21:01 INFO - argparse == 1.2.1 11:21:01 INFO - blessings == 1.6 11:21:01 INFO - blobuploader == 1.2.4 11:21:01 INFO - docopt == 0.6.1 11:21:01 INFO - functools32 == 3.2.3-2 11:21:01 INFO - jsonschema == 2.5.1 11:21:01 INFO - manifestparser == 1.1 11:21:01 INFO - mozInstall == 1.13 11:21:01 INFO - mozcrash == 1.0 11:21:01 INFO - mozdebug == 0.1 11:21:01 INFO - mozdevice == 0.51 11:21:01 INFO - mozfile == 1.2 11:21:01 INFO - mozhttpd == 0.7 11:21:01 INFO - mozinfo == 0.10 11:21:01 INFO - mozleak == 0.1 11:21:01 INFO - mozlog == 3.5 11:21:01 INFO - moznetwork == 0.27 11:21:01 INFO - mozprocess == 0.25 11:21:01 INFO - mozprofile == 0.28 11:21:01 INFO - mozrunner == 6.13 11:21:01 INFO - mozscreenshot == 0.1 11:21:01 INFO - mozsystemmonitor == 0.3 11:21:01 INFO - moztest == 0.8 11:21:01 INFO - mozversion == 1.4 11:21:01 INFO - psutil == 3.1.1 11:21:01 INFO - requests == 1.2.3 11:21:01 INFO - wsgiref == 0.1.2 11:21:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21: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:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:01 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 0x131e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e090>, '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 0x168ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1688f90>, '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': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', '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:21:01 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:21:01 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:21:02 INFO - Using env: {'DISPLAY': ':0', 11:21:02 INFO - 'HOME': '/home/cltbld', 11:21:02 INFO - 'LANG': 'en_US.UTF-8', 11:21:02 INFO - 'LANGUAGE': 'en_US:en', 11:21:02 INFO - 'LOGNAME': 'cltbld', 11:21:02 INFO - 'MAIL': '/var/mail/cltbld', 11:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:02 INFO - 'MOZ_NO_REMOTE': '1', 11:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:02 INFO - 'NO_EM_RESTART': '1', 11:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:02 INFO - 'PWD': '/builds/slave/test', 11:21:02 INFO - 'SHELL': '/bin/bash', 11:21:02 INFO - 'SHLVL': '1', 11:21:02 INFO - 'TERM': 'linux', 11:21:02 INFO - 'TMOUT': '86400', 11:21:02 INFO - 'USER': 'cltbld', 11:21:02 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', 11:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:02 INFO - '_': '/tools/buildbot/bin/python'} 11:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:02 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:21:02 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:21:02 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:21:02 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:21:02 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:21:02 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:21:02 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:21:02 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:21:02 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:21:02 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:21: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:21: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:21: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:21: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:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:21:03 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:21:03 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:21:03 INFO - Installing collected packages: simplejson 11:21:03 INFO - Running setup.py install for simplejson 11:21:03 INFO - building 'simplejson._speedups' extension 11:21:03 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:21:04 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:21:04 INFO - Successfully installed simplejson 11:21:04 INFO - Cleaning up... 11:21:04 INFO - Return code: 0 11:21:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:21: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:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:04 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 0x131e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e090>, '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 0x168ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1688f90>, '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': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', '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:21:04 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:21:04 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:21:04 INFO - Using env: {'DISPLAY': ':0', 11:21:04 INFO - 'HOME': '/home/cltbld', 11:21:04 INFO - 'LANG': 'en_US.UTF-8', 11:21:04 INFO - 'LANGUAGE': 'en_US:en', 11:21:04 INFO - 'LOGNAME': 'cltbld', 11:21:04 INFO - 'MAIL': '/var/mail/cltbld', 11:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:04 INFO - 'MOZ_NO_REMOTE': '1', 11:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:04 INFO - 'NO_EM_RESTART': '1', 11:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:04 INFO - 'PWD': '/builds/slave/test', 11:21:04 INFO - 'SHELL': '/bin/bash', 11:21:04 INFO - 'SHLVL': '1', 11:21:04 INFO - 'TERM': 'linux', 11:21:04 INFO - 'TMOUT': '86400', 11:21:04 INFO - 'USER': 'cltbld', 11:21:04 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', 11:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:04 INFO - '_': '/tools/buildbot/bin/python'} 11:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:21:04 INFO - Cleaning up... 11:21:04 INFO - Return code: 0 11:21:04 INFO - Running post-action listener: _resource_record_post_action 11:21:04 INFO - Running post-action listener: _start_resource_monitoring 11:21:04 INFO - Starting resource monitoring. 11:21:04 INFO - [mozharness: 2017-09-19 18:21:04.711661Z] Finished create-virtualenv step (success) 11:21:04 INFO - [mozharness: 2017-09-19 18:21:04.712172Z] Running install step. 11:21:04 INFO - Running pre-action listener: _resource_record_pre_action 11:21:04 INFO - Running main action method: install 11:21:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:04 INFO - Reading from file tmpfile_stdout 11:21:04 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:21:05 INFO - Reading from file tmpfile_stdout 11:21:05 INFO - Output received: 11:21:05 INFO - Usage: mozinstall [options] installer 11:21:05 INFO - Options: 11:21:05 INFO - -h, --help show this help message and exit 11:21:05 INFO - -d DEST, --destination=DEST 11:21:05 INFO - Directory to install application into. [default: 11:21:05 INFO - "/builds/slave/test"] 11:21:05 INFO - --app=APP Application being installed. [default: firefox] 11:21:05 INFO - mkdir: /builds/slave/test/build/application 11:21:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:21:22 INFO - Reading from file tmpfile_stdout 11:21:22 INFO - Output received: 11:21:22 INFO - /builds/slave/test/build/application/firefox/firefox 11:21:22 INFO - Running post-action listener: _resource_record_post_action 11:21:22 INFO - [mozharness: 2017-09-19 18:21:22.835945Z] Finished install step (success) 11:21:22 INFO - [mozharness: 2017-09-19 18:21:22.836198Z] Running setup-mitmproxy step. 11:21:22 INFO - Running pre-action listener: _resource_record_pre_action 11:21:22 INFO - Running main action method: setup_mitmproxy 11:21:22 INFO - Skipping: mitmproxy is not required 11:21:22 INFO - Running post-action listener: _resource_record_post_action 11:21:22 INFO - [mozharness: 2017-09-19 18:21:22.837340Z] Finished setup-mitmproxy step (success) 11:21:22 INFO - [mozharness: 2017-09-19 18:21:22.837631Z] Running run-tests step. 11:21:22 INFO - Running pre-action listener: _resource_record_pre_action 11:21:22 INFO - Running pre-action listener: _set_gcov_prefix 11:21:22 INFO - Running main action method: run_tests 11:21:22 WARNING - Try message not found. 11:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:22 INFO - Python 2.7.3 11:21:22 INFO - Return code: 0 11:21:22 INFO - grabbing minidump binary from tooltool 11:21:22 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:21:22 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 0x168e090>, '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 0x168ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1688f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:22 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:21:22 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:21:22 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:21:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:22 INFO - Return code: 0 11:21:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:21:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:22 INFO - ENV: RUST_BACKTRACE is now full 11:21:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:21:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-070 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:21:22 INFO - Using env: {'DISPLAY': ':0', 11:21:22 INFO - 'HOME': '/home/cltbld', 11:21:22 INFO - 'LANG': 'en_US.UTF-8', 11:21:22 INFO - 'LANGUAGE': 'en_US:en', 11:21:22 INFO - 'LOGNAME': 'cltbld', 11:21:22 INFO - 'MAIL': '/var/mail/cltbld', 11:21:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:22 INFO - 'MOZ_NO_REMOTE': '1', 11:21:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:22 INFO - 'NO_EM_RESTART': '1', 11:21:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:22 INFO - 'PWD': '/builds/slave/test', 11:21:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:22 INFO - 'RUST_BACKTRACE': 'full', 11:21:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:21:22 INFO - 'SHELL': '/bin/bash', 11:21:22 INFO - 'SHLVL': '1', 11:21:22 INFO - 'TERM': 'linux', 11:21:22 INFO - 'TMOUT': '86400', 11:21:22 INFO - 'USER': 'cltbld', 11:21:22 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', 11:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:22 INFO - '_': '/tools/buildbot/bin/python'} 11:21:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:21:23 INFO - mozversion application_buildid: 20170919173329 11:21:23 INFO - mozversion application_changeset: ba69e294fc80f23d54fc68050f1b7d63d341aa9c 11:21:23 INFO - mozversion application_display_name: Nightly 11:21:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:23 INFO - mozversion application_name: Firefox 11:21:23 INFO - mozversion application_remotingname: firefox 11:21:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:21:23 INFO - mozversion application_vendor: Mozilla 11:21:23 INFO - mozversion application_version: 57.0a1 11:21:23 INFO - mozversion platform_buildid: 20170919173329 11:21:23 INFO - mozversion platform_changeset: ba69e294fc80f23d54fc68050f1b7d63d341aa9c 11:21:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:21:23 INFO - mozversion platform_version: 57.0a1 11:21:23 INFO - using testdate: 1505845283 11:21:23 INFO - actual date: 1505845283 11:21:23 INFO - starting webserver on 'localhost:57157' 11:21:23 INFO - SUITE-START | Running 2 tests 11:21:23 INFO - TEST-START | dromaeo_css 11:21:23 INFO - Initialising browser for dromaeo_css test... 11:21:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57157/getInfo.html -profile /tmp/tmpXK67us/profile 11:21:23 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/firefox/firefox http://localhost:57157/getInfo.html) 11:21:28 INFO - TEST-INFO | 1963: exit 0 11:21:28 INFO - Browser initialized. 11:21:28 INFO - Running cycle 1/1 for dromaeo_css test... 11:21:28 INFO - Using env: {'DISPLAY': ':0', 11:21:28 INFO - 'HOME': '/home/cltbld', 11:21:28 INFO - 'JSGC_DISABLE_POISONING': '1', 11:21:28 INFO - 'LANG': 'en_US.UTF-8', 11:21:28 INFO - 'LANGUAGE': 'en_US:en', 11:21:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:21:28 INFO - 'LOGNAME': 'cltbld', 11:21:28 INFO - 'MAIL': '/var/mail/cltbld', 11:21:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:28 INFO - 'MOZ_CRASHREPORTER': '1', 11:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:21:28 INFO - 'MOZ_NO_REMOTE': '1', 11:21:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:28 INFO - 'NO_EM_RESTART': '1', 11:21:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:28 INFO - 'PWD': '/builds/slave/test', 11:21:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:28 INFO - 'RUST_BACKTRACE': 'full', 11:21:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:21:28 INFO - 'SHELL': '/bin/bash', 11:21:28 INFO - 'SHLVL': '1', 11:21:28 INFO - 'TERM': 'linux', 11:21:28 INFO - 'TMOUT': '86400', 11:21:28 INFO - 'USER': 'cltbld', 11:21:28 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', 11:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:28 INFO - '_': '/tools/buildbot/bin/python'} 11:21:28 INFO - TEST-INFO | started process 2197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXK67us/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:29 INFO - PID 2197 | 11:21:29 INFO - PID 2197 | (/builds/slave/test/build/application/firefox/firefox:2246): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:21:29 INFO - PID 2197 | 11:21:40 INFO - PID 2197 | RSS: Main: 156299264 11:21:40 INFO - PID 2197 | 11:24:37 INFO - PID 2197 | Cycle 1(1): loaded http://localhost:57157/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57157/tests/dromaeo/cssquery-ext.html) 11:24:38 INFO - PID 2197 | RSS: Main: 155987968 11:24:38 INFO - PID 2197 | 11:27:40 INFO - PID 2197 | Cycle 1(1): loaded http://localhost:57157/tests/dromaeo/cssquery-ext.html (next: http://localhost:57157/tests/dromaeo/cssquery-jquery.html) 11:27:40 INFO - PID 2197 | RSS: Main: 155533312 11:27:40 INFO - PID 2197 | 11:30:42 INFO - PID 2197 | Cycle 1(1): loaded http://localhost:57157/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57157/tests/dromaeo/cssquery-mootools.html) 11:30:43 INFO - PID 2197 | RSS: Main: 158334976 11:30:43 INFO - PID 2197 | 11:33:44 INFO - PID 2197 | Cycle 1(1): loaded http://localhost:57157/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57157/tests/dromaeo/cssquery-prototype.html) 11:33:45 INFO - PID 2197 | RSS: Main: 156241920 11:33:45 INFO - PID 2197 | 11:36:48 INFO - PID 2197 | Cycle 1(1): loaded http://localhost:57157/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57157/tests/dromaeo/cssquery-yui.html) 11:36:49 INFO - PID 2197 | RSS: Main: 157646848 11:36:49 INFO - PID 2197 | 11:39:50 INFO - PID 2197 | Cycle 1(1): loaded http://localhost:57157/tests/dromaeo/cssquery-yui.html (next: http://localhost:57157/tests/dromaeo/cssquery-dojo.html) 11:39:51 INFO - PID 2197 | RSS: Main: 160505856 11:39:51 INFO - PID 2197 | 11:39:51 INFO - PID 2197 | __start_tp_report 11:39:51 INFO - PID 2197 | _x_x_mozilla_page_load 11:39:51 INFO - PID 2197 | _x_x_mozilla_page_load_details 11:39:51 INFO - PID 2197 | |i|pagename|runs| 11:39:51 INFO - PID 2197 | |0;dojo.html;3109.54911537827;3139.21519620095;3152.4483215437294;3159.7314228290593;3165.7625678074137;6081.726322315495;6292.056191571261;6332;6357.364263573651;6361.427471527568;6235.563510554263;6263.968680156604;6346.7461301548;6355.173827402431;6462.870742585157;5796.82609521715;5844.064949608063;5876.970615146918;5900.822975310747;5903.557233207505;5737.25415695959;5812.825615231529;5869.1196320551835;5898.1447690084915;5916.5266778657815;5769.686907020893;5855.326637436664;5872.236609240793;5886.6762328072155;5945.04879219325;5720.771169153229;5780.50865676418;5817.418258174191;5826.912596311059;5837.5913686041995;5703.030484817549;5720.885582288331;5778.104393818965;5782.826515204551;5844.824655260349;6205.937940620626;6319.715612797435;6378.362163783631;6379;6385.680715964183;6583.703733331964;6633.767818126391;6647.501437392215;6830.521863469559;6840.11078559789;6774.322567743236;6795.626240556768;6861.039454476328;6868.965655171743;6874.518783685144;6147.754089836401;6256.061590761422;6329.778457753957;6350.809475715736;6395.104685344056;6902.861942761117;6907.723691052302;6920;6920.134983127109;6927.930720692729;6508.576942498722;6599.8020059398295;6609.933900660932;6694.631795251211;6695.933040669628;6788.694508747119;6795.082663840319;6872.965635171792;6880.036794848726;6888.448924086061;6742.056112144303;6743.224529179207;6754.12196414463;6847.315268473113;6865.691043903036;6594.307597702268;6738.427233685192;6772.69522871472;6824.863502730017;6837.794866154023;5310.787568497294;5348.465153484621;5381.730913454312;5387.976284505931;5396.379416367089;4634.885450832955;4645.674802763774;4671.766411679402;4683.578477936934;4687.531246875285;5784.768609255582;5820.272465941757;5854.297484301911;5858.765649373977;5881.705914704247;6791.830204244835;6796.8300792479595;6834;6841.931580684229;6859.691313890887;5691.804721008634;5776.393478684678;5806.854828629233;5808.535317174616;5812.88374232513;5665.49010589049;5729;5753.971230143822;5820.30156381237;5853;6313.842153946188;6381.936180638134;6430.84244835934;6473.449756770728;6486.189226346707;6676.866462670622;6712.731490740316;6785.1518560179975;6844.486663500257;6867.587944723333;6364.745410183541;6384.3934826191435;6427.389398007182;6481.546291759531;6487.253965793805;6614.404703576702;6628.635425051476;6631.635260060743;6637.568558043712;6643.734250629921;6705.228898676714;6711;6733.562318449285;6795.354441328066;6799.89800153008;6459.483241340776;6461.644609546332;6481.125048118443;6554.63949482783;6557.672116394066;6529.836754081186;6632.635205063768;6674.132362792806;6690.397864192246;6695.296993815579;6507.381798729113;6509.446697030806;6586.8353291168105;6593.80218593443;6594.076829244005;6453.354664533509;6603.339666033358;6648.800535983928;6674.699638516181;6736;6463.450606698483;6480.449161821298;6481;6491.28595854465;6526.216853977553 11:39:51 INFO - PID 2197 | |1;ext.html;860.7159637319685;882.3867412148558;905.7735566108473;909.0046399192881;910.9635614575417;39600.40599391008;40630.39054414179;40657.59342406579;40661;40784.59215407845;37157.62842371575;37256.44115338272;40385.39421908674;41080.58919410805;41316.586834131725;7760.650770715317;7808.921910780905;7820.217978202191;7862.606869656523;7898.447108702393;7699.730509432171;7850.764477065697;7897.842043159133;7918.604069796516;7920.287174154325;7919.326857217144;7957.72147974821;7962.124166341727;7965.322947549465;7969;7903.683852645887;7925.445218834655;7933.246341597539;7937.761867143995;7940.444168908179;7806.804829879242;7872.960635196788;7874.842503149962;7876.133625301212;7877.36981041521;36967.630323696685;37236;37256.813715931516;37259.627403725885;37286.44070338947;3479.9478007829903;3481.756277060607;3516.7889926604485;3519.436890097572;3522.876699315512;30474.54288185679;30700.8464957676;30871.536926946115;30883.69116308853;30969.535456967937;4929.65492415531;5097.0315640028275;5100.795968161269;5103.897922041539;5157.53582177602;189262;189336;190027;190083;190627;46755;46842.765786171534;46889.5311046892;47033.76483117563;47047;47864.5213547867;48047.519524805;48112.55662330136;48355.516444835805;48426.27360589594;15702.68594628101;16178.352865885468;16205.10871902033;16218.270177842025;16235.107069111076;13351.465941362238;13366.933165334305;13378;13379.53171638988;13385.799213011813;12746.68133296675;12803.551875684492;12911;12934;12969.870301297055;5067.6452648315;5086.593072554187;5089.287499750038;5176.922346164811;5187.325647665779;989.6635144051057;1001.5793366785967;1002.9218590015762;1004.5931397783909;1030.860833787444;22707.88646056759;22839.657405138936;22891.885540572523;23023.309300721005;23136.884315578314;1101.6089288302537;1111.283222321598;1113.493360520961;1114.8606424196976;1125.2910666280354;12172.452239649238;12235.877641223475;12286.139970202179;12453.501859925502;12505.249685018927;206902;207350;208911;209101;209722;50245;51018.23472647913;54141.187882181795;54242.728786355816;54338;1407.9929600352139;1438.6762978329791;1440.6182361674164;1443.45870298638;1448.174540511919;26224.8688756555;26371;26722.064727734436;27209.86395068012;27368.315792105357;36394;36521;36548.08629784277;36578.26843463169;36616.63383366132;179720;180641;181014;181737;182451;32891.50662740013;32979.34041319112;33172;33207;33387;41159.7942010288;41279.380809287286;41311.38032929449;41580.1683966325;41811;30002.399952001273;30761.384772304875;30835.537466937567;30965.535516966815;30987.380252395276;31100.533491997187;31244.531332030492;31314.686853131177;31473.055808325786;31639.367212656078;35512;35587.82206088953;35700;35927.46108808422;35966.280674386886;30632.693673062982;30801;31005;31126.53310200394;31370.686293136776;22590.66114008324;23105.65341519912;23117.19089831915;23292.417689557897;23429.53140937206 11:39:51 INFO - PID 2197 | |2;jquery.html;547.3377213571579;562.9662220266782;572.7222297185862;573.1231216239154;590.1767034986193;21447.571048579037;22192.223272185478;22195.889020554874;22233.333000010007;22249;23136.42158946027;23723.52552948944;24035.278941631736;24088.638670419958;24103.63844542329;6421.871562568735;6581.967090164542;6614.206295244553;6618.602883826961;6626.8674626507445;6482.546221764478;6593.406593406592;6600.801975940705;6602.636854972999;6606.075149479077;6635.7677481288165;6914.481413893953;6944.097267355237;6944.791656250321;6948.722051117949;6829.078074459959;6893;6901.102856628606;6902.861942761142;6904.447644188453;6559.1145195398485;6786.355296246848;6847.109875716125;6847.93152068478;6850.177978642595;28728.13815585536;29292.41415171706;29300;29302;29328.413431731246;2119.2264823339524;2158.266189495579;2158.8596741211772;2159.7840215978435;2161.5136594266323;19400.320988765325;19824.90087549553;19918.701219481718;19989.000549972443;20281;2449.7060352757603;2462.150558057467;2482.3669964159203;2541.987290063538;2545.783608393289;121591;129303.35348323292;131757;136308;139248.30375848056;19992.800071999383;20155.596888062155;20857.68713469299;20873.68689469659;21328.78671213268;40620;40738.59261407407;41088.79455602703;41212.5272483646;41286.58713412887;11067.889321106846;11209.607663731731;11260.099192064616;11271.323720576791;11277.605283815026;9194.95402522983;9332.206762425134;9359.672411465566;9399.624015039459;9417.199538039207;10779.658305925188;10889.675111091125;11158.274712143684;11278.54885804575;11322;3694.4827724118645;3807.46803375752;3933.645971862546;4075.983772008692;4222.155568886235;947.6493697332031;967.5210770668424;972.1105188752354;989.475577943691;994.4778991029623;18633;18780.436586902415;18829.811701883078;19159.52101197481;19437;1025.1696126137704;1039.7140786283833;1039.7868436970402;1046.9633562825265;1049.7533079726259;10005.349652272578;10567.788644227227;10587.682369528926;10591.364518128938;10622.734431639115;419766;427226;436960;437920;447684;100459.49770251101;101866;102310.48844755729;105435;106939;1041.5625437316346;1079.3955384984433;1140.2303445174473;1157.8842115788523;1194.4027986006822;19231.51921201981;19540.022998850283;19549.315773948412;19661.901690491457;19804.900975495606;52321.7383913078;54431.45568544422;55121;56465.43534564766;56501.43498565126;67160;67625.66187169033;68143.31856681568;68206.65896670485;68289.65855170692;18618.255269789057;19240.23039078421;19293.324733634254;19444.513887152934;19473.415797526097;20306.187752489735;20639.8968005159;21368.465788355414;22104.668429973884;22135.66796498086;17696.823031769516;17813.46559603214;17821.554461138057;17856.46430607084;17909.19408626589;15476.226188690296;15808.60478488047;15871.761923570924;16649.50051498457;16859.7471037937;18270.177841996876;18409.355672551395;18505;18603.162857671166;18635.72046419278;18384.98882561472;18645.440636780917;19170.329038483585;19199.232030719173;19409.223631055163;17294.394696185573;17770.733438998166;17827.19777609985;17913;18100.36648717341 11:39:51 INFO - PID 2197 | |3;mootools.html;1273.1151849464623;1364.4814970311281;1365.965850853729;1366.0847232354324;1374.601365603975;14680.339384727686;15401.845981540195;15404.07575545468;15420.228988550569;15439.614009649764;15019.774703379459;15157.242137893116;15159.469418570352;15160.772588411182;15200.23998800061;2702.2568793581727;2723.9591406128875;2775.861206939655;2789.386335006295;2790.2745286225627;2672.8529930853797;2744.643196384467;2758.2966343582357;2758.3104223944015;2762.4751297253556;2622.6721659792524;2712;2724.8637568121517;2725.236933658579;2725.550284203104;2758.889644414221;2771.3764403009363;2772.542530482488;2772.875220615077;2789.3445040415486;2511.6483692283095;2519.3323769201174;2651.708312085669;2703.202555246207;2706.161090062087;14299.642508937255;14686.779698304534;14744.778828317583;14788.630284242872;14806;7844.725434609818;8137.633806478722;8153.306968907591;8156.265936065783;8166.346692264605;5447.237386765856;5528.612997090206;5549.944500554983;5694.857628559319;5697.373288938214;1957.8531610129155;1984.2459865251112;2014.9294774682962;2026.3515674983864;2060.062671484471;26249.212523624323;26411.73588264112;26836.463270734475;26852.328691782666;26865.731342686715;6669.566478178903;6800.591964482147;6957.721691132399;7006.684699188549;7033.191183013917;16936.153192340334;16976.066316352473;16977.660446790997;16992.065436401117;16997.745033824503;7701.345385642171;7913.525188488709;7934.761957141295;7939.6030198491;7949.085855126619;7202.919562065732;7341.522801017917;7399.297066778648;7425.925740742631;7427.85144297111;5026.371703537058;5156.5616922562;5188.610854185876;5194.11700010999;5261.657992230493;1481.4222453243244;1487.8884083693765;1494.9327280272414;1514.833368329483;1517.5599076267758;813.8168911994754;816.8366326734676;833.3999520345342;844.0673056272731;848.2196379331031;7860.135385107634;7904.644291006918;7995.200479952075;8026.5986700664735;8144.348452123816;696.954697944632;709.3757493405873;709.8899670551073;714.6176795414428;721.0950257426896;4635.837745678885;4823.927641085316;4830.420349558076;4834.371531700856;4836.758162091881;20272.594548108955;21361.35915922525;21515.031823567977;21703.45741356479;21718.782812171678;20021.599568008558;21281.467963300733;21309.573808523743;21608.243711470022;21609.459763505725;9332.20676242527;11177.273477223955;11194.10447164225;11327.546898124148;11365.54537818478;6575.736970521126;8078;8176.059753128228;8352.164783521599;8376.246137847624;18125.909370453064;18127.728084078484;18331.45005649833;18621.534461638566;18897;18607.627847442705;18761;18854.52863678419;19357.128929197937;19833.404997850088;11041.944790275997;11066.612668556561;11095.833562496731;11098;11107.83338249943;13764.31178441054;13881.097728647606;13918;14006.789898151332;14027.859721403063;11428.771424571296;11480.311181329147;11677.88322116802;11805.23265987708;11810.232334898204;11104.222704410613;11177.72055698614;11211.327320360804;11428.657140285804;11487.48306326234;9105.863412048957;9144.58849351794;9226.953865230631;9242.72271831846;9316.301277404085;6459.079526294276;6578.7368505261165;6642.302558231316;6647.501437392311;6732.932670673426;7117.82205444868;7213.6753846076;7248.927510725036;7274;7274.272572742683 11:39:51 INFO - PID 2197 | |4;prototype.html;506.70864253054503;507.9390473143221;525.5640108098961;539.5252178083286;540.8701911541232;6303.716332765025;6417.1390296813925;6429.614223146615;6462;6464.418202361787;6253.280872699641;6263.404976527234;6325.9683701581425;6335.303116657175;6343.492520598353;5007.749612519359;5097.7196254206;5105.489451054902;5110.412302585194;5135.383753949532;4905.264210368456;5093.312402825608;5094.566961808251;5119.0273847968765;5124.128898087315;4970.552650261476;4995.150824359849;5042;5096.745162741867;5106.412762532301;4984.601231901439;4992.40091189056;5026.4219614744225;5028.7737051832755;5032.194848824171;4457.66567507435;4565.08698260346;4570.954290457086;4579.7252164870215;4586.678932474728;6060.363741772343;6166.392660293734;6301.6534090625455;6334.936650633481;6349.777757778502;5658.43415658435;5672.290963629546;5716.314042314949;5735.913961290584;5811.506021988136;6637.767678131242;6650.434713049397;6664.900026499607;6689.130413046321;6711.657668466278;4925.556699897026;4941.654084214107;4946.40643122824;4960.801567937278;4975.4527002029745;6845.794626161223;6956.373926346653;6959.338862808025;6965.373116419496;7013.438924885997;5002.849914502571;5029.7174220573515;5061.139606266944;5078.314427552307;5091.872703182376;5159;5163.741812909339;5166.225066240019;5189.896202075937;5205.609579281493;5693.003724348306;5711.6858572778065;5730.656160630376;5742.3396309424115;5765.1928729977835;6406.743730250738;6547.279799222082;6638.867222655616;6708.865822683519;6725.327467253333;1696.2875592251285;1711.6576684662869;1769.8938063716218;1772.8404443600139;1778.1109445277361;1205.6383085074442;1226.6687994241504;1237.5977807212691;1240.8448943882015;1244.6577191272472;5655.6606603603095;5671.744771485293;5672.00739870521;5740.1102829061565;5758.481736643722;6679.56582822115;6847.109875716224;6856.434653980003;6906.412954898889;6959.8956015659805;5822;5823.912641310384;5824.621399609012;5849.327327357409;5884.882302354014;3571.160777217352;3608.8195590220384;3618.149734812317;3622.148795033218;3633.9818300908855;6537.444317233088;6595.604263744191;6608.207015158212;6620.602763834089;6630.138082049302;6902.482313826483;6941.618210998343;6983.965080174668;7034.311765176423;7097.290270972861;6525.706343214471;6572.835679107965;6583.07836902834;6597.934020659828;6607.834804129935;6785.796426107225;6815.931840681728;6879.449644028566;6893.586384816927;6895.896561551681;6712.765053223114;6735.831604209934;6750.189977202767;6829.053719689865;6861.210960739579;6351;6368.52236082305;6450.548461607643;6490.253620833664;6545.280019197789;4977.656032871177;5017.37282839645;5033.821927799991;5081.568066714371;5088.923666145085;6549.443297319781;6582.637954912334;6857.7256909723055;6895.862082758417;6922.58464492132;6389.9361006389345;6450.612963222222;6533.738650453929;6545.8690826184165;6625.337466253336;6429.4856411486035;6489.902651460137;6518;6557.737690492327;6647.202335719745;6280.905786413299;6348.492120630246;6455.644939528371;6499.805005849832;6506.642134682638;6575.145231119924;6622.1722284714415;6684.364985326386;6691.431228345645;6703.93296067033;6356.650384228912;6429.54993150475;6440.903386449113;6494.7726829562625;6531.281559028408 11:39:51 INFO - PID 2197 | |5;yui.html;876.3865294293996;900.896396914355;903.1465265324267;905.4205308602492;930.2929773372235;17413.303467861286;17431.389901353454;17749.11254437278;17815;17830.554236144104;18191.363302284422;18375;18377.816221837777;18471.907640461777;19081.14134863931;955.2644463762916;964.2382517810921;965.5558443116175;966.4974213409023;967.2213867836389;978.5694294510392;980.1081016275191;982;985.65009421655;985.8176237396069;974.3471873844505;1007.3250921882357;1022.0750221049962;1025.600015993763;1026.984595231072;1007.6674697349857;1014.3862962907408;1014.5688082564917;1014.6702321745425;1016.4460369098858;719.6905330707793;741.2772546766913;747.7569789818331;748.2367984655621;748.2816496163689;19133.9043304784;19492.805071949242;19520.511987200432;19627.607447851107;19665.508362290915;21260.36218913435;21360.89319553392;22424.88787556052;22519.437014074614;22528.324150275355;17215.569610759707;17602.295908163658;17721.291148354052;17775;17907.462776116736;3663.0476076220107;3669.321175582526;3705.110773414388;3709.239605880788;3712.2946640138557;135698;137603;138031;139262;142534.28732856372;16288.185590720417;16413.68690504757;16648.16759162037;16827.242774075195;16867.578310542336;27652.308692282855;30169.396612067634;30290.09129726112;30364.84817575942;30413.23966900801;7977.880331795028;8135.267825895698;8151.429399942066;8168.7957801055445;8175.305099066527;4112.527059388149;4157.542670306264;4211.936820947688;4218.198542276958;4218.472690913636;5320.600954928396;5493.2034854945805;5499.395066542677;5500.532454741392;5512.944870551323;969.6896992962185;1010.8332125199407;1015.5176291261591;1023.7798873242289;1023.9129673977795;658.1772784019975;689.2487188963953;696.3523922751889;696.7735485967081;704.3203308807026;11356.829647555292;11522.48564187914;11770.58802941893;12511.12422130442;12639.241645501299;687.1204857782047;692.2177938929078;702.9859402812017;710.1832892174041;710.6979533698158;5350.4649535046965;5404.621676482687;5486.067368547357;5546.611737178358;5584.692841893735;120735.39632301782;122733.38633306955;124940;128138;129769;108562;110682;113178;113454;113638.43180784043;90233;91535.54232228796;95006;95088;97506.51246743863;9825.459599722084;10046.296759226783;10084.798304033731;10185.643502477378;10264.538095785558;43363;44393.33409998788;45526;46001.079978399575;46227.53772462367;56821.43178568161;57111;57245.14132287935;57558;59262.40737592741;14354.641133971734;14652.780208297097;14689.338979745724;14712.632184195052;14860.405583776528;16794.832051679816;17005;17059.317627294768;17126.828731712525;17365.392211272545;15249.23753812327;15302.923485382948;15373.923130384277;15466.767998479807;15472;15273.389064437742;15481.767773483632;15656.530304090895;15658.765118523459;15691.764623530427;13514.86485135136;13755.17468951866;13795.172289662652;13968.231747253998;13971.441142354599;10369.32599381068;10493.370397776158;10639;10685.145188385066;10824.56701731922;11317.490712917774;11402.315861048364;11576.594819181288;11635.650930472098;11641.6507504775 11:39:51 INFO - PID 2197 | __end_tp_report 11:39:51 INFO - PID 2197 | __start_cc_report 11:39:51 INFO - PID 2197 | _x_x_mozilla_cycle_collect,286 11:39:51 INFO - PID 2197 | __end_cc_report 11:39:51 INFO - PID 2197 | __startTimestamp1505846391233__endTimestamp 11:39:51 INFO - PID 2197 | 11:39:51 INFO - PID 2197 | ------- Summary: start ------- 11:39:51 INFO - PID 2197 | Number of tests: 6 11:39:51 INFO - PID 2197 | 11:39:51 INFO - PID 2197 | [#0] dojo.html Cycles:165 Average:6213.96 Median:6461.64 stddev:743.96 (11.5%) stddev-sans-first:705.25 11:39:51 INFO - PID 2197 | Values: 3109.5 3139.2 3152.4 3159.7 3165.8 6081.7 6292.1 6332.0 6357.4 6361.4 6235.6 6264.0 6346.7 6355.2 6462.9 5796.8 5844.1 5877.0 5900.8 5903.6 5737.3 5812.8 5869.1 5898.1 5916.5 5769.7 5855.3 5872.2 5886.7 5945.0 5720.8 5780.5 5817.4 5826.9 5837.6 5703.0 5720.9 5778.1 5782.8 5844.8 6205.9 6319.7 6378.4 6379.0 6385.7 6583.7 6633.8 6647.5 6830.5 6840.1 6774.3 6795.6 6861.0 6869.0 6874.5 6147.8 6256.1 6329.8 6350.8 6395.1 6902.9 6907.7 6920.0 6920.1 6927.9 6508.6 6599.8 6609.9 6694.6 6695.9 6788.7 6795.1 6873.0 6880.0 6888.4 6742.1 6743.2 6754.1 6847.3 6865.7 6594.3 6738.4 6772.7 6824.9 6837.8 5310.8 5348.5 5381.7 5388.0 5396.4 4634.9 4645.7 4671.8 4683.6 4687.5 5784.8 5820.3 5854.3 5858.8 5881.7 6791.8 6796.8 6834.0 6841.9 6859.7 5691.8 5776.4 5806.9 5808.5 5812.9 5665.5 5729.0 5754.0 5820.3 5853.0 6313.8 6381.9 6430.8 6473.4 6486.2 6676.9 6712.7 6785.2 6844.5 6867.6 6364.7 6384.4 6427.4 6481.5 6487.3 6614.4 6628.6 6631.6 6637.6 6643.7 6705.2 6711.0 6733.6 6795.4 6799.9 6459.5 6461.6 6481.1 6554.6 6557.7 6529.8 6632.6 6674.1 6690.4 6695.3 6507.4 6509.4 6586.8 6593.8 6594.1 6453.4 6603.3 6648.8 6674.7 6736.0 6463.5 6480.4 6481.0 6491.3 6526.2 11:39:51 INFO - PID 2197 | 11:39:51 INFO - PID 2197 | [#1] ext.html Cycles:180 Average:36113.58 Median:3499.27 stddev:49971.17 (1428.0%) stddev-sans-first:50041.24 11:39:51 INFO - PID 2197 | Values: 860.7 882.4 905.8 909.0 911.0 39600.4 40630.4 40657.6 40661.0 40784.6 37157.6 37256.4 40385.4 41080.6 41316.6 7760.7 7808.9 7820.2 7862.6 7898.4 7699.7 7850.8 7897.8 7918.6 7920.3 7919.3 7957.7 7962.1 7965.3 7969.0 7903.7 7925.4 7933.2 7937.8 7940.4 7806.8 7873.0 7874.8 7876.1 7877.4 36967.6 37236.0 37256.8 37259.6 37286.4 3479.9 3481.8 3516.8 3519.4 3522.9 30474.5 30700.8 30871.5 30883.7 30969.5 4929.7 5097.0 5100.8 5103.9 5157.5 189262.0 189336.0 190027.0 190083.0 190627.0 46755.0 46842.8 46889.5 47033.8 47047.0 47864.5 48047.5 48112.6 48355.5 48426.3 15702.7 16178.4 16205.1 16218.3 16235.1 13351.5 13366.9 13378.0 13379.5 13385.8 12746.7 12803.6 12911.0 12934.0 12969.9 5067.6 5086.6 5089.3 5176.9 5187.3 989.7 1001.6 1002.9 1004.6 1030.9 22707.9 22839.7 22891.9 23023.3 23136.9 1101.6 1111.3 1113.5 1114.9 1125.3 12172.5 12235.9 12286.1 12453.5 12505.2 206902.0 207350.0 208911.0 209101.0 209722.0 50245.0 51018.2 54141.2 54242.7 54338.0 1408.0 1438.7 1440.6 1443.5 1448.2 26224.9 26371.0 26722.1 27209.9 27368.3 36394.0 36521.0 36548.1 36578.3 36616.6 179720.0 180641.0 181014.0 181737.0 182451.0 32891.5 32979.3 33172.0 33207.0 33387.0 41159.8 41279.4 41311.4 41580.2 41811.0 30002.4 30761.4 30835.5 30965.5 30987.4 31100.5 31244.5 31314.7 31473.1 31639.4 35512.0 35587.8 35700.0 35927.5 35966.3 30632.7 30801.0 31005.0 31126.5 31370.7 22590.7 23105.7 23117.2 23292.4 23429.5 11:39:51 INFO - PID 2197 | 11:39:51 INFO - PID 2197 | [#2] jquery.html Cycles:180 Average:33464.87 Median:2158.56 stddev:73238.16 (3392.9%) stddev-sans-first:73401.91 11:39:51 INFO - PID 2197 | Values: 547.3 563.0 572.7 573.1 590.2 21447.6 22192.2 22195.9 22233.3 22249.0 23136.4 23723.5 24035.3 24088.6 24103.6 6421.9 6582.0 6614.2 6618.6 6626.9 6482.5 6593.4 6600.8 6602.6 6606.1 6635.8 6914.5 6944.1 6944.8 6948.7 6829.1 6893.0 6901.1 6902.9 6904.4 6559.1 6786.4 6847.1 6847.9 6850.2 28728.1 29292.4 29300.0 29302.0 29328.4 2119.2 2158.3 2158.9 2159.8 2161.5 19400.3 19824.9 19918.7 19989.0 20281.0 2449.7 2462.2 2482.4 2542.0 2545.8 121591.0 129303.4 131757.0 136308.0 139248.3 19992.8 20155.6 20857.7 20873.7 21328.8 40620.0 40738.6 41088.8 41212.5 41286.6 11067.9 11209.6 11260.1 11271.3 11277.6 9195.0 9332.2 9359.7 9399.6 9417.2 10779.7 10889.7 11158.3 11278.5 11322.0 3694.5 3807.5 3933.6 4076.0 4222.2 947.6 967.5 972.1 989.5 994.5 18633.0 18780.4 18829.8 19159.5 19437.0 1025.2 1039.7 1039.8 1047.0 1049.8 10005.3 10567.8 10587.7 10591.4 10622.7 419766.0 427226.0 436960.0 437920.0 447684.0 100459.5 101866.0 102310.5 105435.0 106939.0 1041.6 1079.4 1140.2 1157.9 1194.4 19231.5 19540.0 19549.3 19661.9 19804.9 52321.7 54431.5 55121.0 56465.4 56501.4 67160.0 67625.7 68143.3 68206.7 68289.7 18618.3 19240.2 19293.3 19444.5 19473.4 20306.2 20639.9 21368.5 22104.7 22135.7 17696.8 17813.5 17821.6 17856.5 17909.2 15476.2 15808.6 15871.8 16649.5 16859.7 18270.2 18409.4 18505.0 18603.2 18635.7 18385.0 18645.4 19170.3 19199.2 19409.2 17294.4 17770.7 17827.2 17913.0 18100.4 11:39:51 INFO - PID 2197 | 11:39:51 INFO - PID 2197 | [#3] mootools.html Cycles:180 Average:9227.34 Median:2704.68 stddev:6642.59 (245.6%) stddev-sans-first:6634.34 11:39:51 INFO - PID 2197 | Values: 1273.1 1364.5 1366.0 1366.1 1374.6 14680.3 15401.8 15404.1 15420.2 15439.6 15019.8 15157.2 15159.5 15160.8 15200.2 2702.3 2724.0 2775.9 2789.4 2790.3 2672.9 2744.6 2758.3 2758.3 2762.5 2622.7 2712.0 2724.9 2725.2 2725.6 2758.9 2771.4 2772.5 2772.9 2789.3 2511.6 2519.3 2651.7 2703.2 2706.2 14299.6 14686.8 14744.8 14788.6 14806.0 7844.7 8137.6 8153.3 8156.3 8166.3 5447.2 5528.6 5549.9 5694.9 5697.4 1957.9 1984.2 2014.9 2026.4 2060.1 26249.2 26411.7 26836.5 26852.3 26865.7 6669.6 6800.6 6957.7 7006.7 7033.2 16936.2 16976.1 16977.7 16992.1 16997.7 7701.3 7913.5 7934.8 7939.6 7949.1 7202.9 7341.5 7399.3 7425.9 7427.9 5026.4 5156.6 5188.6 5194.1 5261.7 1481.4 1487.9 1494.9 1514.8 1517.6 813.8 816.8 833.4 844.1 848.2 7860.1 7904.6 7995.2 8026.6 8144.3 697.0 709.4 709.9 714.6 721.1 4635.8 4823.9 4830.4 4834.4 4836.8 20272.6 21361.4 21515.0 21703.5 21718.8 20021.6 21281.5 21309.6 21608.2 21609.5 9332.2 11177.3 11194.1 11327.5 11365.5 6575.7 8078.0 8176.1 8352.2 8376.2 18125.9 18127.7 18331.5 18621.5 18897.0 18607.6 18761.0 18854.5 19357.1 19833.4 11041.9 11066.6 11095.8 11098.0 11107.8 13764.3 13881.1 13918.0 14006.8 14027.9 11428.8 11480.3 11677.9 11805.2 11810.2 11104.2 11177.7 11211.3 11428.7 11487.5 9105.9 9144.6 9227.0 9242.7 9316.3 6459.1 6578.7 6642.3 6647.5 6732.9 7117.8 7213.7 7248.9 7274.0 7274.3 11:39:51 INFO - PID 2197 | 11:39:51 INFO - PID 2197 | [#4] prototype.html Cycles:180 Average:5574.61 Median:6302.68 stddev:1564.29 (24.8%) stddev-sans-first:1521.72 11:39:51 INFO - PID 2197 | Values: 506.7 507.9 525.6 539.5 540.9 6303.7 6417.1 6429.6 6462.0 6464.4 6253.3 6263.4 6326.0 6335.3 6343.5 5007.7 5097.7 5105.5 5110.4 5135.4 4905.3 5093.3 5094.6 5119.0 5124.1 4970.6 4995.2 5042.0 5096.7 5106.4 4984.6 4992.4 5026.4 5028.8 5032.2 4457.7 4565.1 4571.0 4579.7 4586.7 6060.4 6166.4 6301.7 6334.9 6349.8 5658.4 5672.3 5716.3 5735.9 5811.5 6637.8 6650.4 6664.9 6689.1 6711.7 4925.6 4941.7 4946.4 4960.8 4975.5 6845.8 6956.4 6959.3 6965.4 7013.4 5002.8 5029.7 5061.1 5078.3 5091.9 5159.0 5163.7 5166.2 5189.9 5205.6 5693.0 5711.7 5730.7 5742.3 5765.2 6406.7 6547.3 6638.9 6708.9 6725.3 1696.3 1711.7 1769.9 1772.8 1778.1 1205.6 1226.7 1237.6 1240.8 1244.7 5655.7 5671.7 5672.0 5740.1 5758.5 6679.6 6847.1 6856.4 6906.4 6959.9 5822.0 5823.9 5824.6 5849.3 5884.9 3571.2 3608.8 3618.1 3622.1 3634.0 6537.4 6595.6 6608.2 6620.6 6630.1 6902.5 6941.6 6984.0 7034.3 7097.3 6525.7 6572.8 6583.1 6597.9 6607.8 6785.8 6815.9 6879.4 6893.6 6895.9 6712.8 6735.8 6750.2 6829.1 6861.2 6351.0 6368.5 6450.5 6490.3 6545.3 4977.7 5017.4 5033.8 5081.6 5088.9 6549.4 6582.6 6857.7 6895.9 6922.6 6389.9 6450.6 6533.7 6545.9 6625.3 6429.5 6489.9 6518.0 6557.7 6647.2 6280.9 6348.5 6455.6 6499.8 6506.6 6575.1 6622.2 6684.4 6691.4 6703.9 6356.7 6429.5 6440.9 6494.8 6531.3 11:39:51 INFO - PID 2197 | 11:39:51 INFO - PID 2197 | [#5] yui.html Cycles:180 Average:24155.90 Median:18776.52 stddev:35626.98 (189.7%) stddev-sans-first:35684.04 11:39:51 INFO - PID 2197 | Values: 876.4 900.9 903.1 905.4 930.3 17413.3 17431.4 17749.1 17815.0 17830.6 18191.4 18375.0 18377.8 18471.9 19081.1 955.3 964.2 965.6 966.5 967.2 978.6 980.1 982.0 985.7 985.8 974.3 1007.3 1022.1 1025.6 1027.0 1007.7 1014.4 1014.6 1014.7 1016.4 719.7 741.3 747.8 748.2 748.3 19133.9 19492.8 19520.5 19627.6 19665.5 21260.4 21360.9 22424.9 22519.4 22528.3 17215.6 17602.3 17721.3 17775.0 17907.5 3663.0 3669.3 3705.1 3709.2 3712.3 135698.0 137603.0 138031.0 139262.0 142534.3 16288.2 16413.7 16648.2 16827.2 16867.6 27652.3 30169.4 30290.1 30364.8 30413.2 7977.9 8135.3 8151.4 8168.8 8175.3 4112.5 4157.5 4211.9 4218.2 4218.5 5320.6 5493.2 5499.4 5500.5 5512.9 969.7 1010.8 1015.5 1023.8 1023.9 658.2 689.2 696.4 696.8 704.3 11356.8 11522.5 11770.6 12511.1 12639.2 687.1 692.2 703.0 710.2 710.7 5350.5 5404.6 5486.1 5546.6 5584.7 120735.4 122733.4 124940.0 128138.0 129769.0 108562.0 110682.0 113178.0 113454.0 113638.4 90233.0 91535.5 95006.0 95088.0 97506.5 9825.5 10046.3 10084.8 10185.6 10264.5 43363.0 44393.3 45526.0 46001.1 46227.5 56821.4 57111.0 57245.1 57558.0 59262.4 14354.6 14652.8 14689.3 14712.6 14860.4 16794.8 17005.0 17059.3 17126.8 17365.4 15249.2 15302.9 15373.9 15466.8 15472.0 15273.4 15481.8 15656.5 15658.8 15691.8 13514.9 13755.2 13795.2 13968.2 13971.4 10369.3 10493.4 10639.0 10685.1 10824.6 11317.5 11402.3 11576.6 11635.7 11641.7 11:39:51 INFO - PID 2197 | -------- Summary: end -------- 11:39:51 INFO - PID 2197 | 11:39:52 INFO - TEST-INFO | 2197: exit 0 11:39:52 INFO - TEST-OK | dromaeo_css | took 1108824ms 11:39:52 INFO - TEST-START | kraken 11:39:52 INFO - Initialising browser for kraken test... 11:39:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57157/getInfo.html -profile /tmp/tmpXryojl/profile 11:39:52 INFO - TEST-INFO | started process 2571 (/builds/slave/test/build/application/firefox/firefox http://localhost:57157/getInfo.html) 11:39:56 INFO - TEST-INFO | 2571: exit 0 11:39:57 INFO - Browser initialized. 11:39:57 INFO - Running cycle 1/1 for kraken test... 11:39:57 INFO - Using env: {'DISPLAY': ':0', 11:39:57 INFO - 'HOME': '/home/cltbld', 11:39:57 INFO - 'JSGC_DISABLE_POISONING': '1', 11:39:57 INFO - 'LANG': 'en_US.UTF-8', 11:39:57 INFO - 'LANGUAGE': 'en_US:en', 11:39:57 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:39:57 INFO - 'LOGNAME': 'cltbld', 11:39:57 INFO - 'MAIL': '/var/mail/cltbld', 11:39:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:39:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:39:57 INFO - 'MOZ_CRASHREPORTER': '1', 11:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:57 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:39:57 INFO - 'MOZ_NO_REMOTE': '1', 11:39:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:57 INFO - 'NO_EM_RESTART': '1', 11:39:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:57 INFO - 'PWD': '/builds/slave/test', 11:39:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:39:57 INFO - 'RUST_BACKTRACE': 'full', 11:39:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:39:57 INFO - 'SHELL': '/bin/bash', 11:39:57 INFO - 'SHLVL': '1', 11:39:57 INFO - 'TERM': 'linux', 11:39:57 INFO - 'TMOUT': '86400', 11:39:57 INFO - 'USER': 'cltbld', 11:39:57 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622', 11:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:57 INFO - '_': '/tools/buildbot/bin/python'} 11:39:57 INFO - TEST-INFO | started process 2893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXryojl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:39:57 INFO - PID 2893 | 11:39:57 INFO - PID 2893 | (/builds/slave/test/build/application/firefox/firefox:2992): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:39:57 INFO - PID 2893 | 11:40:08 INFO - PID 2893 | RSS: Main: 156078080 11:40:08 INFO - PID 2893 | 11:40:10 INFO - PID 2893 | Cycle 1(1): loaded http://localhost:57157/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57157/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:11 INFO - PID 2893 | RSS: Main: 162136064 11:40:11 INFO - PID 2893 | 11:40:14 INFO - PID 2893 | Cycle 1(1): loaded http://localhost:57157/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57157/tests/kraken/driver.html?testName=audio-dft) 11:40:14 INFO - PID 2893 | RSS: Main: 162525184 11:40:14 INFO - PID 2893 | 11:40:17 INFO - PID 2893 | Cycle 1(1): loaded http://localhost:57157/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57157/tests/kraken/driver.html?testName=audio-fft) 11:40:18 INFO - PID 2893 | RSS: Main: 158289920 11:40:18 INFO - PID 2893 | 11:40:20 INFO - PID 2893 | Cycle 1(1): loaded http://localhost:57157/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57157/tests/kraken/driver.html?testName=audio-oscillator) 11:40:21 INFO - PID 2893 | RSS: Main: 158982144 11:40:21 INFO - PID 2893 | 11:40:23 INFO - PID 2893 | Cycle 1(1): loaded http://localhost:57157/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57157/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:24 INFO - PID 2893 | RSS: Main: 158846976 11:40:24 INFO - PID 2893 | 11:40:27 INFO - PID 2893 | Cycle 1(1): loaded http://localhost:57157/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57157/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:27 INFO - PID 2893 | RSS: Main: 161443840 11:40:27 INFO - PID 2893 | 11:40:31 INFO - PID 2893 | Cycle 1(1): loaded http://localhost:57157/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57157/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:32 INFO - PID 2893 | RSS: Main: 161914880 11:40:32 INFO - PID 2893 | 11:40:35 INFO - PID 2893 | Cycle 1(1): loaded http://localhost:57157/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57157/tests/kraken/driver.html?testName=json-parse-financial) 11:40:35 INFO - PID 2893 | RSS: Main: 161837056 11:40:35 INFO - PID 2893 | 11:40:37 INFO - PID 2893 | Cycle 1(1): loaded http://localhost:57157/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57157/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:38 INFO - PID 2893 | RSS: Main: 161886208 11:40:38 INFO - PID 2893 | 11:40:39 INFO - PID 2893 | Cycle 1(1): loaded http://localhost:57157/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57157/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:40 INFO - PID 2893 | RSS: Main: 161890304 11:40:40 INFO - PID 2893 | 11:40:42 INFO - PID 2893 | Cycle 1(1): loaded http://localhost:57157/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57157/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:43 INFO - PID 2893 | RSS: Main: 158806016 11:40:43 INFO - PID 2893 | 11:40:45 INFO - PID 2893 | Cycle 1(1): loaded http://localhost:57157/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57157/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:40:46 INFO - PID 2893 | RSS: Main: 159490048 11:40:46 INFO - PID 2893 | 11:40:49 INFO - PID 2893 | Cycle 1(1): loaded http://localhost:57157/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57157/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:40:49 INFO - PID 2893 | RSS: Main: 159268864 11:40:49 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | Cycle 1(1): loaded http://localhost:57157/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57157/tests/kraken/driver.html?testName=ai-astar) 11:40:51 INFO - PID 2893 | RSS: Main: 160350208 11:40:51 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | __start_tp_report 11:40:51 INFO - PID 2893 | _x_x_mozilla_page_load 11:40:51 INFO - PID 2893 | _x_x_mozilla_page_load_details 11:40:51 INFO - PID 2893 | |i|pagename|runs| 11:40:51 INFO - PID 2893 | |0;ai-astar;107;109;107;108;109;110;108;109;109;108 11:40:51 INFO - PID 2893 | |1;audio-beat-detection;116;116;116;119;119;118;116;117;120;117 11:40:51 INFO - PID 2893 | |2;audio-dft;163;164;164;165;163;162;162;169;167;165 11:40:51 INFO - PID 2893 | |3;audio-fft;74;76;76;78;73;74;74;74;76;80 11:40:51 INFO - PID 2893 | |4;audio-oscillator;81;79;78;78;79;80;80;79;78;79 11:40:51 INFO - PID 2893 | |5;imaging-gaussian-blur;117;113;113;113;115;117;114;114;113;110 11:40:51 INFO - PID 2893 | |6;imaging-darkroom;147;147;147;147;148;148;147;147;150;147 11:40:51 INFO - PID 2893 | |7;imaging-desaturate;95;93;94;93;94;94;93;95;94;94 11:40:51 INFO - PID 2893 | |8;json-parse-financial;53;53;53;54;55;54;54;53;53;53 11:40:51 INFO - PID 2893 | |9;json-stringify-tinderbox;40;43;39;39;43;39;38;38;38;38 11:40:51 INFO - PID 2893 | |10;stanford-crypto-aes;76;74;76;77;73;74;77;75;77;74 11:40:51 INFO - PID 2893 | |11;stanford-crypto-ccm;112;113;111;114;120;116;113;113;117;114 11:40:51 INFO - PID 2893 | |12;stanford-crypto-pbkdf2;179;173;185;171;180;173;171;186;172;180 11:40:51 INFO - PID 2893 | |13;stanford-crypto-sha256-iterative;67;67;69;65;70;72;67;66;68;65 11:40:51 INFO - PID 2893 | __end_tp_report 11:40:51 INFO - PID 2893 | __start_cc_report 11:40:51 INFO - PID 2893 | _x_x_mozilla_cycle_collect,755 11:40:51 INFO - PID 2893 | __end_cc_report 11:40:51 INFO - PID 2893 | __startTimestamp1505846451933__endTimestamp 11:40:51 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | ------- Summary: start ------- 11:40:51 INFO - PID 2893 | Number of tests: 14 11:40:51 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.00 stddev:0.97 (0.9%) stddev-sans-first:0.88 11:40:51 INFO - PID 2893 | Values: 107.0 109.0 107.0 108.0 109.0 110.0 108.0 109.0 109.0 108.0 11:40:51 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | [#1] audio-beat-detection Cycles:10 Average:117.40 Median:117.50 stddev:1.51 (1.3%) stddev-sans-first:1.51 11:40:51 INFO - PID 2893 | Values: 116.0 116.0 116.0 119.0 119.0 118.0 116.0 117.0 120.0 117.0 11:40:51 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:2.22 (1.4%) stddev-sans-first:2.30 11:40:51 INFO - PID 2893 | Values: 163.0 164.0 164.0 165.0 163.0 162.0 162.0 169.0 167.0 165.0 11:40:51 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | [#3] audio-fft Cycles:10 Average:75.50 Median:76.00 stddev:2.17 (2.9%) stddev-sans-first:2.24 11:40:51 INFO - PID 2893 | Values: 74.0 76.0 76.0 78.0 73.0 74.0 74.0 74.0 76.0 80.0 11:40:51 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:79.00 stddev:0.99 (1.3%) stddev-sans-first:0.78 11:40:51 INFO - PID 2893 | Values: 81.0 79.0 78.0 78.0 79.0 80.0 80.0 79.0 78.0 79.0 11:40:51 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:2.08 (1.8%) stddev-sans-first:1.88 11:40:51 INFO - PID 2893 | Values: 117.0 113.0 113.0 113.0 115.0 117.0 114.0 114.0 113.0 110.0 11:40:51 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 11:40:51 INFO - PID 2893 | Values: 147.0 147.0 147.0 147.0 148.0 148.0 147.0 147.0 150.0 147.0 11:40:51 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 11:40:51 INFO - PID 2893 | Values: 95.0 93.0 94.0 93.0 94.0 94.0 93.0 95.0 94.0 94.0 11:40:51 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 11:40:51 INFO - PID 2893 | Values: 53.0 53.0 53.0 54.0 55.0 54.0 54.0 53.0 53.0 53.0 11:40:51 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | [#9] json-stringify-tinderbox Cycles:10 Average:39.50 Median:39.00 stddev:1.96 (5.0%) stddev-sans-first:2.07 11:40:51 INFO - PID 2893 | Values: 40.0 43.0 39.0 39.0 43.0 39.0 38.0 38.0 38.0 38.0 11:40:51 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:76.00 stddev:1.49 (2.0%) stddev-sans-first:1.56 11:40:51 INFO - PID 2893 | Values: 76.0 74.0 76.0 77.0 73.0 74.0 77.0 75.0 77.0 74.0 11:40:51 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | [#11] stanford-crypto-ccm Cycles:10 Average:114.30 Median:114.00 stddev:2.67 (2.3%) stddev-sans-first:2.70 11:40:51 INFO - PID 2893 | Values: 112.0 113.0 111.0 114.0 120.0 116.0 113.0 113.0 117.0 114.0 11:40:51 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:179.50 stddev:5.73 (3.2%) stddev-sans-first:6.04 11:40:51 INFO - PID 2893 | Values: 179.0 173.0 185.0 171.0 180.0 173.0 171.0 186.0 172.0 180.0 11:40:51 INFO - PID 2893 | 11:40:51 INFO - PID 2893 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:2.22 (3.3%) stddev-sans-first:2.35 11:40:51 INFO - PID 2893 | Values: 67.0 67.0 69.0 65.0 70.0 72.0 67.0 66.0 68.0 65.0 11:40:51 INFO - PID 2893 | -------- Summary: end -------- 11:40:51 INFO - PID 2893 | 11:40:52 INFO - PID 2893 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:40:52 INFO - TEST-INFO | 2893: exit 0 11:40:52 INFO - TEST-OK | kraken | took 60526ms 11:40:52 INFO - SUITE-END | took 1169s 11:40:52 INFO - Completed test suite (00:19:29) 11:40:52 INFO - javascript benchmark 11:40:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8522.555341521764, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3109.54911537827, 3139.21519620095, 3152.4483215437294, 3159.7314228290593, 3165.7625678074137, 6081.726322315495, 6292.056191571261, 6332.0, 6357.364263573651, 6361.427471527568, 6235.563510554263, 6263.968680156604, 6346.7461301548, 6355.173827402431, 6462.870742585157, 5796.82609521715, 5844.064949608063, 5876.970615146918, 5900.822975310747, 5903.557233207505, 5737.25415695959, 5812.825615231529, 5869.1196320551835, 5898.1447690084915, 5916.5266778657815, 5769.686907020893, 5855.326637436664, 5872.236609240793, 5886.6762328072155, 5945.04879219325, 5720.771169153229, 5780.50865676418, 5817.418258174191, 5826.912596311059, 5837.5913686041995, 5703.030484817549, 5720.885582288331, 5778.104393818965, 5782.826515204551, 5844.824655260349, 6205.937940620626, 6319.715612797435, 6378.362163783631, 6379.0, 6385.680715964183, 6583.703733331964, 6633.767818126391, 6647.501437392215, 6830.521863469559, 6840.11078559789, 6774.322567743236, 6795.626240556768, 6861.039454476328, 6868.965655171743, 6874.518783685144, 6147.754089836401, 6256.061590761422, 6329.778457753957, 6350.809475715736, 6395.104685344056, 6902.861942761117, 6907.723691052302, 6920.0, 6920.134983127109, 6927.930720692729, 6508.576942498722, 6599.8020059398295, 6609.933900660932, 6694.631795251211, 6695.933040669628, 6788.694508747119, 6795.082663840319, 6872.965635171792, 6880.036794848726, 6888.448924086061, 6742.056112144303, 6743.224529179207, 6754.12196414463, 6847.315268473113, 6865.691043903036, 6594.307597702268, 6738.427233685192, 6772.69522871472, 6824.863502730017, 6837.794866154023, 5310.787568497294, 5348.465153484621, 5381.730913454312, 5387.976284505931, 5396.379416367089, 4634.885450832955, 4645.674802763774, 4671.766411679402, 4683.578477936934, 4687.531246875285, 5784.768609255582, 5820.272465941757, 5854.297484301911, 5858.765649373977, 5881.705914704247, 6791.830204244835, 6796.8300792479595, 6834.0, 6841.931580684229, 6859.691313890887, 5691.804721008634, 5776.393478684678, 5806.854828629233, 5808.535317174616, 5812.88374232513, 5665.49010589049, 5729.0, 5753.971230143822, 5820.30156381237, 5853.0, 6313.842153946188, 6381.936180638134, 6430.84244835934, 6473.449756770728, 6486.189226346707, 6676.866462670622, 6712.731490740316, 6785.1518560179975, 6844.486663500257, 6867.587944723333, 6364.745410183541, 6384.3934826191435, 6427.389398007182, 6481.546291759531, 6487.253965793805, 6614.404703576702, 6628.635425051476, 6631.635260060743, 6637.568558043712, 6643.734250629921, 6705.228898676714, 6711.0, 6733.562318449285, 6795.354441328066, 6799.89800153008, 6459.483241340776, 6461.644609546332, 6481.125048118443, 6554.63949482783, 6557.672116394066, 6529.836754081186, 6632.635205063768, 6674.132362792806, 6690.397864192246, 6695.296993815579, 6507.381798729113, 6509.446697030806, 6586.8353291168105, 6593.80218593443, 6594.076829244005, 6453.354664533509, 6603.339666033358, 6648.800535983928, 6674.699638516181, 6736.0, 6463.450606698483, 6480.449161821298, 6481.0, 6491.28595854465, 6526.216853977553], "value": 6157.013786640466, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [860.7159637319685, 882.3867412148558, 905.7735566108473, 909.0046399192881, 910.9635614575417, 39600.40599391008, 40630.39054414179, 40657.59342406579, 40661.0, 40784.59215407845, 37157.62842371575, 37256.44115338272, 40385.39421908674, 41080.58919410805, 41316.586834131725, 7760.650770715317, 7808.921910780905, 7820.217978202191, 7862.606869656523, 7898.447108702393, 7699.730509432171, 7850.764477065697, 7897.842043159133, 7918.604069796516, 7920.287174154325, 7919.326857217144, 7957.72147974821, 7962.124166341727, 7965.322947549465, 7969.0, 7903.683852645887, 7925.445218834655, 7933.246341597539, 7937.761867143995, 7940.444168908179, 7806.804829879242, 7872.960635196788, 7874.842503149962, 7876.133625301212, 7877.36981041521, 36967.630323696685, 37236.0, 37256.813715931516, 37259.627403725885, 37286.44070338947, 3479.9478007829903, 3481.756277060607, 3516.7889926604485, 3519.436890097572, 3522.876699315512, 30474.54288185679, 30700.8464957676, 30871.536926946115, 30883.69116308853, 30969.535456967937, 4929.65492415531, 5097.0315640028275, 5100.795968161269, 5103.897922041539, 5157.53582177602, 189262.0, 189336.0, 190027.0, 190083.0, 190627.0, 46755.0, 46842.765786171534, 46889.5311046892, 47033.76483117563, 47047.0, 47864.5213547867, 48047.519524805, 48112.55662330136, 48355.516444835805, 48426.27360589594, 15702.68594628101, 16178.352865885468, 16205.10871902033, 16218.270177842025, 16235.107069111076, 13351.465941362238, 13366.933165334305, 13378.0, 13379.53171638988, 13385.799213011813, 12746.68133296675, 12803.551875684492, 12911.0, 12934.0, 12969.870301297055, 5067.6452648315, 5086.593072554187, 5089.287499750038, 5176.922346164811, 5187.325647665779, 989.6635144051057, 1001.5793366785967, 1002.9218590015762, 1004.5931397783909, 1030.860833787444, 22707.88646056759, 22839.657405138936, 22891.885540572523, 23023.309300721005, 23136.884315578314, 1101.6089288302537, 1111.283222321598, 1113.493360520961, 1114.8606424196976, 1125.2910666280354, 12172.452239649238, 12235.877641223475, 12286.139970202179, 12453.501859925502, 12505.249685018927, 206902.0, 207350.0, 208911.0, 209101.0, 209722.0, 50245.0, 51018.23472647913, 54141.187882181795, 54242.728786355816, 54338.0, 1407.9929600352139, 1438.6762978329791, 1440.6182361674164, 1443.45870298638, 1448.174540511919, 26224.8688756555, 26371.0, 26722.064727734436, 27209.86395068012, 27368.315792105357, 36394.0, 36521.0, 36548.08629784277, 36578.26843463169, 36616.63383366132, 179720.0, 180641.0, 181014.0, 181737.0, 182451.0, 32891.50662740013, 32979.34041319112, 33172.0, 33207.0, 33387.0, 41159.7942010288, 41279.380809287286, 41311.38032929449, 41580.1683966325, 41811.0, 30002.399952001273, 30761.384772304875, 30835.537466937567, 30965.535516966815, 30987.380252395276, 31100.533491997187, 31244.531332030492, 31314.686853131177, 31473.055808325786, 31639.367212656078, 35512.0, 35587.82206088953, 35700.0, 35927.46108808422, 35966.280674386886, 30632.693673062982, 30801.0, 31005.0, 31126.53310200394, 31370.686293136776, 22590.66114008324, 23105.65341519912, 23117.19089831915, 23292.417689557897, 23429.53140937206], "value": 16907.221544121003, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.3377213571579, 562.9662220266782, 572.7222297185862, 573.1231216239154, 590.1767034986193, 21447.571048579037, 22192.223272185478, 22195.889020554874, 22233.333000010007, 22249.0, 23136.42158946027, 23723.52552948944, 24035.278941631736, 24088.638670419958, 24103.63844542329, 6421.871562568735, 6581.967090164542, 6614.206295244553, 6618.602883826961, 6626.8674626507445, 6482.546221764478, 6593.406593406592, 6600.801975940705, 6602.636854972999, 6606.075149479077, 6635.7677481288165, 6914.481413893953, 6944.097267355237, 6944.791656250321, 6948.722051117949, 6829.078074459959, 6893.0, 6901.102856628606, 6902.861942761142, 6904.447644188453, 6559.1145195398485, 6786.355296246848, 6847.109875716125, 6847.93152068478, 6850.177978642595, 28728.13815585536, 29292.41415171706, 29300.0, 29302.0, 29328.413431731246, 2119.2264823339524, 2158.266189495579, 2158.8596741211772, 2159.7840215978435, 2161.5136594266323, 19400.320988765325, 19824.90087549553, 19918.701219481718, 19989.000549972443, 20281.0, 2449.7060352757603, 2462.150558057467, 2482.3669964159203, 2541.987290063538, 2545.783608393289, 121591.0, 129303.35348323292, 131757.0, 136308.0, 139248.30375848056, 19992.800071999383, 20155.596888062155, 20857.68713469299, 20873.68689469659, 21328.78671213268, 40620.0, 40738.59261407407, 41088.79455602703, 41212.5272483646, 41286.58713412887, 11067.889321106846, 11209.607663731731, 11260.099192064616, 11271.323720576791, 11277.605283815026, 9194.95402522983, 9332.206762425134, 9359.672411465566, 9399.624015039459, 9417.199538039207, 10779.658305925188, 10889.675111091125, 11158.274712143684, 11278.54885804575, 11322.0, 3694.4827724118645, 3807.46803375752, 3933.645971862546, 4075.983772008692, 4222.155568886235, 947.6493697332031, 967.5210770668424, 972.1105188752354, 989.475577943691, 994.4778991029623, 18633.0, 18780.436586902415, 18829.811701883078, 19159.52101197481, 19437.0, 1025.1696126137704, 1039.7140786283833, 1039.7868436970402, 1046.9633562825265, 1049.7533079726259, 10005.349652272578, 10567.788644227227, 10587.682369528926, 10591.364518128938, 10622.734431639115, 419766.0, 427226.0, 436960.0, 437920.0, 447684.0, 100459.49770251101, 101866.0, 102310.48844755729, 105435.0, 106939.0, 1041.5625437316346, 1079.3955384984433, 1140.2303445174473, 1157.8842115788523, 1194.4027986006822, 19231.51921201981, 19540.022998850283, 19549.315773948412, 19661.901690491457, 19804.900975495606, 52321.7383913078, 54431.45568544422, 55121.0, 56465.43534564766, 56501.43498565126, 67160.0, 67625.66187169033, 68143.31856681568, 68206.65896670485, 68289.65855170692, 18618.255269789057, 19240.23039078421, 19293.324733634254, 19444.513887152934, 19473.415797526097, 20306.187752489735, 20639.8968005159, 21368.465788355414, 22104.668429973884, 22135.66796498086, 17696.823031769516, 17813.46559603214, 17821.554461138057, 17856.46430607084, 17909.19408626589, 15476.226188690296, 15808.60478488047, 15871.761923570924, 16649.50051498457, 16859.7471037937, 18270.177841996876, 18409.355672551395, 18505.0, 18603.162857671166, 18635.72046419278, 18384.98882561472, 18645.440636780917, 19170.329038483585, 19199.232030719173, 19409.223631055163, 17294.394696185573, 17770.733438998166, 17827.19777609985, 17913.0, 18100.36648717341], "value": 12554.668019584782, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1273.1151849464623, 1364.4814970311281, 1365.965850853729, 1366.0847232354324, 1374.601365603975, 14680.339384727686, 15401.845981540195, 15404.07575545468, 15420.228988550569, 15439.614009649764, 15019.774703379459, 15157.242137893116, 15159.469418570352, 15160.772588411182, 15200.23998800061, 2702.2568793581727, 2723.9591406128875, 2775.861206939655, 2789.386335006295, 2790.2745286225627, 2672.8529930853797, 2744.643196384467, 2758.2966343582357, 2758.3104223944015, 2762.4751297253556, 2622.6721659792524, 2712.0, 2724.8637568121517, 2725.236933658579, 2725.550284203104, 2758.889644414221, 2771.3764403009363, 2772.542530482488, 2772.875220615077, 2789.3445040415486, 2511.6483692283095, 2519.3323769201174, 2651.708312085669, 2703.202555246207, 2706.161090062087, 14299.642508937255, 14686.779698304534, 14744.778828317583, 14788.630284242872, 14806.0, 7844.725434609818, 8137.633806478722, 8153.306968907591, 8156.265936065783, 8166.346692264605, 5447.237386765856, 5528.612997090206, 5549.944500554983, 5694.857628559319, 5697.373288938214, 1957.8531610129155, 1984.2459865251112, 2014.9294774682962, 2026.3515674983864, 2060.062671484471, 26249.212523624323, 26411.73588264112, 26836.463270734475, 26852.328691782666, 26865.731342686715, 6669.566478178903, 6800.591964482147, 6957.721691132399, 7006.684699188549, 7033.191183013917, 16936.153192340334, 16976.066316352473, 16977.660446790997, 16992.065436401117, 16997.745033824503, 7701.345385642171, 7913.525188488709, 7934.761957141295, 7939.6030198491, 7949.085855126619, 7202.919562065732, 7341.522801017917, 7399.297066778648, 7425.925740742631, 7427.85144297111, 5026.371703537058, 5156.5616922562, 5188.610854185876, 5194.11700010999, 5261.657992230493, 1481.4222453243244, 1487.8884083693765, 1494.9327280272414, 1514.833368329483, 1517.5599076267758, 813.8168911994754, 816.8366326734676, 833.3999520345342, 844.0673056272731, 848.2196379331031, 7860.135385107634, 7904.644291006918, 7995.200479952075, 8026.5986700664735, 8144.348452123816, 696.954697944632, 709.3757493405873, 709.8899670551073, 714.6176795414428, 721.0950257426896, 4635.837745678885, 4823.927641085316, 4830.420349558076, 4834.371531700856, 4836.758162091881, 20272.594548108955, 21361.35915922525, 21515.031823567977, 21703.45741356479, 21718.782812171678, 20021.599568008558, 21281.467963300733, 21309.573808523743, 21608.243711470022, 21609.459763505725, 9332.20676242527, 11177.273477223955, 11194.10447164225, 11327.546898124148, 11365.54537818478, 6575.736970521126, 8078.0, 8176.059753128228, 8352.164783521599, 8376.246137847624, 18125.909370453064, 18127.728084078484, 18331.45005649833, 18621.534461638566, 18897.0, 18607.627847442705, 18761.0, 18854.52863678419, 19357.128929197937, 19833.404997850088, 11041.944790275997, 11066.612668556561, 11095.833562496731, 11098.0, 11107.83338249943, 13764.31178441054, 13881.097728647606, 13918.0, 14006.789898151332, 14027.859721403063, 11428.771424571296, 11480.311181329147, 11677.88322116802, 11805.23265987708, 11810.232334898204, 11104.222704410613, 11177.72055698614, 11211.327320360804, 11428.657140285804, 11487.48306326234, 9105.863412048957, 9144.58849351794, 9226.953865230631, 9242.72271831846, 9316.301277404085, 6459.079526294276, 6578.7368505261165, 6642.302558231316, 6647.501437392311, 6732.932670673426, 7117.82205444868, 7213.6753846076, 7248.927510725036, 7274.0, 7274.272572742683], "value": 6546.405021935535, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.70864253054503, 507.9390473143221, 525.5640108098961, 539.5252178083286, 540.8701911541232, 6303.716332765025, 6417.1390296813925, 6429.614223146615, 6462.0, 6464.418202361787, 6253.280872699641, 6263.404976527234, 6325.9683701581425, 6335.303116657175, 6343.492520598353, 5007.749612519359, 5097.7196254206, 5105.489451054902, 5110.412302585194, 5135.383753949532, 4905.264210368456, 5093.312402825608, 5094.566961808251, 5119.0273847968765, 5124.128898087315, 4970.552650261476, 4995.150824359849, 5042.0, 5096.745162741867, 5106.412762532301, 4984.601231901439, 4992.40091189056, 5026.4219614744225, 5028.7737051832755, 5032.194848824171, 4457.66567507435, 4565.08698260346, 4570.954290457086, 4579.7252164870215, 4586.678932474728, 6060.363741772343, 6166.392660293734, 6301.6534090625455, 6334.936650633481, 6349.777757778502, 5658.43415658435, 5672.290963629546, 5716.314042314949, 5735.913961290584, 5811.506021988136, 6637.767678131242, 6650.434713049397, 6664.900026499607, 6689.130413046321, 6711.657668466278, 4925.556699897026, 4941.654084214107, 4946.40643122824, 4960.801567937278, 4975.4527002029745, 6845.794626161223, 6956.373926346653, 6959.338862808025, 6965.373116419496, 7013.438924885997, 5002.849914502571, 5029.7174220573515, 5061.139606266944, 5078.314427552307, 5091.872703182376, 5159.0, 5163.741812909339, 5166.225066240019, 5189.896202075937, 5205.609579281493, 5693.003724348306, 5711.6858572778065, 5730.656160630376, 5742.3396309424115, 5765.1928729977835, 6406.743730250738, 6547.279799222082, 6638.867222655616, 6708.865822683519, 6725.327467253333, 1696.2875592251285, 1711.6576684662869, 1769.8938063716218, 1772.8404443600139, 1778.1109445277361, 1205.6383085074442, 1226.6687994241504, 1237.5977807212691, 1240.8448943882015, 1244.6577191272472, 5655.6606603603095, 5671.744771485293, 5672.00739870521, 5740.1102829061565, 5758.481736643722, 6679.56582822115, 6847.109875716224, 6856.434653980003, 6906.412954898889, 6959.8956015659805, 5822.0, 5823.912641310384, 5824.621399609012, 5849.327327357409, 5884.882302354014, 3571.160777217352, 3608.8195590220384, 3618.149734812317, 3622.148795033218, 3633.9818300908855, 6537.444317233088, 6595.604263744191, 6608.207015158212, 6620.602763834089, 6630.138082049302, 6902.482313826483, 6941.618210998343, 6983.965080174668, 7034.311765176423, 7097.290270972861, 6525.706343214471, 6572.835679107965, 6583.07836902834, 6597.934020659828, 6607.834804129935, 6785.796426107225, 6815.931840681728, 6879.449644028566, 6893.586384816927, 6895.896561551681, 6712.765053223114, 6735.831604209934, 6750.189977202767, 6829.053719689865, 6861.210960739579, 6351.0, 6368.52236082305, 6450.548461607643, 6490.253620833664, 6545.280019197789, 4977.656032871177, 5017.37282839645, 5033.821927799991, 5081.568066714371, 5088.923666145085, 6549.443297319781, 6582.637954912334, 6857.7256909723055, 6895.862082758417, 6922.58464492132, 6389.9361006389345, 6450.612963222222, 6533.738650453929, 6545.8690826184165, 6625.337466253336, 6429.4856411486035, 6489.902651460137, 6518.0, 6557.737690492327, 6647.202335719745, 6280.905786413299, 6348.492120630246, 6455.644939528371, 6499.805005849832, 6506.642134682638, 6575.145231119924, 6622.1722284714415, 6684.364985326386, 6691.431228345645, 6703.93296067033, 6356.650384228912, 6429.54993150475, 6440.903386449113, 6494.7726829562625, 6531.281559028408], "value": 5114.03487414603, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [876.3865294293996, 900.896396914355, 903.1465265324267, 905.4205308602492, 930.2929773372235, 17413.303467861286, 17431.389901353454, 17749.11254437278, 17815.0, 17830.554236144104, 18191.363302284422, 18375.0, 18377.816221837777, 18471.907640461777, 19081.14134863931, 955.2644463762916, 964.2382517810921, 965.5558443116175, 966.4974213409023, 967.2213867836389, 978.5694294510392, 980.1081016275191, 982.0, 985.65009421655, 985.8176237396069, 974.3471873844505, 1007.3250921882357, 1022.0750221049962, 1025.600015993763, 1026.984595231072, 1007.6674697349857, 1014.3862962907408, 1014.5688082564917, 1014.6702321745425, 1016.4460369098858, 719.6905330707793, 741.2772546766913, 747.7569789818331, 748.2367984655621, 748.2816496163689, 19133.9043304784, 19492.805071949242, 19520.511987200432, 19627.607447851107, 19665.508362290915, 21260.36218913435, 21360.89319553392, 22424.88787556052, 22519.437014074614, 22528.324150275355, 17215.569610759707, 17602.295908163658, 17721.291148354052, 17775.0, 17907.462776116736, 3663.0476076220107, 3669.321175582526, 3705.110773414388, 3709.239605880788, 3712.2946640138557, 135698.0, 137603.0, 138031.0, 139262.0, 142534.28732856372, 16288.185590720417, 16413.68690504757, 16648.16759162037, 16827.242774075195, 16867.578310542336, 27652.308692282855, 30169.396612067634, 30290.09129726112, 30364.84817575942, 30413.23966900801, 7977.880331795028, 8135.267825895698, 8151.429399942066, 8168.7957801055445, 8175.305099066527, 4112.527059388149, 4157.542670306264, 4211.936820947688, 4218.198542276958, 4218.472690913636, 5320.600954928396, 5493.2034854945805, 5499.395066542677, 5500.532454741392, 5512.944870551323, 969.6896992962185, 1010.8332125199407, 1015.5176291261591, 1023.7798873242289, 1023.9129673977795, 658.1772784019975, 689.2487188963953, 696.3523922751889, 696.7735485967081, 704.3203308807026, 11356.829647555292, 11522.48564187914, 11770.58802941893, 12511.12422130442, 12639.241645501299, 687.1204857782047, 692.2177938929078, 702.9859402812017, 710.1832892174041, 710.6979533698158, 5350.4649535046965, 5404.621676482687, 5486.067368547357, 5546.611737178358, 5584.692841893735, 120735.39632301782, 122733.38633306955, 124940.0, 128138.0, 129769.0, 108562.0, 110682.0, 113178.0, 113454.0, 113638.43180784043, 90233.0, 91535.54232228796, 95006.0, 95088.0, 97506.51246743863, 9825.459599722084, 10046.296759226783, 10084.798304033731, 10185.643502477378, 10264.538095785558, 43363.0, 44393.33409998788, 45526.0, 46001.079978399575, 46227.53772462367, 56821.43178568161, 57111.0, 57245.14132287935, 57558.0, 59262.40737592741, 14354.641133971734, 14652.780208297097, 14689.338979745724, 14712.632184195052, 14860.405583776528, 16794.832051679816, 17005.0, 17059.317627294768, 17126.828731712525, 17365.392211272545, 15249.23753812327, 15302.923485382948, 15373.923130384277, 15466.767998479807, 15472.0, 15273.389064437742, 15481.767773483632, 15656.530304090895, 15658.765118523459, 15691.764623530427, 13514.86485135136, 13755.17468951866, 13795.172289662652, 13968.231747253998, 13971.441142354599, 10369.32599381068, 10493.370397776158, 10639.0, 10685.145188385066, 10824.56701731922, 11317.490712917774, 11402.315861048364, 11576.594819181288, 11635.650930472098, 11641.6507504775], "value": 8757.475001783783, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 109.0, 107.0, 108.0, 109.0, 110.0, 108.0, 109.0, 109.0, 108.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 119.0, 119.0, 118.0, 116.0, 117.0, 120.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 165.0, 163.0, 162.0, 162.0, 169.0, 167.0, 165.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 78.0, 73.0, 74.0, 74.0, 74.0, 76.0, 80.0], "value": 75.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 78.0, 78.0, 79.0, 80.0, 80.0, 79.0, 78.0, 79.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 113.0, 113.0, 115.0, 117.0, 114.0, 114.0, 113.0, 110.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 150.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 94.0, 93.0, 94.0, 94.0, 93.0, 95.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 54.0, 55.0, 54.0, 54.0, 53.0, 53.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 43.0, 39.0, 39.0, 43.0, 39.0, 38.0, 38.0, 38.0, 38.0], "value": 39.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 77.0, 73.0, 74.0, 77.0, 75.0, 77.0, 74.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 111.0, 114.0, 120.0, 116.0, 113.0, 113.0, 117.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 173.0, 185.0, 171.0, 180.0, 173.0, 171.0, 186.0, 172.0, 180.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 65.0, 70.0, 72.0, 67.0, 66.0, 68.0, 65.0], "value": 67.6, "unit": "score"}]}]} 11:40:52 INFO - Return code: 0 11:40:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:40:52 INFO - # TBPL SUCCESS # 11:40:52 INFO - Running post-action listener: _package_coverage_data 11:40:52 INFO - Running post-action listener: _resource_record_post_action 11:40:52 INFO - [mozharness: 2017-09-19 18:40:52.719419Z] Finished run-tests step (success) 11:40:52 INFO - Running post-run listener: _resource_record_post_run 11:40:52 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 335941632; Read time: 216; Write time: 220920 11:40:52 INFO - TinderboxPrint: CPU usage
13.1% 11:40:52 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 216 11:40:52 INFO - TinderboxPrint: I/O write bytes / time
335,941,632 / 220,920 11:40:52 INFO - TinderboxPrint: CPU idle
8,223.3 (86.9%) 11:40:52 INFO - TinderboxPrint: CPU user
1,192.2 (12.6%) 11:40:52 INFO - TinderboxPrint: Swap in / out
0 / 0 11:40:52 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10289152; Read time: 0; Write time: 744 11:40:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:40:52 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 325165056; Read time: 200; Write time: 220176 11:40:53 INFO - Running post-run listener: _upload_blobber_files 11:40:53 INFO - Blob upload gear active. 11:40:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:40:53 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:40:53 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:40:53 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:40:53 INFO - (blobuploader) - INFO - Open directory for files ... 11:40:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:40:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:40:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:54 INFO - (blobuploader) - INFO - Done attempting. 11:40:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:40:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:40:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:55 INFO - (blobuploader) - INFO - Done attempting. 11:40:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:40:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:40:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:57 INFO - (blobuploader) - INFO - Done attempting. 11:40:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:40:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:41:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:04 INFO - (blobuploader) - INFO - Done attempting. 11:41:04 INFO - (blobuploader) - INFO - Iteration through files over. 11:41:04 INFO - Return code: 0 11:41:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:41:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:41:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62c184583a5cd4c156a6dca7b81999b18949f1a246d9f093eeeda2c14d18ae9ed4805b4b1b249a4bae315aaeabad94093d4807796cd01bdf982ea79501730796", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02060e380920be62a175d1648acc79495095aed488a2443c9985f107d2c38ca030b51ba270f6b42a5e7578b99e3ff3708ebdd3b524537e5c952876bf9df701cc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e921e5bafce7caac127c9f912ad1da4613fbb32a170294cc390ca80fd3453fb6f4976685c4270d0bc9dfc465dc8e8d1f73375c39b809f6ad0f64c07e1652d67", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56348c15e9dd844ee8de6eb26f4cb230d2d19c82049fc88c4a7d7b07c06af43fb76097c2541cfddffbd47cdf97e9fca3cb766912ed71e188317d7432136b8ee7"} 11:41:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:41:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:41:04 INFO - Contents: 11:41:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62c184583a5cd4c156a6dca7b81999b18949f1a246d9f093eeeda2c14d18ae9ed4805b4b1b249a4bae315aaeabad94093d4807796cd01bdf982ea79501730796", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02060e380920be62a175d1648acc79495095aed488a2443c9985f107d2c38ca030b51ba270f6b42a5e7578b99e3ff3708ebdd3b524537e5c952876bf9df701cc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e921e5bafce7caac127c9f912ad1da4613fbb32a170294cc390ca80fd3453fb6f4976685c4270d0bc9dfc465dc8e8d1f73375c39b809f6ad0f64c07e1652d67", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56348c15e9dd844ee8de6eb26f4cb230d2d19c82049fc88c4a7d7b07c06af43fb76097c2541cfddffbd47cdf97e9fca3cb766912ed71e188317d7432136b8ee7"} 11:41:04 INFO - Running post-run listener: copy_logs_to_upload_dir 11:41:04 INFO - Copying logs to upload dir... 11:41:04 INFO - mkdir: /builds/slave/test/build/upload/logs 11:41:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.719165 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-19 11:41:04.186261) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 11:41:04.191503) ========= 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=2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62c184583a5cd4c156a6dca7b81999b18949f1a246d9f093eeeda2c14d18ae9ed4805b4b1b249a4bae315aaeabad94093d4807796cd01bdf982ea79501730796", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02060e380920be62a175d1648acc79495095aed488a2443c9985f107d2c38ca030b51ba270f6b42a5e7578b99e3ff3708ebdd3b524537e5c952876bf9df701cc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e921e5bafce7caac127c9f912ad1da4613fbb32a170294cc390ca80fd3453fb6f4976685c4270d0bc9dfc465dc8e8d1f73375c39b809f6ad0f64c07e1652d67", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56348c15e9dd844ee8de6eb26f4cb230d2d19c82049fc88c4a7d7b07c06af43fb76097c2541cfddffbd47cdf97e9fca3cb766912ed71e188317d7432136b8ee7"} build_url:https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011452 build_url: 'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62c184583a5cd4c156a6dca7b81999b18949f1a246d9f093eeeda2c14d18ae9ed4805b4b1b249a4bae315aaeabad94093d4807796cd01bdf982ea79501730796", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02060e380920be62a175d1648acc79495095aed488a2443c9985f107d2c38ca030b51ba270f6b42a5e7578b99e3ff3708ebdd3b524537e5c952876bf9df701cc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e921e5bafce7caac127c9f912ad1da4613fbb32a170294cc390ca80fd3453fb6f4976685c4270d0bc9dfc465dc8e8d1f73375c39b809f6ad0f64c07e1652d67", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56348c15e9dd844ee8de6eb26f4cb230d2d19c82049fc88c4a7d7b07c06af43fb76097c2541cfddffbd47cdf97e9fca3cb766912ed71e188317d7432136b8ee7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 11:41:04.226993) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:41:04.227357) ========= 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=2432103b8b3de4003b23cad4000001c2-1505838549.952390-1641681622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:41:04.309742) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 11:41:04.310057) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 11:41:04.310364) ========= ========= Total master_lag: 0.29 =========