builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1506300589.01 results: success (0) revision: 7e962631ba4298bcefa571008661983d77c3e652 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 17:49:49.008511) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 17:49:49.008998) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 17:49:49.009290) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 17:49:49.027303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 17:49:49.027685) ========= 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=523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-24 17:49:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.1M=0s 2017-09-24 17:49:49 (33.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132012 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 17:49:49.177069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 17:49:49.177519) ========= 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=523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020686 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 17:49:49.228001) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 17:49:49.228339) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7e962631ba4298bcefa571008661983d77c3e652 --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 7e962631ba4298bcefa571008661983d77c3e652 --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=523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-24 17:49:49,289 truncating revision to first 12 chars 2017-09-24 17:49:49,289 Setting DEBUG logging. 2017-09-24 17:49:49,289 attempt 1/10 2017-09-24 17:49:49,289 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7e962631ba42?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-24 17:49:49,694 unpacking tar archive at: mozilla-central-7e962631ba42/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727556 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 17:49:49.972734) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 17:49:49.973075) ========= script_repo_revision: 7e962631ba4298bcefa571008661983d77c3e652 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 17:49:49.973472) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 17:49:49.973744) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 17:49:49.987450) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-24 17:49:49.988077) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:49:50 INFO - MultiFileLogger online at 20170924 17:49:50 in /builds/slave/test 17:49:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:49:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:49:50 INFO - {'append_to_log': False, 17:49:50 INFO - 'base_work_dir': '/builds/slave/test', 17:49:50 INFO - 'blob_upload_branch': 'Firefox', 17:49:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:49:50 INFO - 'branch': 'Firefox', 17:49:50 INFO - 'buildbot_json_path': 'buildprops.json', 17:49:50 INFO - 'code_coverage': False, 17:49:50 INFO - 'config_files': ('talos/linux_config.py',), 17:49:50 INFO - 'default_actions': ('clobber', 17:49:50 INFO - 'read-buildbot-config', 17:49:50 INFO - 'download-and-extract', 17:49:50 INFO - 'populate-webroot', 17:49:50 INFO - 'create-virtualenv', 17:49:50 INFO - 'install', 17:49:50 INFO - 'setup-mitmproxy', 17:49:50 INFO - 'run-tests'), 17:49:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:49:50 INFO - 'disable_ccov_upload': False, 17:49:50 INFO - 'disable_stylo': False, 17:49:50 INFO - 'download_minidump_stackwalk': True, 17:49:50 INFO - 'download_symbols': 'ondemand', 17:49:50 INFO - 'enable_stylo': False, 17:49:50 INFO - 'enable_webrender': False, 17:49:50 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:49:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:49:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:49:50 INFO - 'gecko_profile': False, 17:49:50 INFO - 'gecko_profile_interval': 0, 17:49:50 INFO - 'installer_path': 'installer.exe', 17:49:50 INFO - 'log_level': 'info', 17:49:50 INFO - 'log_name': 'talos', 17:49:50 INFO - 'log_to_console': True, 17:49:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:49:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:49:50 INFO - 'opt_config_files': (), 17:49:50 INFO - 'pip_index': False, 17:49:50 INFO - 'suite': 'dromaeojs-e10s', 17:49:50 INFO - 'system_bits': '32', 17:49:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:49:50 INFO - 'title': 'talos-linux64-ix-065', 17:49:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:49:50 INFO - 'use_talos_json': True, 17:49:50 INFO - 'verify': 'False', 17:49:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:49:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:49:50 INFO - 'work_dir': 'build'} 17:49:50 INFO - [mozharness: 2017-09-25 00:49:50.195242Z] Running clobber step. 17:49:50 INFO - Running pre-action listener: _resource_record_pre_action 17:49:50 INFO - Running main action method: clobber 17:49:50 INFO - rmtree: /builds/slave/test/build 17:49:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:49:51 INFO - Running post-action listener: _resource_record_post_action 17:49:51 INFO - [mozharness: 2017-09-25 00:49:51.704814Z] Finished clobber step (success) 17:49:51 INFO - [mozharness: 2017-09-25 00:49:51.704911Z] Running read-buildbot-config step. 17:49:51 INFO - Running pre-action listener: _resource_record_pre_action 17:49:51 INFO - Running main action method: read_buildbot_config 17:49:51 INFO - Using buildbot properties: 17:49:51 INFO - { 17:49:51 INFO - "project": "", 17:49:51 INFO - "product": "firefox", 17:49:51 INFO - "who": "archaeopteryx@coole-files.de", 17:49:51 INFO - "installer_path": "public/build/target.tar.bz2", 17:49:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:49:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:49:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 17:49:51 INFO - "stage_platform": "linux64-pgo", 17:49:51 INFO - "basedir": "/builds/slave/test", 17:49:51 INFO - "buildnumber": 201, 17:49:51 INFO - "platform": "ubuntu64_hw", 17:49:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:49:51 INFO - "slavebuilddir": "test", 17:49:51 INFO - "taskId": "OA-lF28dQqy769aYY0ZqSQ", 17:49:51 INFO - "branch": "mozilla-central", 17:49:51 INFO - "script_repo_revision": "production", 17:49:51 INFO - "revision": "7e962631ba4298bcefa571008661983d77c3e652", 17:49:51 INFO - "slavename": "talos-linux64-ix-065", 17:49:51 INFO - "repo_path": "mozilla-central" 17:49:51 INFO - } 17:49:51 INFO - Finding installer, test and symbols from parent task. 17:49:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OA-lF28dQqy769aYY0ZqSQ'}, attempt #1 17:49:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OA-lF28dQqy769aYY0ZqSQ'}, attempt #1 17:49:52 INFO - Task dependencies: XNnhmb6FR56ecTjHY5Q_Pw 17:49:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw'}, attempt #1 17:49:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.tar.bz2 17:49:53 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.test_packages.json 17:49:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.crashreporter-symbols.zip 17:49:53 INFO - Running post-action listener: _resource_record_post_action 17:49:53 INFO - [mozharness: 2017-09-25 00:49:53.057021Z] Finished read-buildbot-config step (success) 17:49:53 INFO - [mozharness: 2017-09-25 00:49:53.057242Z] Running download-and-extract step. 17:49:53 INFO - Running pre-action listener: _resource_record_pre_action 17:49:53 INFO - Running main action method: download_and_extract 17:49:53 INFO - mkdir: /builds/slave/test/build/tests 17:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:53 INFO - trying https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.test_packages.json 17:49:53 INFO - Downloading https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:49:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:49:53 INFO - Downloaded 989 bytes. 17:49:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:49:53 INFO - Using the following test package requirements: 17:49:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:49:53 INFO - u'common': [u'target.common.tests.zip'], 17:49:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:49:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:49:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:49:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:49:53 INFO - u'mozbase': [u'target.common.tests.zip'], 17:49:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:49:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:49:53 INFO - u'web-platform': [u'target.common.tests.zip', 17:49:53 INFO - u'target.web-platform.tests.tar.gz'], 17:49:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:49:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:49:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.common.tests.zip 17:49:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:49:53 INFO - Fetch https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.common.tests.zip into memory 17:49:56 INFO - Content-Length response header: 55353629 17:49:56 INFO - Bytes received: 55353629 17:50:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.talos.tests.zip 17:50:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:50:06 INFO - Fetch https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.talos.tests.zip into memory 17:50:08 INFO - Content-Length response header: 14513823 17:50:08 INFO - Bytes received: 14513823 17:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:08 INFO - trying https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.tar.bz2 17:50:08 INFO - Downloading https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:50:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:50:11 INFO - Downloaded 62310319 bytes. 17:50:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.tar.bz2 17:50:11 INFO - mkdir: /builds/slave/test/properties 17:50:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:50:11 INFO - Writing to file /builds/slave/test/properties/build_url 17:50:11 INFO - Contents: 17:50:11 INFO - build_url:https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.tar.bz2 17:50:11 INFO - Running post-action listener: _resource_record_post_action 17:50:11 INFO - Running post-action listener: find_tests_for_verification 17:50:11 INFO - Running post-action listener: set_extra_try_arguments 17:50:11 INFO - [mozharness: 2017-09-25 00:50:11.469840Z] Finished download-and-extract step (success) 17:50:11 INFO - [mozharness: 2017-09-25 00:50:11.470066Z] Running populate-webroot step. 17:50:11 INFO - Running pre-action listener: _resource_record_pre_action 17:50:11 INFO - Running main action method: populate_webroot 17:50:11 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:50:11 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:50:11 INFO - 'tests': ['tresize', 17:50:11 INFO - 'tcanvasmark']}, 17:50:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:50:11 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:50:11 INFO - 'tests': ['dromaeo_css', 17:50:11 INFO - 'kraken']}, 17:50:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:50:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:50:11 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:50:11 INFO - 'talos_options': ['--disable-stylo'], 17:50:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:50:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:50:11 INFO - 'tests': ['damp', 'tps']}, 17:50:11 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:50:11 INFO - 'talos_options': ['--disable-stylo'], 17:50:11 INFO - 'tests': ['damp', 'tps']}, 17:50:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:50:11 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:50:11 INFO - 'tests': ['dromaeo_dom']}, 17:50:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:50:11 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:50:11 INFO - 'tests': ['basic_compositor_video', 17:50:11 INFO - 'glvideo']}, 17:50:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:50:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:50:11 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:50:11 INFO - 'talos_options': ['--disable-stylo'], 17:50:11 INFO - 'tests': ['ts_paint_webext', 17:50:11 INFO - 'tp5o_webext']}, 17:50:11 INFO - 'other-e10s': {'tests': ['a11yr', 17:50:11 INFO - 'ts_paint', 17:50:11 INFO - 'tpaint', 17:50:11 INFO - 'sessionrestore', 17:50:11 INFO - 'sessionrestore_many_windows', 17:50:11 INFO - 'sessionrestore_no_auto_restore', 17:50:11 INFO - 'tabpaint']}, 17:50:11 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:50:11 INFO - 'tests': ['a11yr', 17:50:11 INFO - 'ts_paint', 17:50:11 INFO - 'tpaint', 17:50:11 INFO - 'sessionrestore', 17:50:11 INFO - 'sessionrestore_many_windows', 17:50:11 INFO - 'sessionrestore_no_auto_restore', 17:50:11 INFO - 'tabpaint']}, 17:50:11 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 17:50:11 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:50:11 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:50:11 INFO - 'tests': ['perf_reftest_singletons']}, 17:50:11 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:50:11 INFO - 'tests': ['perf_reftest']}, 17:50:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:50:11 INFO - 'tsvgr_opacity', 17:50:11 INFO - 'tart', 17:50:11 INFO - 'tscrollx', 17:50:11 INFO - 'tsvg_static']}, 17:50:11 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:50:11 INFO - 'tests': ['tsvgx', 17:50:11 INFO - 'tsvgr_opacity', 17:50:11 INFO - 'tart', 17:50:11 INFO - 'tscrollx', 17:50:11 INFO - 'tsvg_static']}, 17:50:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:50:11 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:50:11 INFO - 'talos_options': ['--disable-stylo'], 17:50:11 INFO - 'tests': ['tp5o']}, 17:50:11 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:50:11 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:50:11 INFO - 'talos_options': ['--mitmproxy', 17:50:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:50:11 INFO - '--firstNonBlankPaint'], 17:50:11 INFO - 'tests': ['tp6_google', 17:50:11 INFO - 'tp6_youtube', 17:50:11 INFO - 'tp6_amazon', 17:50:11 INFO - 'tp6_facebook']}, 17:50:11 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:50:11 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:50:11 INFO - 'talos_options': ['--disable-stylo', 17:50:11 INFO - '--mitmproxy', 17:50:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:50:11 INFO - '--firstNonBlankPaint'], 17:50:11 INFO - 'tests': ['tp6_google', 17:50:11 INFO - 'tp6_youtube', 17:50:11 INFO - 'tp6_amazon', 17:50:11 INFO - 'tp6_facebook']}, 17:50:11 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:50:11 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:50:11 INFO - 'talos_options': ['--stylo-threads=1', 17:50:11 INFO - '--mitmproxy', 17:50:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:50:11 INFO - '--firstNonBlankPaint'], 17:50:11 INFO - 'tests': ['tp6_google', 17:50:11 INFO - 'tp6_youtube', 17:50:11 INFO - 'tp6_amazon', 17:50:11 INFO - 'tp6_facebook']}, 17:50:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:50:11 INFO - 'talos_options': ['--xperf_path', 17:50:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:50:11 INFO - 'tests': ['tp5n']}, 17:50:11 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:50:11 INFO - 'talos_options': ['--disable-stylo', 17:50:11 INFO - '--xperf_path', 17:50:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:50:11 INFO - 'tests': ['tp5n']}}} 17:50:11 INFO - Running post-action listener: _resource_record_post_action 17:50:11 INFO - [mozharness: 2017-09-25 00:50:11.490495Z] Finished populate-webroot step (success) 17:50:11 INFO - [mozharness: 2017-09-25 00:50:11.490584Z] Running create-virtualenv step. 17:50:11 INFO - Running pre-action listener: _resource_record_pre_action 17:50:11 INFO - Running main action method: create_virtualenv 17:50:11 INFO - Creating virtualenv /builds/slave/test/build/venv 17:50:11 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:50:11 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:50:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:50:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:50:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:50:12 INFO - Installing distribute.............................................................................................................................................................................................done. 17:50:12 INFO - Installing pip...............done. 17:50:12 INFO - Return code: 0 17:50:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:50:12 INFO - Reading from file tmpfile_stdout 17:50:12 INFO - Output received: 17:50:12 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:50:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:12 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 0x15e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194dd60>, '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 0x194ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194eef0>, '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': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:50:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:50:12 INFO - Using env: {'DISPLAY': ':0', 17:50:12 INFO - 'HOME': '/home/cltbld', 17:50:12 INFO - 'LANG': 'en_US.UTF-8', 17:50:12 INFO - 'LANGUAGE': 'en_US:en', 17:50:12 INFO - 'LOGNAME': 'cltbld', 17:50:12 INFO - 'MAIL': '/var/mail/cltbld', 17:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:12 INFO - 'MOZ_NO_REMOTE': '1', 17:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:12 INFO - 'NO_EM_RESTART': '1', 17:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:12 INFO - 'PWD': '/builds/slave/test', 17:50:12 INFO - 'SHELL': '/bin/bash', 17:50:12 INFO - 'SHLVL': '1', 17:50:12 INFO - 'TERM': 'linux', 17:50:12 INFO - 'TMOUT': '86400', 17:50:12 INFO - 'USER': 'cltbld', 17:50:12 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 17:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:12 INFO - '_': '/tools/buildbot/bin/python'} 17:50:13 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:50:13 INFO - Downloading/unpacking pip>=1.5 17:50:13 INFO - Running setup.py egg_info for package pip 17:50:13 INFO - warning: no files found matching 'pip/cacert.pem' 17:50:13 INFO - warning: no files found matching '*.html' under directory 'docs' 17:50:13 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:50:13 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:50:13 INFO - Installing collected packages: pip 17:50:13 INFO - Found existing installation: pip 1.1 17:50:13 INFO - Uninstalling pip: 17:50:13 INFO - Successfully uninstalled pip 17:50:13 INFO - Running setup.py install for pip 17:50:13 INFO - warning: no files found matching 'pip/cacert.pem' 17:50:13 INFO - warning: no files found matching '*.html' under directory 'docs' 17:50:13 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:50:13 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:50:13 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:50:13 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:50:13 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:50:13 INFO - Successfully installed pip 17:50:13 INFO - Cleaning up... 17:50:13 INFO - Return code: 0 17:50:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:13 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 0x15e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194dd60>, '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 0x194ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194eef0>, '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': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:50:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:50:13 INFO - Using env: {'DISPLAY': ':0', 17:50:13 INFO - 'HOME': '/home/cltbld', 17:50:13 INFO - 'LANG': 'en_US.UTF-8', 17:50:13 INFO - 'LANGUAGE': 'en_US:en', 17:50:13 INFO - 'LOGNAME': 'cltbld', 17:50:13 INFO - 'MAIL': '/var/mail/cltbld', 17:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:13 INFO - 'MOZ_NO_REMOTE': '1', 17:50:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:13 INFO - 'NO_EM_RESTART': '1', 17:50:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:13 INFO - 'PWD': '/builds/slave/test', 17:50:13 INFO - 'SHELL': '/bin/bash', 17:50:13 INFO - 'SHLVL': '1', 17:50:13 INFO - 'TERM': 'linux', 17:50:13 INFO - 'TMOUT': '86400', 17:50:13 INFO - 'USER': 'cltbld', 17:50:13 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 17:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:13 INFO - '_': '/tools/buildbot/bin/python'} 17:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:13 INFO - Downloading/unpacking psutil>=3.1.1 17:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:50:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:50:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:50:15 INFO - Installing collected packages: psutil 17:50:15 INFO - Running setup.py install for psutil 17:50:15 INFO - building 'psutil._psutil_linux' extension 17:50:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:50:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:50:15 INFO - building 'psutil._psutil_posix' extension 17:50:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:50:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:50:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:50:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:50:15 INFO - Successfully installed psutil 17:50:15 INFO - Cleaning up... 17:50:15 INFO - Return code: 0 17:50:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:15 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 0x15e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194dd60>, '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 0x194ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194eef0>, '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': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:50:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:50:15 INFO - Using env: {'DISPLAY': ':0', 17:50:15 INFO - 'HOME': '/home/cltbld', 17:50:15 INFO - 'LANG': 'en_US.UTF-8', 17:50:15 INFO - 'LANGUAGE': 'en_US:en', 17:50:15 INFO - 'LOGNAME': 'cltbld', 17:50:15 INFO - 'MAIL': '/var/mail/cltbld', 17:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:15 INFO - 'MOZ_NO_REMOTE': '1', 17:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:15 INFO - 'NO_EM_RESTART': '1', 17:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:15 INFO - 'PWD': '/builds/slave/test', 17:50:15 INFO - 'SHELL': '/bin/bash', 17:50:15 INFO - 'SHLVL': '1', 17:50:15 INFO - 'TERM': 'linux', 17:50:15 INFO - 'TMOUT': '86400', 17:50:15 INFO - 'USER': 'cltbld', 17:50:15 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 17:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:15 INFO - '_': '/tools/buildbot/bin/python'} 17:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:50:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:50:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:50:17 INFO - Installing collected packages: mozsystemmonitor 17:50:17 INFO - Running setup.py install for mozsystemmonitor 17:50:17 INFO - Successfully installed mozsystemmonitor 17:50:17 INFO - Cleaning up... 17:50:18 INFO - Return code: 0 17:50:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:18 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 0x15e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194dd60>, '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 0x194ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194eef0>, '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': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:50:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:50:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:50:18 INFO - Using env: {'DISPLAY': ':0', 17:50:18 INFO - 'HOME': '/home/cltbld', 17:50:18 INFO - 'LANG': 'en_US.UTF-8', 17:50:18 INFO - 'LANGUAGE': 'en_US:en', 17:50:18 INFO - 'LOGNAME': 'cltbld', 17:50:18 INFO - 'MAIL': '/var/mail/cltbld', 17:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:18 INFO - 'MOZ_NO_REMOTE': '1', 17:50:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:18 INFO - 'NO_EM_RESTART': '1', 17:50:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:18 INFO - 'PWD': '/builds/slave/test', 17:50:18 INFO - 'SHELL': '/bin/bash', 17:50:18 INFO - 'SHLVL': '1', 17:50:18 INFO - 'TERM': 'linux', 17:50:18 INFO - 'TMOUT': '86400', 17:50:18 INFO - 'USER': 'cltbld', 17:50:18 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 17:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:18 INFO - '_': '/tools/buildbot/bin/python'} 17:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:18 INFO - Downloading/unpacking jsonschema==2.5.1 17:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:50:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:19 INFO - Downloading functools32-3.2.3-2.tar.gz 17:50:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:50:19 INFO - warning: no files found matching '*.txt' 17:50:19 INFO - no previously-included directories found matching 'build' 17:50:19 INFO - no previously-included directories found matching 'dist' 17:50:19 INFO - no previously-included directories found matching '.git*' 17:50:19 INFO - Installing collected packages: jsonschema, functools32 17:50:20 INFO - Running setup.py install for functools32 17:50:20 INFO - warning: no files found matching '*.txt' 17:50:20 INFO - no previously-included directories found matching 'build' 17:50:20 INFO - no previously-included directories found matching 'dist' 17:50:20 INFO - no previously-included directories found matching '.git*' 17:50:20 INFO - Successfully installed jsonschema functools32 17:50:20 INFO - Cleaning up... 17:50:20 INFO - Return code: 0 17:50:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:20 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 0x15e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194dd60>, '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 0x194ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194eef0>, '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': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:50:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:50:20 INFO - Using env: {'DISPLAY': ':0', 17:50:20 INFO - 'HOME': '/home/cltbld', 17:50:20 INFO - 'LANG': 'en_US.UTF-8', 17:50:20 INFO - 'LANGUAGE': 'en_US:en', 17:50:20 INFO - 'LOGNAME': 'cltbld', 17:50:20 INFO - 'MAIL': '/var/mail/cltbld', 17:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:20 INFO - 'MOZ_NO_REMOTE': '1', 17:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:20 INFO - 'NO_EM_RESTART': '1', 17:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:20 INFO - 'PWD': '/builds/slave/test', 17:50:20 INFO - 'SHELL': '/bin/bash', 17:50:20 INFO - 'SHLVL': '1', 17:50:20 INFO - 'TERM': 'linux', 17:50:20 INFO - 'TMOUT': '86400', 17:50:20 INFO - 'USER': 'cltbld', 17:50:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 17:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:20 INFO - '_': '/tools/buildbot/bin/python'} 17:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:50:20 INFO - Cleaning up... 17:50:20 INFO - Return code: 0 17:50:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:20 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 0x15e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194dd60>, '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 0x194ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194eef0>, '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': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:50:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:50:20 INFO - Using env: {'DISPLAY': ':0', 17:50:20 INFO - 'HOME': '/home/cltbld', 17:50:20 INFO - 'LANG': 'en_US.UTF-8', 17:50:20 INFO - 'LANGUAGE': 'en_US:en', 17:50:20 INFO - 'LOGNAME': 'cltbld', 17:50:20 INFO - 'MAIL': '/var/mail/cltbld', 17:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:20 INFO - 'MOZ_NO_REMOTE': '1', 17:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:20 INFO - 'NO_EM_RESTART': '1', 17:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:20 INFO - 'PWD': '/builds/slave/test', 17:50:20 INFO - 'SHELL': '/bin/bash', 17:50:20 INFO - 'SHLVL': '1', 17:50:20 INFO - 'TERM': 'linux', 17:50:20 INFO - 'TMOUT': '86400', 17:50:20 INFO - 'USER': 'cltbld', 17:50:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 17:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:20 INFO - '_': '/tools/buildbot/bin/python'} 17:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:21 INFO - Downloading/unpacking blobuploader==1.2.4 17:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:22 INFO - Downloading blobuploader-1.2.4.tar.gz 17:50:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:50:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:50:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:22 INFO - Downloading docopt-0.6.1.tar.gz 17:50:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:50:22 INFO - Installing collected packages: blobuploader, requests, docopt 17:50:22 INFO - Running setup.py install for blobuploader 17:50:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:50:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:50:22 INFO - Running setup.py install for requests 17:50:23 INFO - Running setup.py install for docopt 17:50:23 INFO - Successfully installed blobuploader requests docopt 17:50:23 INFO - Cleaning up... 17:50:23 INFO - Return code: 0 17:50:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:23 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 0x15e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194dd60>, '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 0x194ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194eef0>, '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': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:50:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:50:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:50:23 INFO - Using env: {'DISPLAY': ':0', 17:50:23 INFO - 'HOME': '/home/cltbld', 17:50:23 INFO - 'LANG': 'en_US.UTF-8', 17:50:23 INFO - 'LANGUAGE': 'en_US:en', 17:50:23 INFO - 'LOGNAME': 'cltbld', 17:50:23 INFO - 'MAIL': '/var/mail/cltbld', 17:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:23 INFO - 'MOZ_NO_REMOTE': '1', 17:50:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:23 INFO - 'NO_EM_RESTART': '1', 17:50:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:23 INFO - 'PWD': '/builds/slave/test', 17:50:23 INFO - 'SHELL': '/bin/bash', 17:50:23 INFO - 'SHLVL': '1', 17:50:23 INFO - 'TERM': 'linux', 17:50:23 INFO - 'TMOUT': '86400', 17:50:23 INFO - 'USER': 'cltbld', 17:50:23 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 17:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:23 INFO - '_': '/tools/buildbot/bin/python'} 17:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:50:23 INFO - Running setup.py (path:/tmp/pip-5snf3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:50:23 INFO - Running setup.py (path:/tmp/pip-xW3WS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:50:23 INFO - Running setup.py (path:/tmp/pip-7c6fZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:50:23 INFO - Running setup.py (path:/tmp/pip-wbqFBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:50:23 INFO - Running setup.py (path:/tmp/pip-TV70FH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:50:24 INFO - Running setup.py (path:/tmp/pip-_Jh7OX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:50:24 INFO - Running setup.py (path:/tmp/pip-by2aqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:50:24 INFO - Running setup.py (path:/tmp/pip-FuPcXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:50:24 INFO - Running setup.py (path:/tmp/pip-DCI9nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:50:24 INFO - Running setup.py (path:/tmp/pip-uDW82c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:50:24 INFO - Running setup.py (path:/tmp/pip-qId6U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:50:24 INFO - Running setup.py (path:/tmp/pip-xeY2Pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:50:24 INFO - Running setup.py (path:/tmp/pip-KXquaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:50:24 INFO - Running setup.py (path:/tmp/pip-xqlR8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:24 INFO - Running setup.py (path:/tmp/pip-uGheK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:50:24 INFO - Running setup.py (path:/tmp/pip-_lzm2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:50:24 INFO - Running setup.py (path:/tmp/pip-l803gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:50:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:50:24 INFO - Running setup.py install for manifestparser 17:50:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:50:25 INFO - Running setup.py install for mozcrash 17:50:25 INFO - Running setup.py install for mozdebug 17:50:25 INFO - Running setup.py install for mozdevice 17:50:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:50:25 INFO - Running setup.py install for mozfile 17:50:25 INFO - Running setup.py install for mozhttpd 17:50:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:50:25 INFO - Running setup.py install for mozinfo 17:50:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:50:25 INFO - Running setup.py install for mozInstall 17:50:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:50:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:50:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:50:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:50:25 INFO - Running setup.py install for mozleak 17:50:25 INFO - Running setup.py install for mozlog 17:50:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:50:25 INFO - Running setup.py install for moznetwork 17:50:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:50:26 INFO - Running setup.py install for mozprocess 17:50:26 INFO - Running setup.py install for mozprofile 17:50:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:50:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:50:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:50:26 INFO - Running setup.py install for mozrunner 17:50:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:50:26 INFO - Running setup.py install for mozscreenshot 17:50:26 INFO - Running setup.py install for moztest 17:50:26 INFO - Running setup.py install for mozversion 17:50:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:50:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:50:26 INFO - Cleaning up... 17:50:26 INFO - Return code: 0 17:50:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:26 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 0x15e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194dd60>, '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 0x194ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194eef0>, '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': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:50:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:50:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:50:26 INFO - Using env: {'DISPLAY': ':0', 17:50:26 INFO - 'HOME': '/home/cltbld', 17:50:26 INFO - 'LANG': 'en_US.UTF-8', 17:50:26 INFO - 'LANGUAGE': 'en_US:en', 17:50:26 INFO - 'LOGNAME': 'cltbld', 17:50:26 INFO - 'MAIL': '/var/mail/cltbld', 17:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:26 INFO - 'MOZ_NO_REMOTE': '1', 17:50:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:26 INFO - 'NO_EM_RESTART': '1', 17:50:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:26 INFO - 'PWD': '/builds/slave/test', 17:50:26 INFO - 'SHELL': '/bin/bash', 17:50:26 INFO - 'SHLVL': '1', 17:50:26 INFO - 'TERM': 'linux', 17:50:26 INFO - 'TMOUT': '86400', 17:50:26 INFO - 'USER': 'cltbld', 17:50:26 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 17:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:26 INFO - '_': '/tools/buildbot/bin/python'} 17:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:50:26 INFO - Running setup.py (path:/tmp/pip-AIAPjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:50:26 INFO - Running setup.py (path:/tmp/pip-EL_hTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:50:27 INFO - Running setup.py (path:/tmp/pip-rmbORr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:50:27 INFO - Running setup.py (path:/tmp/pip-WJ_tiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:50:27 INFO - Running setup.py (path:/tmp/pip-U_0A5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:50:27 INFO - Running setup.py (path:/tmp/pip-4G3379-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:50:27 INFO - Running setup.py (path:/tmp/pip-xD34JA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:50:27 INFO - Running setup.py (path:/tmp/pip-HB2gF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:50:27 INFO - Running setup.py (path:/tmp/pip-M1dJ6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:50:27 INFO - Running setup.py (path:/tmp/pip-mR9IlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:50:27 INFO - Running setup.py (path:/tmp/pip-fyIrYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:50:27 INFO - Running setup.py (path:/tmp/pip-sqGBp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:50:27 INFO - Running setup.py (path:/tmp/pip-SlQ2Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:50:27 INFO - Running setup.py (path:/tmp/pip-02m73e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:27 INFO - Running setup.py (path:/tmp/pip-rmhUWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:50:27 INFO - Running setup.py (path:/tmp/pip-mnHvvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:50:28 INFO - Running setup.py (path:/tmp/pip-4JrGwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:50:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:29 INFO - Downloading blessings-1.6.tar.gz 17:50:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:50:29 INFO - Installing collected packages: blessings 17:50:29 INFO - Running setup.py install for blessings 17:50:29 INFO - Successfully installed blessings 17:50:29 INFO - Cleaning up... 17:50:29 INFO - Return code: 0 17:50:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:50:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:50:29 INFO - Reading from file tmpfile_stdout 17:50:29 INFO - Current package versions: 17:50:29 INFO - argparse == 1.2.1 17:50:29 INFO - blessings == 1.6 17:50:29 INFO - blobuploader == 1.2.4 17:50:29 INFO - docopt == 0.6.1 17:50:29 INFO - functools32 == 3.2.3-2 17:50:29 INFO - jsonschema == 2.5.1 17:50:29 INFO - manifestparser == 1.1 17:50:29 INFO - mozInstall == 1.13 17:50:29 INFO - mozcrash == 1.0 17:50:29 INFO - mozdebug == 0.1 17:50:29 INFO - mozdevice == 0.51 17:50:29 INFO - mozfile == 1.2 17:50:29 INFO - mozhttpd == 0.7 17:50:29 INFO - mozinfo == 0.10 17:50:29 INFO - mozleak == 0.1 17:50:29 INFO - mozlog == 3.5 17:50:29 INFO - moznetwork == 0.27 17:50:29 INFO - mozprocess == 0.25 17:50:29 INFO - mozprofile == 0.28 17:50:29 INFO - mozrunner == 6.13 17:50:29 INFO - mozscreenshot == 0.1 17:50:29 INFO - mozsystemmonitor == 0.3 17:50:29 INFO - moztest == 0.8 17:50:29 INFO - mozversion == 1.4 17:50:29 INFO - psutil == 3.1.1 17:50:29 INFO - requests == 1.2.3 17:50:29 INFO - wsgiref == 0.1.2 17:50:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:29 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 0x15e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194dd60>, '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 0x194ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194eef0>, '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': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:50:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:50:29 INFO - Using env: {'DISPLAY': ':0', 17:50:29 INFO - 'HOME': '/home/cltbld', 17:50:29 INFO - 'LANG': 'en_US.UTF-8', 17:50:29 INFO - 'LANGUAGE': 'en_US:en', 17:50:29 INFO - 'LOGNAME': 'cltbld', 17:50:29 INFO - 'MAIL': '/var/mail/cltbld', 17:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:29 INFO - 'MOZ_NO_REMOTE': '1', 17:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:29 INFO - 'NO_EM_RESTART': '1', 17:50:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:29 INFO - 'PWD': '/builds/slave/test', 17:50:29 INFO - 'SHELL': '/bin/bash', 17:50:29 INFO - 'SHLVL': '1', 17:50:29 INFO - 'TERM': 'linux', 17:50:29 INFO - 'TMOUT': '86400', 17:50:29 INFO - 'USER': 'cltbld', 17:50:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 17:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:29 INFO - '_': '/tools/buildbot/bin/python'} 17:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:50:29 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:50:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:50:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:50:31 INFO - Installing collected packages: simplejson 17:50:31 INFO - Running setup.py install for simplejson 17:50:31 INFO - building 'simplejson._speedups' extension 17:50:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 17:50:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 17:50:32 INFO - Successfully installed simplejson 17:50:32 INFO - Cleaning up... 17:50:32 INFO - Return code: 0 17:50:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:32 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 0x15e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17abb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19509c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194dd60>, '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 0x194ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194eef0>, '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': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:50:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:50:32 INFO - Using env: {'DISPLAY': ':0', 17:50:32 INFO - 'HOME': '/home/cltbld', 17:50:32 INFO - 'LANG': 'en_US.UTF-8', 17:50:32 INFO - 'LANGUAGE': 'en_US:en', 17:50:32 INFO - 'LOGNAME': 'cltbld', 17:50:32 INFO - 'MAIL': '/var/mail/cltbld', 17:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:32 INFO - 'MOZ_NO_REMOTE': '1', 17:50:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:32 INFO - 'NO_EM_RESTART': '1', 17:50:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:32 INFO - 'PWD': '/builds/slave/test', 17:50:32 INFO - 'SHELL': '/bin/bash', 17:50:32 INFO - 'SHLVL': '1', 17:50:32 INFO - 'TERM': 'linux', 17:50:32 INFO - 'TMOUT': '86400', 17:50:32 INFO - 'USER': 'cltbld', 17:50:32 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 17:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:32 INFO - '_': '/tools/buildbot/bin/python'} 17:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:50:32 INFO - Cleaning up... 17:50:32 INFO - Return code: 0 17:50:32 INFO - Running post-action listener: _resource_record_post_action 17:50:32 INFO - Running post-action listener: _start_resource_monitoring 17:50:32 INFO - Starting resource monitoring. 17:50:32 INFO - [mozharness: 2017-09-25 00:50:32.431706Z] Finished create-virtualenv step (success) 17:50:32 INFO - [mozharness: 2017-09-25 00:50:32.432229Z] Running install step. 17:50:32 INFO - Running pre-action listener: _resource_record_pre_action 17:50:32 INFO - Running main action method: install 17:50:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:50:32 INFO - Reading from file tmpfile_stdout 17:50:32 INFO - Detecting whether we're running mozinstall >=1.0... 17:50:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:50:32 INFO - Reading from file tmpfile_stdout 17:50:32 INFO - Output received: 17:50:32 INFO - Usage: mozinstall [options] installer 17:50:32 INFO - Options: 17:50:32 INFO - -h, --help show this help message and exit 17:50:32 INFO - -d DEST, --destination=DEST 17:50:32 INFO - Directory to install application into. [default: 17:50:32 INFO - "/builds/slave/test"] 17:50:32 INFO - --app=APP Application being installed. [default: firefox] 17:50:32 INFO - mkdir: /builds/slave/test/build/application 17:50:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:50:50 INFO - Reading from file tmpfile_stdout 17:50:50 INFO - Output received: 17:50:50 INFO - /builds/slave/test/build/application/firefox/firefox 17:50:50 INFO - Running post-action listener: _resource_record_post_action 17:50:50 INFO - [mozharness: 2017-09-25 00:50:50.376514Z] Finished install step (success) 17:50:50 INFO - [mozharness: 2017-09-25 00:50:50.376854Z] Running setup-mitmproxy step. 17:50:50 INFO - Running pre-action listener: _resource_record_pre_action 17:50:50 INFO - Running main action method: setup_mitmproxy 17:50:50 INFO - Skipping: mitmproxy is not required 17:50:50 INFO - Running post-action listener: _resource_record_post_action 17:50:50 INFO - [mozharness: 2017-09-25 00:50:50.378578Z] Finished setup-mitmproxy step (success) 17:50:50 INFO - [mozharness: 2017-09-25 00:50:50.378890Z] Running run-tests step. 17:50:50 INFO - Running pre-action listener: _resource_record_pre_action 17:50:50 INFO - Running pre-action listener: _set_gcov_prefix 17:50:50 INFO - Running main action method: run_tests 17:50:50 WARNING - Try message not found. 17:50:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:50:50 INFO - Python 2.7.3 17:50:50 INFO - Return code: 0 17:50:50 INFO - grabbing minidump binary from tooltool 17:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:50 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 0x194dd60>, '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 0x194ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194eef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:50:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:50:50 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:50:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:50:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:50:50 INFO - Return code: 0 17:50:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:50:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:50:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:50:50 INFO - ENV: RUST_BACKTRACE is now full 17:50:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:50:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:50:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:50:50 INFO - Using env: {'DISPLAY': ':0', 17:50:50 INFO - 'HOME': '/home/cltbld', 17:50:50 INFO - 'LANG': 'en_US.UTF-8', 17:50:50 INFO - 'LANGUAGE': 'en_US:en', 17:50:50 INFO - 'LOGNAME': 'cltbld', 17:50:50 INFO - 'MAIL': '/var/mail/cltbld', 17:50:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:50:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:50 INFO - 'MOZ_NO_REMOTE': '1', 17:50:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:50 INFO - 'NO_EM_RESTART': '1', 17:50:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:50 INFO - 'PWD': '/builds/slave/test', 17:50:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:50:50 INFO - 'RUST_BACKTRACE': 'full', 17:50:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:50:50 INFO - 'SHELL': '/bin/bash', 17:50:50 INFO - 'SHLVL': '1', 17:50:50 INFO - 'TERM': 'linux', 17:50:50 INFO - 'TMOUT': '86400', 17:50:50 INFO - 'USER': 'cltbld', 17:50:50 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 17:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:50 INFO - '_': '/tools/buildbot/bin/python'} 17:50:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:50:50 INFO - mozversion application_buildid: 20170924232050 17:50:50 INFO - mozversion application_changeset: 7e962631ba4298bcefa571008661983d77c3e652 17:50:50 INFO - mozversion application_display_name: Nightly 17:50:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:50:50 INFO - mozversion application_name: Firefox 17:50:50 INFO - mozversion application_remotingname: firefox 17:50:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:50:50 INFO - mozversion application_vendor: Mozilla 17:50:50 INFO - mozversion application_version: 58.0a1 17:50:50 INFO - mozversion platform_buildid: 20170924232050 17:50:50 INFO - mozversion platform_changeset: 7e962631ba4298bcefa571008661983d77c3e652 17:50:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:50:50 INFO - mozversion platform_version: 58.0a1 17:50:50 INFO - using testdate: 1506300650 17:50:50 INFO - actual date: 1506300650 17:50:50 INFO - starting webserver on 'localhost:55708' 17:50:50 INFO - SUITE-START | Running 2 tests 17:50:50 INFO - TEST-START | dromaeo_css 17:50:50 INFO - Initialising browser for dromaeo_css test... 17:50:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55708/getInfo.html -profile /tmp/tmpcX_niP/profile 17:50:50 INFO - TEST-INFO | started process 26310 (/builds/slave/test/build/application/firefox/firefox http://localhost:55708/getInfo.html) 17:50:55 INFO - TEST-INFO | 26310: exit 0 17:50:55 INFO - Browser initialized. 17:50:55 INFO - Running cycle 1/1 for dromaeo_css test... 17:50:55 INFO - Using env: {'DISPLAY': ':0', 17:50:55 INFO - 'HOME': '/home/cltbld', 17:50:55 INFO - 'JSGC_DISABLE_POISONING': '1', 17:50:55 INFO - 'LANG': 'en_US.UTF-8', 17:50:55 INFO - 'LANGUAGE': 'en_US:en', 17:50:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:50:55 INFO - 'LOGNAME': 'cltbld', 17:50:55 INFO - 'MAIL': '/var/mail/cltbld', 17:50:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:50:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:50:55 INFO - 'MOZ_CRASHREPORTER': '1', 17:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:50:55 INFO - 'MOZ_NO_REMOTE': '1', 17:50:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:55 INFO - 'NO_EM_RESTART': '1', 17:50:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:55 INFO - 'PWD': '/builds/slave/test', 17:50:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:50:55 INFO - 'RUST_BACKTRACE': 'full', 17:50:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:50:55 INFO - 'SHELL': '/bin/bash', 17:50:55 INFO - 'SHLVL': '1', 17:50:55 INFO - 'TERM': 'linux', 17:50:55 INFO - 'TMOUT': '86400', 17:50:55 INFO - 'USER': 'cltbld', 17:50:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 17:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:55 INFO - '_': '/tools/buildbot/bin/python'} 17:50:55 INFO - TEST-INFO | started process 26544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcX_niP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:50:56 INFO - PID 26544 | 17:50:56 INFO - PID 26544 | (/builds/slave/test/build/application/firefox/firefox:26593): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:50:56 INFO - PID 26544 | 17:51:06 INFO - PID 26544 | RSS: Main: 146898944 17:51:06 INFO - PID 26544 | 17:54:04 INFO - PID 26544 | Cycle 1(1): loaded http://localhost:55708/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55708/tests/dromaeo/cssquery-ext.html) 17:54:05 INFO - PID 26544 | RSS: Main: 147410944 17:54:05 INFO - PID 26544 | 17:57:06 INFO - PID 26544 | Cycle 1(1): loaded http://localhost:55708/tests/dromaeo/cssquery-ext.html (next: http://localhost:55708/tests/dromaeo/cssquery-jquery.html) 17:57:07 INFO - PID 26544 | RSS: Main: 147222528 17:57:07 INFO - PID 26544 | 18:00:09 INFO - PID 26544 | Cycle 1(1): loaded http://localhost:55708/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55708/tests/dromaeo/cssquery-mootools.html) 18:00:09 INFO - PID 26544 | RSS: Main: 149729280 18:00:09 INFO - PID 26544 | 18:03:11 INFO - PID 26544 | Cycle 1(1): loaded http://localhost:55708/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55708/tests/dromaeo/cssquery-prototype.html) 18:03:11 INFO - PID 26544 | RSS: Main: 146116608 18:03:11 INFO - PID 26544 | 18:06:14 INFO - PID 26544 | Cycle 1(1): loaded http://localhost:55708/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55708/tests/dromaeo/cssquery-yui.html) 18:06:15 INFO - PID 26544 | RSS: Main: 149213184 18:06:15 INFO - PID 26544 | 18:09:17 INFO - PID 26544 | Cycle 1(1): loaded http://localhost:55708/tests/dromaeo/cssquery-yui.html (next: http://localhost:55708/tests/dromaeo/cssquery-dojo.html) 18:09:17 INFO - PID 26544 | RSS: Main: 151691264 18:09:17 INFO - PID 26544 | 18:09:17 INFO - PID 26544 | __start_tp_report 18:09:17 INFO - PID 26544 | _x_x_mozilla_page_load 18:09:17 INFO - PID 26544 | _x_x_mozilla_page_load_details 18:09:17 INFO - PID 26544 | |i|pagename|runs| 18:09:17 INFO - PID 26544 | |0;dojo.html;3865.787381694009;3870.980645096775;3872.225554889022;3876.4185372194183;3880.941785873212;6107.083937409391;6196.597221180631;6209.782657606985;6223.813285601428;6330.272018717849;6260.342664020281;6266.968665156668;6271.059341098838;6283.088952101943;6297.464715499188;5513.9448605514035;5581.6371935824245;5599.160125981115;5629.831105066854;5683.374828768853;5573.4147914469;5655.066913959213;5662.037453632893;5681.630694004876;5697;5431.619786614939;5641.12562552805;5709.0009248381575;5720.399358067405;5729.914051289234;5447.1829225616075;5534.75093620788;5579.218909352694;5661.122526008476;5681.261436013292;5562.9443705562835;5578.079616863212;5640.09758438652;5651.124075768263;5658.91511627326;6116.388361163892;6182.041783523561;6188.907166392508;6223.595466294676;6256.249250090018;6684.431823295025;6696;6696.59820410772;6704.7988560343265;6711.094002309675;6753.088333075021;6759;6890.965545172242;6901.861962760717;6925.3074692530845;6284.497240220863;6307.27466341372;6376.139221205124;6391.552591318609;6409.198850143732;6822.624755638389;6951.7219311228;6962.895556566656;7058.294170582901;7059.470539709542;6582.24304205013;6670.566413183127;6732.966335168293;6779.593224406552;6781.050652908597;6712.261651218362;6778.525503214728;6786.3892249697765;6794.218664853506;6802.217744959294;6647.900281495781;6652.467802575782;6680.83297917556;6739.528233023641;6754.864902701918;6662.300458451793;6696.63168525726;6715.127033485615;6722.092517510171;6736.932630673728;4931.334269873593;4995;5013;5016.498350165028;5024.422191447957;4416.823327066945;4431.601155895984;4447.911041779146;4453.4433195850515;4498.572635599613;6244.2819075805955;6244.594101383395;6309.558330916791;6328.367163283635;6343.111964324999;6707.865842683119;6712.630805305657;6727.562708423937;6789.355011273921;6832.897506537406;6017.097435384728;6123.571350005457;6173.074038894202;6174.9073763893575;6301.464375528039;5431.266778984866;5456.127019676833;5456.809011684572;5545.889082218414;5556.055470570012;6940.167179938439;7021.1574611047;7038.190608080034;7052.9647351762915;7062;6623.30455302196;6663.36698013688;6722.19333679942;6732.360425759643;6761.966190169214;6950.200726916267;7013.929860701328;7013.929860701532;7028.648567571703;7109.253528379652;6647.7673281436855;6712.362325579063;6740.831479213059;6748.7300507979135;6749.696263668048;6693.464522838064;6719.160104986877;6728.259891412039;6849.8972515411315;6891.862162756817;6449.903251451326;6543.1821022372205;6578.605283682803;6611.768588099393;6617.900731488935;6569.24453687832;6580.967095164685;6616.933830661825;6655.600663960178;6656.600603963778;6325.841853953688;6472.708728107153;6487.448566871869;6542.443892269211;6572.4084832365315;5869.501092407193;6430.7749228776765;6551.737930482727;6603.273639899511;6612.008198770223;6376.52176086786;6435.388638079375;6450.838729031811;6497.057926600711;6509.902351464637 18:09:17 INFO - PID 26544 | |1;ext.html;946.8911075226347;970.0638883477444;986.9111779939803;990.7424069741865;1004.41241873504;39991.2001759965;40842.7957860211;40847.18305633886;40989.59010409895;41067.58932410675;41800;43004.354934676005;43439.78280108595;43769.562304376945;43863.12273754523;8418.158184181579;8461.576921153948;8540.615672294762;8545.829083418359;8556.78608034801;8308.501489910594;8315.293200077971;8468.153184681543;8476.78808029798;8504.149585041509;8492.320614350838;8507.106753790855;8556.786080347978;8590.699325523608;8599.269062129695;8500;8504.532250726208;8510.957445212796;8536.914630853706;8542.786430339229;8330.791730206793;8350.164983501661;8372.790680232982;8377.24604785566;8390.538520381377;40391;40558.79720601378;40752.59247407547;40804.38793418101;40824.979375515555;3778.074371778904;3812.6377994090517;3820.2359528094216;3822.9426558601645;3839.4816699745456;33110.668893311;33222.33555328904;33244.833775830964;33299.33401331984;33322.666773332196;5253.894922101575;5481.095619222823;5525.392206857243;5552.7223638817895;5664.518515926151;210379;211880;219674;223306;225258.87370563205;53486.73256633692;53839.19241211385;53852.730736346064;53856.46143538593;54229;56173.43826561682;56229.43770562324;56572.15141772877;56660.15009774857;56820.71589642025;15797;15846;15906.681866362607;16054.357825686842;16366.509004729876;13310;13326.800097998537;13327.333633318296;13335.73328533424;13336.133151345131;13840.23878686682;13843.238621875893;13858.4456621734;13937.860621393656;13954.790678139836;5566.832995010156;5572.332685503531;5583.860403489864;5622.662640241599;5644.915326270109;1101.895319944604;1111.5053801058614;1113.6826004588654;1116;1131.0499180688098;25282.620760688606;25331.87334063355;25467.61798573023;25550.872245639024;25731.48537029249;1197.1260979485025;1209.9516019359128;1231.396615658321;1244.3964677131585;1244.440001999104;13581;13581.592552223448;13582.59252222435;13652.24912629815;13786.862131378759;255726;256351;256664;257456;257762;56700;57081;57163.428365716645;57264.427355726744;57323.42676573264;1524.7331716949711;1555.8366371531054;1566.1699299371123;1570.8350623184629;1576.3536949850736;24932.10862619794;25003.87498062498;25018.37454063663;25020.249392518253;25074.24777256685;41618.375724363555;41742.1651566973;41748.79125604353;41762;41881.581184187766;218967;219288;219296;219306;219486;33145;33702;36689;36946.44580331351;37265.62734372621;46457.07085858331;46614.53385466102;46625.300620490045;46658.53341466542;47038.294425584325;34392.48411273883;34563.654363456044;34665.480017800255;34834.129146771535;35215.82392088023;34082.97751067472;34251.82874085614;34372.48441273333;34541.65458345384;34568.65431345755;38640.6135938637;39042.80478597589;39344.60655393409;39615.603843962344;39725;33170.33659326848;33196.33607327888;33313.500297496044;33466.33067338688;33474;24816.255512334657;25005.74994250107;25267.62098568486;25302;25531.87234063892 18:09:17 INFO - PID 26544 | |2;jquery.html;608.3277977834492;611.7950486586993;612.3019757476476;614.3457218062765;615.1756646094233;22836.77163228367;23911.163109291178;23941.64087538686;23987.400314992134;23988.76011239887;24932.501349973034;26505.602415963775;26774;26811.597826032576;26836.865815670895;6501.349865013496;6717.462602991749;6723.562968407063;6725.05849181115;6733;6524.575902566342;6721.596704197739;6808.965955170242;6812.659367031629;6822.283660215656;6748.730050797963;6761.121054262939;6772.796816095525;6774.153230846145;6775.830604234909;6540.215174179105;6766.15423072116;6779.932200678004;6790.947403152494;6800.421964133055;6310.085037669558;6321.810345689637;6336.493080553545;6345.6827158642345;6363.649999250039;30252.54621180684;30905.381892362253;30922.53616195759;30965.845170774228;30967.845160774275;2255.3684968208927;2293.759155288704;2302.056156975632;2310.2491690200586;2312.1560630369963;20267;20780.272690455913;20910.163593456396;20984.790152098438;21022.684659730116;2518.1312447205682;2526.2168727694475;2599.636050952868;2600.557905156109;2616.2020583721956;131887.34056329753;135895;139090;139169;142431;15756.448524301595;16204.75692864608;16237.51287461378;16724.83275167257;17027.744583831252;25363.746362536138;25370.492590148464;25392.111276105617;25515.36211594725;25527.234182974542;10729.517171727135;10854.837177442345;11006.119510439146;11024.889751102546;11082.279651822606;9877.506124693737;9928.652497162564;9951.21562296001;9979.401235925867;10052.396856188652;9606.66376676813;9970.40177589347;10111.292209545261;10175.236857235588;10332.328398654214;2771.4041481081663;2803.2711495011035;2880.971190288112;2908.9127326180246;2975.5090410082094;1048.6277371532997;1048.8059708953867;1050.3120456101112;1057.9100776433936;1075.2741899217997;21040.15839366408;21855.453613659785;21932.89033554822;21958.560828783335;22026.242632048987;1106.7011906785124;1107.399807278491;1114.9442527873573;1121.3835380896705;1129.13056946151;12033.278003319829;12045.63863084109;12076.215046022156;12185.634430967086;12274.754504909852;586566;594334;599798;603633;617833;119306.4034679821;122267;123166.38416808037;123637;124339.37830310971;1134.313740187175;1163.3892206591606;1223.62067758995;1231.310466138947;1268.7399083187925;22771;23300.53398932046;23426.88286558556;23468.178613748438;23615.40961475977;59112.40887591241;59549.106763397715;60119.39880601138;60405.0939235903;61903.452413690015;73347.26652733404;73393.6330318345;73921.26078739359;73972;74367.25632743603;15877.603059923595;15998.120103394425;16202;16214.35142594283;16332.101734404247;24948;25263.74736252614;25459.2362229126;25477.745222548278;25531.23406297814;20131.899340503205;20226.49433764109;20243.291484797963;20346.389608311776;20445.59108817845;17799.555011124827;17925.731114033562;18448.07759611987;18702;18910.621787563898;20852.895735521226;21003.894980525;21184.682229766873;21462.14151433925;21534.353969380943;16046.598835029217;16054.518364449084;16108.838911611203;16128.838711612734;16150.273237704096;20067.598648026666;20349.694754578988;20401.59196816085;20532.692009619568;20709.792902070785 18:09:17 INFO - PID 26544 | |3;mootools.html;1406.4655430936245;1477.128494188429;1489.337244926007;1509.3283488847467;1512.206091801804;17609.7358539622;18135.90932045338;18164;18172.545686357847;18173;17729;17770;17814.732779008325;17817.91091044543;17857.285708571642;2733.562629979204;2795.371041515663;2836.276749428893;2838.7303206195484;2848.2025032990796;2720.07517444069;2741.0817376179;2743.9451210975767;2752.1055656911585;2757.986210068947;2717.9320516987036;2812.8452935088562;2816.1270006298114;2816.521191397457;2816.943661126776;2759.613654088429;2777.125205560252;2784.7354501322343;2788.4004938938124;2802.369466869958;2686.1807148819603;2730.4675588260297;2737.9589306160424;2738.4796888591304;2752.724727527251;16295;16761.078140702255;16774.07742574158;16779.91610041942;16792.160391980473;8345.624446899843;8583.270422014137;8584.31325493959;8586.527740974245;8591.785205369915;5404.864878378072;5470.753816078286;5569.303837020372;5573.916391254134;5651.18057881609;2110.799474049978;2125.8086772190577;2136.4872430616697;2156.2022051840763;2162.708034415365;29963.40073198524;30271;30287.394252115053;30319.393612127853;30472.542911856563;7338.4496162788;7433.925660743432;7500.924990750132;7514.9479072929835;7634.503757255871;19384.612307753767;19456;19478;19494.610107797766;19496.512587185432;8419.115992820789;8671.869921951176;8689.913760779902;8690.91309086901;8693.956530217309;7748.225177482207;7849.097353804272;7885.014373203349;7892.565908874953;8008.959955200186;5469.425710300441;5655.321361436654;5670.659760414306;5718.828435146869;5725.885482290414;1550.4418409372618;1551.4880089570415;1556.3463345394734;1561.8125824901085;1574.0791636892545;972.7033254857337;985.5762022330323;993.3195760903805;1008.9495525223709;1017.2065788684838;8367.539785311745;8554.144585541397;8568.528730919734;8683.175098365646;8717.041125476193;787.1737568840235;811.4563242627454;812.975610731679;819.9016118065751;827.420805436197;5259.815906443256;5895.145203945404;6051.788187413419;6095.6952152392205;6282.931901576651;24003.759962400152;25048.123315683864;25515.617265741028;25525;25532.617010744852;23666.408339791644;24808.379790505383;24880.129195478432;24918.12786552498;25031.749682503305;11288.435578221057;12627;12653.746925061447;12688.619341419771;12869.806952895715;8700.738977830675;9903.712517372696;10035;10083.697489075339;10217.438040907822;19800.801991980472;20102.698459522828;20177.293794717116;20365.49086272855;20761.169553218308;21258.893705531373;21275.787242127382;22142.778572214072;22426.66360004634;22478.775212247667;12430.440630171845;12448.25310481374;12469.875301246871;12497.375131243583;12600.621981340575;15241.3903443861;15457.381704731684;15460.768088478906;15468.92265538665;15471.767923481382;11959.940200298943;12012.459439325427;12134.393280336124;12162.452689628812;12213.14507984468;12165.45255463524;12293.692657683629;12336.876631233932;12583.05627077991;12668.619941401772;10450.581976720847;10586.629467968583;10791.244612877023;10807.189460790314;10817;7901.604919754104;7953.2842044216295;7983.680652773824;8181.222783835526;8190;8124.187581241828;8162.469439486415;8178.550179740171;8206.05630352517;8207.95896020516 18:09:17 INFO - PID 26544 | |4;prototype.html;568.1988396361131;573.8364566098662;578.7308901360872;580.7415700013495;590.2238556298468;6159.260888693363;6173.320934697191;6250.531210159244;6263.592866463677;6312.274088479826;6131.509479241661;6145.47763440107;6194.256689197303;6194.969025154879;6206.6586337751405;5029.0696221199105;5081.720505372203;5088.643794934356;5107.361579802525;5118.564921981636;4827.56551910328;4949.727764972925;5033.647644664875;5089.46560611136;5120.257562653413;4899.559039686427;4902.65681402302;4903.901921961558;4905.650945989845;4939.3084968104495;4955.554000140005;4972.925406118911;4976.178930476467;4984.999999999982;4992.251162325644;4408.162449134654;4496.168208881368;4512.796924138422;4522.140793249272;4526.932096018562;5998.910016349758;6020.638761674313;6106.442857071418;6137.11011903276;6156.230471191101;5816.243888294537;5817.767289308423;5819.730305180983;5858.56060795442;5858.912116318259;6623.205215374138;6628;6643.5017373697165;6659.101021362151;6669.833254168636;4890.554722638681;5089.8727531812;5094.61790365724;5096.566791822699;5097.5667068299235;6609.801705948829;6776.627285499296;6804.829879253009;6808.557443766189;6858.417034552069;5120.028788916219;5121.411037730709;5133.844884900867;5196.220566914917;5199.896002079937;5193.714345711022;5233.031889100528;5234.2933703949475;5242.7640756166065;5259.815906443256;5730.140478928194;5739.540836733051;5750.6837123958585;5767.826965191051;5832.533397328203;6534.183227096613;6601;6625.569337993112;6646.966765166143;6707.128073350434;1793.2020250988446;1795.4828170196163;1813.2475022865626;1816.7365731968791;1823.927042918295;1228.2016689152122;1274.7386785709093;1284.2551320234243;1306.3664122900386;1308.4373719300602;6101.359357267512;6123.234595675541;6152.107944348045;6171.7531298748445;6190.628562286277;6411.006294024433;6585.769498067544;6624.569402988886;6689.431398331099;6743.35938085881;5986.431289027535;6111.8523960160555;6136.938630613726;6153.446189842846;6173.660448675276;3537.3809583322814;3556.182078121995;3569.196930690574;3571.910702232413;3574.1422058705725;6836.589804611739;6838.111045564145;6875.209350924708;6897.241303456616;6916.757913473105;6481.967590162019;6691.464682825363;6711.261761206263;6717.899231511531;6781.152355955505;6822.522423430312;6841.965790170918;6900.689468973908;6907.447404207652;6913.896291555731;6448.258450278278;6508.544401892012;6570.507211959027;6571.474282057328;6592.604443733391;6495.895697731492;6568.080468734476;6648.9002664961035;6668.766593169215;6677.666116694243;6737.258901520927;6785.762498312535;6810.727570897307;6859.314068593101;6997.4052205561065;5112.258722485293;5128.769205385692;5150.227465880148;5163.27714120016;5191.636585439134;6518.511111666549;6549.836254093686;6586.769463068769;6599.868002639824;6615.4376877965915;6279.2464904209955;6451.1936007999;6485.513586481127;6512.934870651422;6533.314002029719;6385.776497822554;6399.936000639934;6481.578697384655;6507.349265073455;6528.738850446119;6272.372762723874;6289.559730818799;6367.968160159169;6386.361363863763;6401.591649837029;6464.612123272619;6477.643729594729;6513.804585862432;6545.967270163809;6577.270432770347;6271.96864015677;6345;6371.13989611415;6401.967990160019;6417.26201486835 18:09:17 INFO - PID 26544 | |5;yui.html;937.5546615357702;967.9080487353701;977.096186027924;988.1650005745147;992.5930368548894;20554;21073.26243581473;21197.258095966627;21216.681749773765;21276.787232127674;18765.812341876575;18880.527986800338;19335.323263685776;19749.605007899834;19921.900390498064;1017.0236572890016;1044.3316277582353;1044.3733759744168;1044.597829835515;1044.6082718980383;1023.8668973033532;1024.08856118055;1026.071405378134;1026.702256345659;1059.4384975962714;1117.8155604325277;1120.8318752187197;1121.3328069798456;1122.831575263713;1126.9969726943027;1029.2177944761997;1069.4652673663168;1069.9411532365716;1099.7360633447954;1107.9861926337392;771.2595907928395;773.8374941262342;775.5811861594789;777.2848978939389;779.3142035009156;19114.139863706027;19162.233510659556;19196.232150713953;19207.80792192088;19273.4217973461;23166.53666926669;23329.88335058331;23730.288091357288;23756.04975800966;23802.523949521084;18701.438956831316;19060.237590496363;19103.61792764151;19269.710954335696;19337.709934350994;4009.8596549120934;4020.075382662004;4024.5371782245124;4031.8992025199314;4047.190561887605;156508;157415.2129239358;157966;159326;160445;17531.123443827757;17709;17962;18068.18693158811;18129;32858.34283314368;33610;33934.49098263528;34539.654603453644;34566.30867382688;9052;9201.861972070425;9202.539873006323;9205.03347148553;9206.723798286062;4371.278739008092;4570.177368073712;4635.490096089427;4667.393238878992;4668.5564871337165;5873.324567674772;6044.365341639064;6059.1820104286235;6084.361142080018;6086.056661217518;1028.2339656955617;1049.4805071489661;1056.0390045059114;1060.0459586372172;1071.212658695858;724.7499612633633;732.1177980533445;737.3990197988622;748.9176190619028;754.1704125462057;11494.13793965456;11700.531978720755;12059;12657.81013284783;12903.677408064874;703.7431337561856;704.3871831506622;710.6233696141054;722.299369611476;730.2113717185428;5911.527077833763;5948.078047902582;6065;6106.114613381035;6196.566240363221;150869;152025;153637;154345;158065;126002.36998814947;127401.3629931863;127768;128491;131228.3438582801;116099.8390016089;116110.41944790391;117176;117608;119627;11170.441477926233;11188.66434006981;11257.887421125684;11581.82627260575;11717.707057323294;52951.47048529465;54277.72861135669;55238.89522209614;55275.44724552703;56863.147052793414;70903;72071;72759.63620181865;72791;73711.26288737044;16448.095354755602;16544.50366489007;16588.917055415128;16715;16744.246508906886;17773.644527109645;17870.46388608344;17965;18048.097595120453;18054.187561559498;16570.502884913472;16680;16699.246579109018;16800;16949.57626059309;15165.772513412528;15381;15413.845861541242;15467.767983480031;15491.84508154949;16273.349066037226;16500;16681;16708.41520546775;16810.915945420194;12567.554731205662;12699.111062225555;12816.102872799187;12985.155964862253;13048.217106973612;11854.110941679237;11916.702082448008;11943.343116128348;12030.699232519257;12068.879311206776 18:09:17 INFO - PID 26544 | __end_tp_report 18:09:17 INFO - PID 26544 | __start_cc_report 18:09:17 INFO - PID 26544 | _x_x_mozilla_cycle_collect,272 18:09:17 INFO - PID 26544 | __end_cc_report 18:09:17 INFO - PID 26544 | __startTimestamp1506301757250__endTimestamp 18:09:17 INFO - PID 26544 | 18:09:17 INFO - PID 26544 | ------- Summary: start ------- 18:09:17 INFO - PID 26544 | Number of tests: 6 18:09:17 INFO - PID 26544 | 18:09:17 INFO - PID 26544 | [#0] dojo.html Cycles:165 Average:6221.81 Median:6472.71 stddev:734.24 (11.3%) stddev-sans-first:712.85 18:09:17 INFO - PID 26544 | Values: 3865.8 3871.0 3872.2 3876.4 3880.9 6107.1 6196.6 6209.8 6223.8 6330.3 6260.3 6267.0 6271.1 6283.1 6297.5 5513.9 5581.6 5599.2 5629.8 5683.4 5573.4 5655.1 5662.0 5681.6 5697.0 5431.6 5641.1 5709.0 5720.4 5729.9 5447.2 5534.8 5579.2 5661.1 5681.3 5562.9 5578.1 5640.1 5651.1 5658.9 6116.4 6182.0 6188.9 6223.6 6256.2 6684.4 6696.0 6696.6 6704.8 6711.1 6753.1 6759.0 6891.0 6901.9 6925.3 6284.5 6307.3 6376.1 6391.6 6409.2 6822.6 6951.7 6962.9 7058.3 7059.5 6582.2 6670.6 6733.0 6779.6 6781.1 6712.3 6778.5 6786.4 6794.2 6802.2 6647.9 6652.5 6680.8 6739.5 6754.9 6662.3 6696.6 6715.1 6722.1 6736.9 4931.3 4995.0 5013.0 5016.5 5024.4 4416.8 4431.6 4447.9 4453.4 4498.6 6244.3 6244.6 6309.6 6328.4 6343.1 6707.9 6712.6 6727.6 6789.4 6832.9 6017.1 6123.6 6173.1 6174.9 6301.5 5431.3 5456.1 5456.8 5545.9 5556.1 6940.2 7021.2 7038.2 7053.0 7062.0 6623.3 6663.4 6722.2 6732.4 6762.0 6950.2 7013.9 7013.9 7028.6 7109.3 6647.8 6712.4 6740.8 6748.7 6749.7 6693.5 6719.2 6728.3 6849.9 6891.9 6449.9 6543.2 6578.6 6611.8 6617.9 6569.2 6581.0 6616.9 6655.6 6656.6 6325.8 6472.7 6487.4 6542.4 6572.4 5869.5 6430.8 6551.7 6603.3 6612.0 6376.5 6435.4 6450.8 6497.1 6509.9 18:09:17 INFO - PID 26544 | 18:09:17 INFO - PID 26544 | [#1] ext.html Cycles:180 Average:41104.61 Median:20521.85 stddev:60220.13 (293.4%) stddev-sans-first:60313.57 18:09:17 INFO - PID 26544 | Values: 946.9 970.1 986.9 990.7 1004.4 39991.2 40842.8 40847.2 40989.6 41067.6 41800.0 43004.4 43439.8 43769.6 43863.1 8418.2 8461.6 8540.6 8545.8 8556.8 8308.5 8315.3 8468.2 8476.8 8504.1 8492.3 8507.1 8556.8 8590.7 8599.3 8500.0 8504.5 8511.0 8536.9 8542.8 8330.8 8350.2 8372.8 8377.2 8390.5 40391.0 40558.8 40752.6 40804.4 40825.0 3778.1 3812.6 3820.2 3822.9 3839.5 33110.7 33222.3 33244.8 33299.3 33322.7 5253.9 5481.1 5525.4 5552.7 5664.5 210379.0 211880.0 219674.0 223306.0 225258.9 53486.7 53839.2 53852.7 53856.5 54229.0 56173.4 56229.4 56572.2 56660.2 56820.7 15797.0 15846.0 15906.7 16054.4 16366.5 13310.0 13326.8 13327.3 13335.7 13336.1 13840.2 13843.2 13858.4 13937.9 13954.8 5566.8 5572.3 5583.9 5622.7 5644.9 1101.9 1111.5 1113.7 1116.0 1131.0 25282.6 25331.9 25467.6 25550.9 25731.5 1197.1 1210.0 1231.4 1244.4 1244.4 13581.0 13581.6 13582.6 13652.2 13786.9 255726.0 256351.0 256664.0 257456.0 257762.0 56700.0 57081.0 57163.4 57264.4 57323.4 1524.7 1555.8 1566.2 1570.8 1576.4 24932.1 25003.9 25018.4 25020.2 25074.2 41618.4 41742.2 41748.8 41762.0 41881.6 218967.0 219288.0 219296.0 219306.0 219486.0 33145.0 33702.0 36689.0 36946.4 37265.6 46457.1 46614.5 46625.3 46658.5 47038.3 34392.5 34563.7 34665.5 34834.1 35215.8 34083.0 34251.8 34372.5 34541.7 34568.7 38640.6 39042.8 39344.6 39615.6 39725.0 33170.3 33196.3 33313.5 33466.3 33474.0 24816.3 25005.7 25267.6 25302.0 25531.9 18:09:17 INFO - PID 26544 | 18:09:17 INFO - PID 26544 | [#2] jquery.html Cycles:180 Average:39142.95 Median:12806.35 stddev:99804.07 (779.3%) stddev-sans-first:100042.11 18:09:17 INFO - PID 26544 | Values: 608.3 611.8 612.3 614.3 615.2 22836.8 23911.2 23941.6 23987.4 23988.8 24932.5 26505.6 26774.0 26811.6 26836.9 6501.3 6717.5 6723.6 6725.1 6733.0 6524.6 6721.6 6809.0 6812.7 6822.3 6748.7 6761.1 6772.8 6774.2 6775.8 6540.2 6766.2 6779.9 6790.9 6800.4 6310.1 6321.8 6336.5 6345.7 6363.6 30252.5 30905.4 30922.5 30965.8 30967.8 2255.4 2293.8 2302.1 2310.2 2312.2 20267.0 20780.3 20910.2 20984.8 21022.7 2518.1 2526.2 2599.6 2600.6 2616.2 131887.3 135895.0 139090.0 139169.0 142431.0 15756.4 16204.8 16237.5 16724.8 17027.7 25363.7 25370.5 25392.1 25515.4 25527.2 10729.5 10854.8 11006.1 11024.9 11082.3 9877.5 9928.7 9951.2 9979.4 10052.4 9606.7 9970.4 10111.3 10175.2 10332.3 2771.4 2803.3 2881.0 2908.9 2975.5 1048.6 1048.8 1050.3 1057.9 1075.3 21040.2 21855.5 21932.9 21958.6 22026.2 1106.7 1107.4 1114.9 1121.4 1129.1 12033.3 12045.6 12076.2 12185.6 12274.8 586566.0 594334.0 599798.0 603633.0 617833.0 119306.4 122267.0 123166.4 123637.0 124339.4 1134.3 1163.4 1223.6 1231.3 1268.7 22771.0 23300.5 23426.9 23468.2 23615.4 59112.4 59549.1 60119.4 60405.1 61903.5 73347.3 73393.6 73921.3 73972.0 74367.3 15877.6 15998.1 16202.0 16214.4 16332.1 24948.0 25263.7 25459.2 25477.7 25531.2 20131.9 20226.5 20243.3 20346.4 20445.6 17799.6 17925.7 18448.1 18702.0 18910.6 20852.9 21003.9 21184.7 21462.1 21534.4 16046.6 16054.5 16108.8 16128.8 16150.3 20067.6 20349.7 20401.6 20532.7 20709.8 18:09:17 INFO - PID 26544 | 18:09:17 INFO - PID 26544 | [#3] mootools.html Cycles:180 Average:10410.83 Median:2702.06 stddev:7697.25 (284.9%) stddev-sans-first:7689.11 18:09:17 INFO - PID 26544 | Values: 1406.5 1477.1 1489.3 1509.3 1512.2 17609.7 18135.9 18164.0 18172.5 18173.0 17729.0 17770.0 17814.7 17817.9 17857.3 2733.6 2795.4 2836.3 2838.7 2848.2 2720.1 2741.1 2743.9 2752.1 2758.0 2717.9 2812.8 2816.1 2816.5 2816.9 2759.6 2777.1 2784.7 2788.4 2802.4 2686.2 2730.5 2738.0 2738.5 2752.7 16295.0 16761.1 16774.1 16779.9 16792.2 8345.6 8583.3 8584.3 8586.5 8591.8 5404.9 5470.8 5569.3 5573.9 5651.2 2110.8 2125.8 2136.5 2156.2 2162.7 29963.4 30271.0 30287.4 30319.4 30472.5 7338.4 7433.9 7500.9 7514.9 7634.5 19384.6 19456.0 19478.0 19494.6 19496.5 8419.1 8671.9 8689.9 8690.9 8694.0 7748.2 7849.1 7885.0 7892.6 8009.0 5469.4 5655.3 5670.7 5718.8 5725.9 1550.4 1551.5 1556.3 1561.8 1574.1 972.7 985.6 993.3 1008.9 1017.2 8367.5 8554.1 8568.5 8683.2 8717.0 787.2 811.5 813.0 819.9 827.4 5259.8 5895.1 6051.8 6095.7 6282.9 24003.8 25048.1 25515.6 25525.0 25532.6 23666.4 24808.4 24880.1 24918.1 25031.7 11288.4 12627.0 12653.7 12688.6 12869.8 8700.7 9903.7 10035.0 10083.7 10217.4 19800.8 20102.7 20177.3 20365.5 20761.2 21258.9 21275.8 22142.8 22426.7 22478.8 12430.4 12448.3 12469.9 12497.4 12600.6 15241.4 15457.4 15460.8 15468.9 15471.8 11959.9 12012.5 12134.4 12162.5 12213.1 12165.5 12293.7 12336.9 12583.1 12668.6 10450.6 10586.6 10791.2 10807.2 10817.0 7901.6 7953.3 7983.7 8181.2 8190.0 8124.2 8162.5 8178.6 8206.1 8208.0 18:09:17 INFO - PID 26544 | 18:09:17 INFO - PID 26544 | [#4] prototype.html Cycles:180 Average:5566.96 Median:6172.54 stddev:1535.43 (24.9%) stddev-sans-first:1493.19 18:09:17 INFO - PID 26544 | Values: 568.2 573.8 578.7 580.7 590.2 6159.3 6173.3 6250.5 6263.6 6312.3 6131.5 6145.5 6194.3 6195.0 6206.7 5029.1 5081.7 5088.6 5107.4 5118.6 4827.6 4949.7 5033.6 5089.5 5120.3 4899.6 4902.7 4903.9 4905.7 4939.3 4955.6 4972.9 4976.2 4985.0 4992.3 4408.2 4496.2 4512.8 4522.1 4526.9 5998.9 6020.6 6106.4 6137.1 6156.2 5816.2 5817.8 5819.7 5858.6 5858.9 6623.2 6628.0 6643.5 6659.1 6669.8 4890.6 5089.9 5094.6 5096.6 5097.6 6609.8 6776.6 6804.8 6808.6 6858.4 5120.0 5121.4 5133.8 5196.2 5199.9 5193.7 5233.0 5234.3 5242.8 5259.8 5730.1 5739.5 5750.7 5767.8 5832.5 6534.2 6601.0 6625.6 6647.0 6707.1 1793.2 1795.5 1813.2 1816.7 1823.9 1228.2 1274.7 1284.3 1306.4 1308.4 6101.4 6123.2 6152.1 6171.8 6190.6 6411.0 6585.8 6624.6 6689.4 6743.4 5986.4 6111.9 6136.9 6153.4 6173.7 3537.4 3556.2 3569.2 3571.9 3574.1 6836.6 6838.1 6875.2 6897.2 6916.8 6482.0 6691.5 6711.3 6717.9 6781.2 6822.5 6842.0 6900.7 6907.4 6913.9 6448.3 6508.5 6570.5 6571.5 6592.6 6495.9 6568.1 6648.9 6668.8 6677.7 6737.3 6785.8 6810.7 6859.3 6997.4 5112.3 5128.8 5150.2 5163.3 5191.6 6518.5 6549.8 6586.8 6599.9 6615.4 6279.2 6451.2 6485.5 6512.9 6533.3 6385.8 6399.9 6481.6 6507.3 6528.7 6272.4 6289.6 6368.0 6386.4 6401.6 6464.6 6477.6 6513.8 6546.0 6577.3 6272.0 6345.0 6371.1 6402.0 6417.3 18:09:17 INFO - PID 26544 | 18:09:17 INFO - PID 26544 | [#5] yui.html Cycles:180 Average:28027.55 Median:18006.55 stddev:42501.47 (236.0%) stddev-sans-first:42572.03 18:09:17 INFO - PID 26544 | Values: 937.6 967.9 977.1 988.2 992.6 20554.0 21073.3 21197.3 21216.7 21276.8 18765.8 18880.5 19335.3 19749.6 19921.9 1017.0 1044.3 1044.4 1044.6 1044.6 1023.9 1024.1 1026.1 1026.7 1059.4 1117.8 1120.8 1121.3 1122.8 1127.0 1029.2 1069.5 1069.9 1099.7 1108.0 771.3 773.8 775.6 777.3 779.3 19114.1 19162.2 19196.2 19207.8 19273.4 23166.5 23329.9 23730.3 23756.0 23802.5 18701.4 19060.2 19103.6 19269.7 19337.7 4009.9 4020.1 4024.5 4031.9 4047.2 156508.0 157415.2 157966.0 159326.0 160445.0 17531.1 17709.0 17962.0 18068.2 18129.0 32858.3 33610.0 33934.5 34539.7 34566.3 9052.0 9201.9 9202.5 9205.0 9206.7 4371.3 4570.2 4635.5 4667.4 4668.6 5873.3 6044.4 6059.2 6084.4 6086.1 1028.2 1049.5 1056.0 1060.0 1071.2 724.7 732.1 737.4 748.9 754.2 11494.1 11700.5 12059.0 12657.8 12903.7 703.7 704.4 710.6 722.3 730.2 5911.5 5948.1 6065.0 6106.1 6196.6 150869.0 152025.0 153637.0 154345.0 158065.0 126002.4 127401.4 127768.0 128491.0 131228.3 116099.8 116110.4 117176.0 117608.0 119627.0 11170.4 11188.7 11257.9 11581.8 11717.7 52951.5 54277.7 55238.9 55275.4 56863.1 70903.0 72071.0 72759.6 72791.0 73711.3 16448.1 16544.5 16588.9 16715.0 16744.2 17773.6 17870.5 17965.0 18048.1 18054.2 16570.5 16680.0 16699.2 16800.0 16949.6 15165.8 15381.0 15413.8 15467.8 15491.8 16273.3 16500.0 16681.0 16708.4 16810.9 12567.6 12699.1 12816.1 12985.2 13048.2 11854.1 11916.7 11943.3 12030.7 12068.9 18:09:17 INFO - PID 26544 | -------- Summary: end -------- 18:09:17 INFO - PID 26544 | 18:09:17 INFO - TEST-INFO | 26544: exit 0 18:09:17 INFO - TEST-OK | dromaeo_css | took 1107120ms 18:09:17 INFO - TEST-START | kraken 18:09:17 INFO - Initialising browser for kraken test... 18:09:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55708/getInfo.html -profile /tmp/tmpDdYyLj/profile 18:09:17 INFO - TEST-INFO | started process 26915 (/builds/slave/test/build/application/firefox/firefox http://localhost:55708/getInfo.html) 18:09:22 INFO - TEST-INFO | 26915: exit 0 18:09:22 INFO - Browser initialized. 18:09:22 INFO - Running cycle 1/1 for kraken test... 18:09:22 INFO - Using env: {'DISPLAY': ':0', 18:09:22 INFO - 'HOME': '/home/cltbld', 18:09:22 INFO - 'JSGC_DISABLE_POISONING': '1', 18:09:22 INFO - 'LANG': 'en_US.UTF-8', 18:09:22 INFO - 'LANGUAGE': 'en_US:en', 18:09:22 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:09:22 INFO - 'LOGNAME': 'cltbld', 18:09:22 INFO - 'MAIL': '/var/mail/cltbld', 18:09:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:09:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:09:22 INFO - 'MOZ_CRASHREPORTER': '1', 18:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:22 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:09:22 INFO - 'MOZ_NO_REMOTE': '1', 18:09:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:22 INFO - 'NO_EM_RESTART': '1', 18:09:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:22 INFO - 'PWD': '/builds/slave/test', 18:09:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:09:22 INFO - 'RUST_BACKTRACE': 'full', 18:09:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:09:22 INFO - 'SHELL': '/bin/bash', 18:09:22 INFO - 'SHLVL': '1', 18:09:22 INFO - 'TERM': 'linux', 18:09:22 INFO - 'TMOUT': '86400', 18:09:22 INFO - 'USER': 'cltbld', 18:09:22 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854', 18:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:22 INFO - '_': '/tools/buildbot/bin/python'} 18:09:22 INFO - TEST-INFO | started process 27156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDdYyLj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:09:23 INFO - PID 27156 | 18:09:23 INFO - PID 27156 | (/builds/slave/test/build/application/firefox/firefox:27207): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:09:23 INFO - PID 27156 | 18:09:34 INFO - PID 27156 | RSS: Main: 145420288 18:09:34 INFO - PID 27156 | 18:09:36 INFO - PID 27156 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55708/tests/kraken/driver.html?testName=audio-beat-detection) 18:09:37 INFO - PID 27156 | RSS: Main: 152580096 18:09:37 INFO - PID 27156 | 18:09:40 INFO - PID 27156 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55708/tests/kraken/driver.html?testName=audio-dft) 18:09:40 INFO - PID 27156 | RSS: Main: 152997888 18:09:40 INFO - PID 27156 | 18:09:43 INFO - PID 27156 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55708/tests/kraken/driver.html?testName=audio-fft) 18:09:44 INFO - PID 27156 | RSS: Main: 148037632 18:09:44 INFO - PID 27156 | 18:09:46 INFO - PID 27156 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55708/tests/kraken/driver.html?testName=audio-oscillator) 18:09:46 INFO - PID 27156 | RSS: Main: 149164032 18:09:46 INFO - PID 27156 | 18:09:48 INFO - PID 27156 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55708/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:09:49 INFO - PID 27156 | RSS: Main: 149082112 18:09:49 INFO - PID 27156 | 18:09:52 INFO - PID 27156 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55708/tests/kraken/driver.html?testName=imaging-darkroom) 18:09:53 INFO - PID 27156 | RSS: Main: 149114880 18:09:53 INFO - PID 27156 | 18:09:56 INFO - PID 27156 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55708/tests/kraken/driver.html?testName=imaging-desaturate) 18:09:57 INFO - PID 27156 | RSS: Main: 150511616 18:09:57 INFO - PID 27156 | 18:10:00 INFO - PID 27156 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55708/tests/kraken/driver.html?testName=json-parse-financial) 18:10:00 INFO - PID 27156 | RSS: Main: 151990272 18:10:00 INFO - PID 27156 | 18:10:02 INFO - PID 27156 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55708/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:10:02 INFO - PID 27156 | RSS: Main: 151986176 18:10:02 INFO - PID 27156 | 18:10:04 INFO - PID 27156 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55708/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:10:05 INFO - PID 27156 | RSS: Main: 151916544 18:10:05 INFO - PID 27156 | 18:10:07 INFO - PID 27156 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55708/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:10:07 INFO - PID 27156 | RSS: Main: 148660224 18:10:07 INFO - PID 27156 | 18:10:10 INFO - PID 27156 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55708/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:10:10 INFO - PID 27156 | RSS: Main: 148430848 18:10:10 INFO - PID 27156 | 18:10:13 INFO - PID 27156 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55708/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:10:14 INFO - PID 27156 | RSS: Main: 149172224 18:10:14 INFO - PID 27156 | 18:10:15 INFO - PID 27156 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55708/tests/kraken/driver.html?testName=ai-astar) 18:10:16 INFO - PID 27156 | RSS: Main: 150925312 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | __start_tp_report 18:10:16 INFO - PID 27156 | _x_x_mozilla_page_load 18:10:16 INFO - PID 27156 | _x_x_mozilla_page_load_details 18:10:16 INFO - PID 27156 | |i|pagename|runs| 18:10:16 INFO - PID 27156 | |0;ai-astar;104;105;105;105;105;110;107;106;105;106 18:10:16 INFO - PID 27156 | |1;audio-beat-detection;113;115;121;116;112;112;113;111;122;114 18:10:16 INFO - PID 27156 | |2;audio-dft;163;162;165;162;160;162;162;163;164;165 18:10:16 INFO - PID 27156 | |3;audio-fft;74;78;73;74;74;74;74;75;74;73 18:10:16 INFO - PID 27156 | |4;audio-oscillator;78;79;79;84;80;83;81;81;78;77 18:10:16 INFO - PID 27156 | |5;imaging-gaussian-blur;113;114;114;113;115;114;114;114;114;115 18:10:16 INFO - PID 27156 | |6;imaging-darkroom;150;151;151;152;153;151;150;151;152;150 18:10:16 INFO - PID 27156 | |7;imaging-desaturate;96;94;95;94;94;94;94;95;94;95 18:10:16 INFO - PID 27156 | |8;json-parse-financial;44;45;44;47;45;45;44;45;43;43 18:10:16 INFO - PID 27156 | |9;json-stringify-tinderbox;36;37;37;37;37;37;37;37;37;37 18:10:16 INFO - PID 27156 | |10;stanford-crypto-aes;73;75;72;70;71;71;73;71;75;73 18:10:16 INFO - PID 27156 | |11;stanford-crypto-ccm;110;104;110;112;110;108;110;112;111;104 18:10:16 INFO - PID 27156 | |12;stanford-crypto-pbkdf2;155;151;152;153;152;150;166;151;151;157 18:10:16 INFO - PID 27156 | |13;stanford-crypto-sha256-iterative;69;63;59;60;60;61;64;64;61;62 18:10:16 INFO - PID 27156 | __end_tp_report 18:10:16 INFO - PID 27156 | __start_cc_report 18:10:16 INFO - PID 27156 | _x_x_mozilla_cycle_collect,715 18:10:16 INFO - PID 27156 | __end_cc_report 18:10:16 INFO - PID 27156 | __startTimestamp1506301816126__endTimestamp 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | ------- Summary: start ------- 18:10:16 INFO - PID 27156 | Number of tests: 14 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | [#0] ai-astar Cycles:10 Average:105.80 Median:105.50 stddev:1.69 (1.6%) stddev-sans-first:1.66 18:10:16 INFO - PID 27156 | Values: 104.0 105.0 105.0 105.0 105.0 110.0 107.0 106.0 105.0 106.0 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | [#1] audio-beat-detection Cycles:10 Average:114.90 Median:114.50 stddev:3.78 (3.3%) stddev-sans-first:3.95 18:10:16 INFO - PID 27156 | Values: 113.0 115.0 121.0 116.0 112.0 112.0 113.0 111.0 122.0 114.0 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.55 (1.0%) stddev-sans-first:1.64 18:10:16 INFO - PID 27156 | Values: 163.0 162.0 165.0 162.0 160.0 162.0 162.0 163.0 164.0 165.0 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | [#3] audio-fft Cycles:10 Average:74.30 Median:74.00 stddev:1.42 (1.9%) stddev-sans-first:1.50 18:10:16 INFO - PID 27156 | Values: 74.0 78.0 73.0 74.0 74.0 74.0 74.0 75.0 74.0 73.0 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | [#4] audio-oscillator Cycles:10 Average:80.00 Median:80.50 stddev:2.26 (2.8%) stddev-sans-first:2.28 18:10:16 INFO - PID 27156 | Values: 78.0 79.0 79.0 84.0 80.0 83.0 81.0 81.0 78.0 77.0 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 18:10:16 INFO - PID 27156 | Values: 113.0 114.0 114.0 113.0 115.0 114.0 114.0 114.0 114.0 115.0 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 18:10:16 INFO - PID 27156 | Values: 150.0 151.0 151.0 152.0 153.0 151.0 150.0 151.0 152.0 150.0 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.50 18:10:16 INFO - PID 27156 | Values: 96.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | [#8] json-parse-financial Cycles:10 Average:44.50 Median:45.00 stddev:1.18 (2.6%) stddev-sans-first:1.24 18:10:16 INFO - PID 27156 | Values: 44.0 45.0 44.0 47.0 45.0 45.0 44.0 45.0 43.0 43.0 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | [#9] json-stringify-tinderbox Cycles:10 Average:36.90 Median:37.00 stddev:0.32 (0.9%) stddev-sans-first:0.00 18:10:16 INFO - PID 27156 | Values: 36.0 37.0 37.0 37.0 37.0 37.0 37.0 37.0 37.0 37.0 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:73.00 stddev:1.71 (2.3%) stddev-sans-first:1.80 18:10:16 INFO - PID 27156 | Values: 73.0 75.0 72.0 70.0 71.0 71.0 73.0 71.0 75.0 73.0 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | [#11] stanford-crypto-ccm Cycles:10 Average:109.10 Median:110.00 stddev:2.92 (2.7%) stddev-sans-first:3.08 18:10:16 INFO - PID 27156 | Values: 110.0 104.0 110.0 112.0 110.0 108.0 110.0 112.0 111.0 104.0 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:152.50 stddev:4.78 (3.1%) stddev-sans-first:5.05 18:10:16 INFO - PID 27156 | Values: 155.0 151.0 152.0 153.0 152.0 150.0 166.0 151.0 151.0 157.0 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:2.91 (4.7%) stddev-sans-first:1.81 18:10:16 INFO - PID 27156 | Values: 69.0 63.0 59.0 60.0 60.0 61.0 64.0 64.0 61.0 62.0 18:10:16 INFO - PID 27156 | -------- Summary: end -------- 18:10:16 INFO - PID 27156 | 18:10:16 INFO - PID 27156 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:10:16 INFO - TEST-INFO | 27156: exit 0 18:10:16 INFO - TEST-OK | kraken | took 58895ms 18:10:16 INFO - SUITE-END | took 1166s 18:10:16 INFO - Completed test suite (00:19:26) 18:10:16 INFO - javascript benchmark 18:10:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8994.040118281007, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3865.787381694009, 3870.980645096775, 3872.225554889022, 3876.4185372194183, 3880.941785873212, 6107.083937409391, 6196.597221180631, 6209.782657606985, 6223.813285601428, 6330.272018717849, 6260.342664020281, 6266.968665156668, 6271.059341098838, 6283.088952101943, 6297.464715499188, 5513.9448605514035, 5581.6371935824245, 5599.160125981115, 5629.831105066854, 5683.374828768853, 5573.4147914469, 5655.066913959213, 5662.037453632893, 5681.630694004876, 5697.0, 5431.619786614939, 5641.12562552805, 5709.0009248381575, 5720.399358067405, 5729.914051289234, 5447.1829225616075, 5534.75093620788, 5579.218909352694, 5661.122526008476, 5681.261436013292, 5562.9443705562835, 5578.079616863212, 5640.09758438652, 5651.124075768263, 5658.91511627326, 6116.388361163892, 6182.041783523561, 6188.907166392508, 6223.595466294676, 6256.249250090018, 6684.431823295025, 6696.0, 6696.59820410772, 6704.7988560343265, 6711.094002309675, 6753.088333075021, 6759.0, 6890.965545172242, 6901.861962760717, 6925.3074692530845, 6284.497240220863, 6307.27466341372, 6376.139221205124, 6391.552591318609, 6409.198850143732, 6822.624755638389, 6951.7219311228, 6962.895556566656, 7058.294170582901, 7059.470539709542, 6582.24304205013, 6670.566413183127, 6732.966335168293, 6779.593224406552, 6781.050652908597, 6712.261651218362, 6778.525503214728, 6786.3892249697765, 6794.218664853506, 6802.217744959294, 6647.900281495781, 6652.467802575782, 6680.83297917556, 6739.528233023641, 6754.864902701918, 6662.300458451793, 6696.63168525726, 6715.127033485615, 6722.092517510171, 6736.932630673728, 4931.334269873593, 4995.0, 5013.0, 5016.498350165028, 5024.422191447957, 4416.823327066945, 4431.601155895984, 4447.911041779146, 4453.4433195850515, 4498.572635599613, 6244.2819075805955, 6244.594101383395, 6309.558330916791, 6328.367163283635, 6343.111964324999, 6707.865842683119, 6712.630805305657, 6727.562708423937, 6789.355011273921, 6832.897506537406, 6017.097435384728, 6123.571350005457, 6173.074038894202, 6174.9073763893575, 6301.464375528039, 5431.266778984866, 5456.127019676833, 5456.809011684572, 5545.889082218414, 5556.055470570012, 6940.167179938439, 7021.1574611047, 7038.190608080034, 7052.9647351762915, 7062.0, 6623.30455302196, 6663.36698013688, 6722.19333679942, 6732.360425759643, 6761.966190169214, 6950.200726916267, 7013.929860701328, 7013.929860701532, 7028.648567571703, 7109.253528379652, 6647.7673281436855, 6712.362325579063, 6740.831479213059, 6748.7300507979135, 6749.696263668048, 6693.464522838064, 6719.160104986877, 6728.259891412039, 6849.8972515411315, 6891.862162756817, 6449.903251451326, 6543.1821022372205, 6578.605283682803, 6611.768588099393, 6617.900731488935, 6569.24453687832, 6580.967095164685, 6616.933830661825, 6655.600663960178, 6656.600603963778, 6325.841853953688, 6472.708728107153, 6487.448566871869, 6542.443892269211, 6572.4084832365315, 5869.501092407193, 6430.7749228776765, 6551.737930482727, 6603.273639899511, 6612.008198770223, 6376.52176086786, 6435.388638079375, 6450.838729031811, 6497.057926600711, 6509.902351464637], "value": 6172.5250556419915, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [946.8911075226347, 970.0638883477444, 986.9111779939803, 990.7424069741865, 1004.41241873504, 39991.2001759965, 40842.7957860211, 40847.18305633886, 40989.59010409895, 41067.58932410675, 41800.0, 43004.354934676005, 43439.78280108595, 43769.562304376945, 43863.12273754523, 8418.158184181579, 8461.576921153948, 8540.615672294762, 8545.829083418359, 8556.78608034801, 8308.501489910594, 8315.293200077971, 8468.153184681543, 8476.78808029798, 8504.149585041509, 8492.320614350838, 8507.106753790855, 8556.786080347978, 8590.699325523608, 8599.269062129695, 8500.0, 8504.532250726208, 8510.957445212796, 8536.914630853706, 8542.786430339229, 8330.791730206793, 8350.164983501661, 8372.790680232982, 8377.24604785566, 8390.538520381377, 40391.0, 40558.79720601378, 40752.59247407547, 40804.38793418101, 40824.979375515555, 3778.074371778904, 3812.6377994090517, 3820.2359528094216, 3822.9426558601645, 3839.4816699745456, 33110.668893311, 33222.33555328904, 33244.833775830964, 33299.33401331984, 33322.666773332196, 5253.894922101575, 5481.095619222823, 5525.392206857243, 5552.7223638817895, 5664.518515926151, 210379.0, 211880.0, 219674.0, 223306.0, 225258.87370563205, 53486.73256633692, 53839.19241211385, 53852.730736346064, 53856.46143538593, 54229.0, 56173.43826561682, 56229.43770562324, 56572.15141772877, 56660.15009774857, 56820.71589642025, 15797.0, 15846.0, 15906.681866362607, 16054.357825686842, 16366.509004729876, 13310.0, 13326.800097998537, 13327.333633318296, 13335.73328533424, 13336.133151345131, 13840.23878686682, 13843.238621875893, 13858.4456621734, 13937.860621393656, 13954.790678139836, 5566.832995010156, 5572.332685503531, 5583.860403489864, 5622.662640241599, 5644.915326270109, 1101.895319944604, 1111.5053801058614, 1113.6826004588654, 1116.0, 1131.0499180688098, 25282.620760688606, 25331.87334063355, 25467.61798573023, 25550.872245639024, 25731.48537029249, 1197.1260979485025, 1209.9516019359128, 1231.396615658321, 1244.3964677131585, 1244.440001999104, 13581.0, 13581.592552223448, 13582.59252222435, 13652.24912629815, 13786.862131378759, 255726.0, 256351.0, 256664.0, 257456.0, 257762.0, 56700.0, 57081.0, 57163.428365716645, 57264.427355726744, 57323.42676573264, 1524.7331716949711, 1555.8366371531054, 1566.1699299371123, 1570.8350623184629, 1576.3536949850736, 24932.10862619794, 25003.87498062498, 25018.37454063663, 25020.249392518253, 25074.24777256685, 41618.375724363555, 41742.1651566973, 41748.79125604353, 41762.0, 41881.581184187766, 218967.0, 219288.0, 219296.0, 219306.0, 219486.0, 33145.0, 33702.0, 36689.0, 36946.44580331351, 37265.62734372621, 46457.07085858331, 46614.53385466102, 46625.300620490045, 46658.53341466542, 47038.294425584325, 34392.48411273883, 34563.654363456044, 34665.480017800255, 34834.129146771535, 35215.82392088023, 34082.97751067472, 34251.82874085614, 34372.48441273333, 34541.65458345384, 34568.65431345755, 38640.6135938637, 39042.80478597589, 39344.60655393409, 39615.603843962344, 39725.0, 33170.33659326848, 33196.33607327888, 33313.500297496044, 33466.33067338688, 33474.0, 24816.255512334657, 25005.74994250107, 25267.62098568486, 25302.0, 25531.87234063892], "value": 18455.87652023384, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.3277977834492, 611.7950486586993, 612.3019757476476, 614.3457218062765, 615.1756646094233, 22836.77163228367, 23911.163109291178, 23941.64087538686, 23987.400314992134, 23988.76011239887, 24932.501349973034, 26505.602415963775, 26774.0, 26811.597826032576, 26836.865815670895, 6501.349865013496, 6717.462602991749, 6723.562968407063, 6725.05849181115, 6733.0, 6524.575902566342, 6721.596704197739, 6808.965955170242, 6812.659367031629, 6822.283660215656, 6748.730050797963, 6761.121054262939, 6772.796816095525, 6774.153230846145, 6775.830604234909, 6540.215174179105, 6766.15423072116, 6779.932200678004, 6790.947403152494, 6800.421964133055, 6310.085037669558, 6321.810345689637, 6336.493080553545, 6345.6827158642345, 6363.649999250039, 30252.54621180684, 30905.381892362253, 30922.53616195759, 30965.845170774228, 30967.845160774275, 2255.3684968208927, 2293.759155288704, 2302.056156975632, 2310.2491690200586, 2312.1560630369963, 20267.0, 20780.272690455913, 20910.163593456396, 20984.790152098438, 21022.684659730116, 2518.1312447205682, 2526.2168727694475, 2599.636050952868, 2600.557905156109, 2616.2020583721956, 131887.34056329753, 135895.0, 139090.0, 139169.0, 142431.0, 15756.448524301595, 16204.75692864608, 16237.51287461378, 16724.83275167257, 17027.744583831252, 25363.746362536138, 25370.492590148464, 25392.111276105617, 25515.36211594725, 25527.234182974542, 10729.517171727135, 10854.837177442345, 11006.119510439146, 11024.889751102546, 11082.279651822606, 9877.506124693737, 9928.652497162564, 9951.21562296001, 9979.401235925867, 10052.396856188652, 9606.66376676813, 9970.40177589347, 10111.292209545261, 10175.236857235588, 10332.328398654214, 2771.4041481081663, 2803.2711495011035, 2880.971190288112, 2908.9127326180246, 2975.5090410082094, 1048.6277371532997, 1048.8059708953867, 1050.3120456101112, 1057.9100776433936, 1075.2741899217997, 21040.15839366408, 21855.453613659785, 21932.89033554822, 21958.560828783335, 22026.242632048987, 1106.7011906785124, 1107.399807278491, 1114.9442527873573, 1121.3835380896705, 1129.13056946151, 12033.278003319829, 12045.63863084109, 12076.215046022156, 12185.634430967086, 12274.754504909852, 586566.0, 594334.0, 599798.0, 603633.0, 617833.0, 119306.4034679821, 122267.0, 123166.38416808037, 123637.0, 124339.37830310971, 1134.313740187175, 1163.3892206591606, 1223.62067758995, 1231.310466138947, 1268.7399083187925, 22771.0, 23300.53398932046, 23426.88286558556, 23468.178613748438, 23615.40961475977, 59112.40887591241, 59549.106763397715, 60119.39880601138, 60405.0939235903, 61903.452413690015, 73347.26652733404, 73393.6330318345, 73921.26078739359, 73972.0, 74367.25632743603, 15877.603059923595, 15998.120103394425, 16202.0, 16214.35142594283, 16332.101734404247, 24948.0, 25263.74736252614, 25459.2362229126, 25477.745222548278, 25531.23406297814, 20131.899340503205, 20226.49433764109, 20243.291484797963, 20346.389608311776, 20445.59108817845, 17799.555011124827, 17925.731114033562, 18448.07759611987, 18702.0, 18910.621787563898, 20852.895735521226, 21003.894980525, 21184.682229766873, 21462.14151433925, 21534.353969380943, 16046.598835029217, 16054.518364449084, 16108.838911611203, 16128.838711612734, 16150.273237704096, 20067.598648026666, 20349.694754578988, 20401.59196816085, 20532.692009619568, 20709.792902070785], "value": 12926.31637619454, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.4655430936245, 1477.128494188429, 1489.337244926007, 1509.3283488847467, 1512.206091801804, 17609.7358539622, 18135.90932045338, 18164.0, 18172.545686357847, 18173.0, 17729.0, 17770.0, 17814.732779008325, 17817.91091044543, 17857.285708571642, 2733.562629979204, 2795.371041515663, 2836.276749428893, 2838.7303206195484, 2848.2025032990796, 2720.07517444069, 2741.0817376179, 2743.9451210975767, 2752.1055656911585, 2757.986210068947, 2717.9320516987036, 2812.8452935088562, 2816.1270006298114, 2816.521191397457, 2816.943661126776, 2759.613654088429, 2777.125205560252, 2784.7354501322343, 2788.4004938938124, 2802.369466869958, 2686.1807148819603, 2730.4675588260297, 2737.9589306160424, 2738.4796888591304, 2752.724727527251, 16295.0, 16761.078140702255, 16774.07742574158, 16779.91610041942, 16792.160391980473, 8345.624446899843, 8583.270422014137, 8584.31325493959, 8586.527740974245, 8591.785205369915, 5404.864878378072, 5470.753816078286, 5569.303837020372, 5573.916391254134, 5651.18057881609, 2110.799474049978, 2125.8086772190577, 2136.4872430616697, 2156.2022051840763, 2162.708034415365, 29963.40073198524, 30271.0, 30287.394252115053, 30319.393612127853, 30472.542911856563, 7338.4496162788, 7433.925660743432, 7500.924990750132, 7514.9479072929835, 7634.503757255871, 19384.612307753767, 19456.0, 19478.0, 19494.610107797766, 19496.512587185432, 8419.115992820789, 8671.869921951176, 8689.913760779902, 8690.91309086901, 8693.956530217309, 7748.225177482207, 7849.097353804272, 7885.014373203349, 7892.565908874953, 8008.959955200186, 5469.425710300441, 5655.321361436654, 5670.659760414306, 5718.828435146869, 5725.885482290414, 1550.4418409372618, 1551.4880089570415, 1556.3463345394734, 1561.8125824901085, 1574.0791636892545, 972.7033254857337, 985.5762022330323, 993.3195760903805, 1008.9495525223709, 1017.2065788684838, 8367.539785311745, 8554.144585541397, 8568.528730919734, 8683.175098365646, 8717.041125476193, 787.1737568840235, 811.4563242627454, 812.975610731679, 819.9016118065751, 827.420805436197, 5259.815906443256, 5895.145203945404, 6051.788187413419, 6095.6952152392205, 6282.931901576651, 24003.759962400152, 25048.123315683864, 25515.617265741028, 25525.0, 25532.617010744852, 23666.408339791644, 24808.379790505383, 24880.129195478432, 24918.12786552498, 25031.749682503305, 11288.435578221057, 12627.0, 12653.746925061447, 12688.619341419771, 12869.806952895715, 8700.738977830675, 9903.712517372696, 10035.0, 10083.697489075339, 10217.438040907822, 19800.801991980472, 20102.698459522828, 20177.293794717116, 20365.49086272855, 20761.169553218308, 21258.893705531373, 21275.787242127382, 22142.778572214072, 22426.66360004634, 22478.775212247667, 12430.440630171845, 12448.25310481374, 12469.875301246871, 12497.375131243583, 12600.621981340575, 15241.3903443861, 15457.381704731684, 15460.768088478906, 15468.92265538665, 15471.767923481382, 11959.940200298943, 12012.459439325427, 12134.393280336124, 12162.452689628812, 12213.14507984468, 12165.45255463524, 12293.692657683629, 12336.876631233932, 12583.05627077991, 12668.619941401772, 10450.581976720847, 10586.629467968583, 10791.244612877023, 10807.189460790314, 10817.0, 7901.604919754104, 7953.2842044216295, 7983.680652773824, 8181.222783835526, 8190.0, 8124.187581241828, 8162.469439486415, 8178.550179740171, 8206.05630352517, 8207.95896020516], "value": 7256.181917502095, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.1988396361131, 573.8364566098662, 578.7308901360872, 580.7415700013495, 590.2238556298468, 6159.260888693363, 6173.320934697191, 6250.531210159244, 6263.592866463677, 6312.274088479826, 6131.509479241661, 6145.47763440107, 6194.256689197303, 6194.969025154879, 6206.6586337751405, 5029.0696221199105, 5081.720505372203, 5088.643794934356, 5107.361579802525, 5118.564921981636, 4827.56551910328, 4949.727764972925, 5033.647644664875, 5089.46560611136, 5120.257562653413, 4899.559039686427, 4902.65681402302, 4903.901921961558, 4905.650945989845, 4939.3084968104495, 4955.554000140005, 4972.925406118911, 4976.178930476467, 4984.999999999982, 4992.251162325644, 4408.162449134654, 4496.168208881368, 4512.796924138422, 4522.140793249272, 4526.932096018562, 5998.910016349758, 6020.638761674313, 6106.442857071418, 6137.11011903276, 6156.230471191101, 5816.243888294537, 5817.767289308423, 5819.730305180983, 5858.56060795442, 5858.912116318259, 6623.205215374138, 6628.0, 6643.5017373697165, 6659.101021362151, 6669.833254168636, 4890.554722638681, 5089.8727531812, 5094.61790365724, 5096.566791822699, 5097.5667068299235, 6609.801705948829, 6776.627285499296, 6804.829879253009, 6808.557443766189, 6858.417034552069, 5120.028788916219, 5121.411037730709, 5133.844884900867, 5196.220566914917, 5199.896002079937, 5193.714345711022, 5233.031889100528, 5234.2933703949475, 5242.7640756166065, 5259.815906443256, 5730.140478928194, 5739.540836733051, 5750.6837123958585, 5767.826965191051, 5832.533397328203, 6534.183227096613, 6601.0, 6625.569337993112, 6646.966765166143, 6707.128073350434, 1793.2020250988446, 1795.4828170196163, 1813.2475022865626, 1816.7365731968791, 1823.927042918295, 1228.2016689152122, 1274.7386785709093, 1284.2551320234243, 1306.3664122900386, 1308.4373719300602, 6101.359357267512, 6123.234595675541, 6152.107944348045, 6171.7531298748445, 6190.628562286277, 6411.006294024433, 6585.769498067544, 6624.569402988886, 6689.431398331099, 6743.35938085881, 5986.431289027535, 6111.8523960160555, 6136.938630613726, 6153.446189842846, 6173.660448675276, 3537.3809583322814, 3556.182078121995, 3569.196930690574, 3571.910702232413, 3574.1422058705725, 6836.589804611739, 6838.111045564145, 6875.209350924708, 6897.241303456616, 6916.757913473105, 6481.967590162019, 6691.464682825363, 6711.261761206263, 6717.899231511531, 6781.152355955505, 6822.522423430312, 6841.965790170918, 6900.689468973908, 6907.447404207652, 6913.896291555731, 6448.258450278278, 6508.544401892012, 6570.507211959027, 6571.474282057328, 6592.604443733391, 6495.895697731492, 6568.080468734476, 6648.9002664961035, 6668.766593169215, 6677.666116694243, 6737.258901520927, 6785.762498312535, 6810.727570897307, 6859.314068593101, 6997.4052205561065, 5112.258722485293, 5128.769205385692, 5150.227465880148, 5163.27714120016, 5191.636585439134, 6518.511111666549, 6549.836254093686, 6586.769463068769, 6599.868002639824, 6615.4376877965915, 6279.2464904209955, 6451.1936007999, 6485.513586481127, 6512.934870651422, 6533.314002029719, 6385.776497822554, 6399.936000639934, 6481.578697384655, 6507.349265073455, 6528.738850446119, 6272.372762723874, 6289.559730818799, 6367.968160159169, 6386.361363863763, 6401.591649837029, 6464.612123272619, 6477.643729594729, 6513.804585862432, 6545.967270163809, 6577.270432770347, 6271.96864015677, 6345.0, 6371.13989611415, 6401.967990160019, 6417.26201486835], "value": 5130.187483354448, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [937.5546615357702, 967.9080487353701, 977.096186027924, 988.1650005745147, 992.5930368548894, 20554.0, 21073.26243581473, 21197.258095966627, 21216.681749773765, 21276.787232127674, 18765.812341876575, 18880.527986800338, 19335.323263685776, 19749.605007899834, 19921.900390498064, 1017.0236572890016, 1044.3316277582353, 1044.3733759744168, 1044.597829835515, 1044.6082718980383, 1023.8668973033532, 1024.08856118055, 1026.071405378134, 1026.702256345659, 1059.4384975962714, 1117.8155604325277, 1120.8318752187197, 1121.3328069798456, 1122.831575263713, 1126.9969726943027, 1029.2177944761997, 1069.4652673663168, 1069.9411532365716, 1099.7360633447954, 1107.9861926337392, 771.2595907928395, 773.8374941262342, 775.5811861594789, 777.2848978939389, 779.3142035009156, 19114.139863706027, 19162.233510659556, 19196.232150713953, 19207.80792192088, 19273.4217973461, 23166.53666926669, 23329.88335058331, 23730.288091357288, 23756.04975800966, 23802.523949521084, 18701.438956831316, 19060.237590496363, 19103.61792764151, 19269.710954335696, 19337.709934350994, 4009.8596549120934, 4020.075382662004, 4024.5371782245124, 4031.8992025199314, 4047.190561887605, 156508.0, 157415.2129239358, 157966.0, 159326.0, 160445.0, 17531.123443827757, 17709.0, 17962.0, 18068.18693158811, 18129.0, 32858.34283314368, 33610.0, 33934.49098263528, 34539.654603453644, 34566.30867382688, 9052.0, 9201.861972070425, 9202.539873006323, 9205.03347148553, 9206.723798286062, 4371.278739008092, 4570.177368073712, 4635.490096089427, 4667.393238878992, 4668.5564871337165, 5873.324567674772, 6044.365341639064, 6059.1820104286235, 6084.361142080018, 6086.056661217518, 1028.2339656955617, 1049.4805071489661, 1056.0390045059114, 1060.0459586372172, 1071.212658695858, 724.7499612633633, 732.1177980533445, 737.3990197988622, 748.9176190619028, 754.1704125462057, 11494.13793965456, 11700.531978720755, 12059.0, 12657.81013284783, 12903.677408064874, 703.7431337561856, 704.3871831506622, 710.6233696141054, 722.299369611476, 730.2113717185428, 5911.527077833763, 5948.078047902582, 6065.0, 6106.114613381035, 6196.566240363221, 150869.0, 152025.0, 153637.0, 154345.0, 158065.0, 126002.36998814947, 127401.3629931863, 127768.0, 128491.0, 131228.3438582801, 116099.8390016089, 116110.41944790391, 117176.0, 117608.0, 119627.0, 11170.441477926233, 11188.66434006981, 11257.887421125684, 11581.82627260575, 11717.707057323294, 52951.47048529465, 54277.72861135669, 55238.89522209614, 55275.44724552703, 56863.147052793414, 70903.0, 72071.0, 72759.63620181865, 72791.0, 73711.26288737044, 16448.095354755602, 16544.50366489007, 16588.917055415128, 16715.0, 16744.246508906886, 17773.644527109645, 17870.46388608344, 17965.0, 18048.097595120453, 18054.187561559498, 16570.502884913472, 16680.0, 16699.246579109018, 16800.0, 16949.57626059309, 15165.772513412528, 15381.0, 15413.845861541242, 15467.767983480031, 15491.84508154949, 16273.349066037226, 16500.0, 16681.0, 16708.41520546775, 16810.915945420194, 12567.554731205662, 12699.111062225555, 12816.102872799187, 12985.155964862253, 13048.217106973612, 11854.110941679237, 11916.702082448008, 11943.343116128348, 12030.699232519257, 12068.879311206776], "value": 9655.793298435317, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1376.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 105.0, 105.0, 105.0, 105.0, 110.0, 107.0, 106.0, 105.0, 106.0], "value": 105.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 121.0, 116.0, 112.0, 112.0, 113.0, 111.0, 122.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 165.0, 162.0, 160.0, 162.0, 162.0, 163.0, 164.0, 165.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 73.0, 74.0, 74.0, 74.0, 74.0, 75.0, 74.0, 73.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 84.0, 80.0, 83.0, 81.0, 81.0, 78.0, 77.0], "value": 80.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 152.0, 153.0, 151.0, 150.0, 151.0, 152.0, 150.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 45.0, 44.0, 47.0, 45.0, 45.0, 44.0, 45.0, 43.0, 43.0], "value": 44.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0], "value": 36.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 72.0, 70.0, 71.0, 71.0, 73.0, 71.0, 75.0, 73.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 110.0, 112.0, 110.0, 108.0, 110.0, 112.0, 111.0, 104.0], "value": 109.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 151.0, 152.0, 153.0, 152.0, 150.0, 166.0, 151.0, 151.0, 157.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 63.0, 59.0, 60.0, 60.0, 61.0, 64.0, 64.0, 61.0, 62.0], "value": 62.3, "unit": "score"}]}]} 18:10:16 INFO - Return code: 0 18:10:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:10:16 INFO - # TBPL SUCCESS # 18:10:16 INFO - Running post-action listener: _package_coverage_data 18:10:16 INFO - Running post-action listener: _resource_record_post_action 18:10:16 INFO - [mozharness: 2017-09-25 01:10:16.919250Z] Finished run-tests step (success) 18:10:16 INFO - Running post-run listener: _resource_record_post_run 18:10:17 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319455232; Read time: 12; Write time: 181656 18:10:17 INFO - TinderboxPrint: CPU usage
13.1% 18:10:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:10:17 INFO - TinderboxPrint: I/O write bytes / time
319,455,232 / 181,656 18:10:17 INFO - TinderboxPrint: CPU idle
8,204.5 (86.9%) 18:10:17 INFO - TinderboxPrint: CPU user
1,186.7 (12.6%) 18:10:17 INFO - TinderboxPrint: Swap in / out
0 / 0 18:10:17 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9715712; Read time: 0; Write time: 1240 18:10:17 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:10:17 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 4096; Write bytes: 309739520; Read time: 12; Write time: 180416 18:10:17 INFO - Running post-run listener: _upload_blobber_files 18:10:17 INFO - Blob upload gear active. 18:10:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:10:17 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 18:10:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:10:17 INFO - (blobuploader) - INFO - Open directory for files ... 18:10:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:10:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:10:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:18 INFO - (blobuploader) - INFO - Done attempting. 18:10:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:10:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:10:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:19 INFO - (blobuploader) - INFO - Done attempting. 18:10:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:10:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:10:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:20 INFO - (blobuploader) - INFO - Done attempting. 18:10:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:10:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:10:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:26 INFO - (blobuploader) - INFO - Done attempting. 18:10:26 INFO - (blobuploader) - INFO - Iteration through files over. 18:10:26 INFO - Return code: 0 18:10:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:10:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:10:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f941f532ac11de73d6296b584044fefef841caad02ef70fea1c372048e6f8a967514551951d175104c8451acde8bcec9012fe08a948d16a886d459aaba9ed42", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fd86c9dd8814b579bb6c1d01f52acdf4fbc20e7108dd01ffa842da29f035ac4c6f8e8404b9ca7617c4fdde0cd97ee9da70dc237199ea66caca17dc9d1b708d2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4890b2a732a3dea12c2bea6b3dace2dfa373289b1d617ab17134436c247df30a4e552a278bea19fd9d4d4794ffcc6b1a488ea13d78a024981ab79646da0f28d2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23d8e5fb78a2885a478eb3525515ba57183b2b82b7a40b216d4838bf0a648deee405f1b99566279d7eb9b78084e6ac74a41d52a7bf36d4031bbf743865ee35e0"} 18:10:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:10:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:10:26 INFO - Contents: 18:10:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f941f532ac11de73d6296b584044fefef841caad02ef70fea1c372048e6f8a967514551951d175104c8451acde8bcec9012fe08a948d16a886d459aaba9ed42", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fd86c9dd8814b579bb6c1d01f52acdf4fbc20e7108dd01ffa842da29f035ac4c6f8e8404b9ca7617c4fdde0cd97ee9da70dc237199ea66caca17dc9d1b708d2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4890b2a732a3dea12c2bea6b3dace2dfa373289b1d617ab17134436c247df30a4e552a278bea19fd9d4d4794ffcc6b1a488ea13d78a024981ab79646da0f28d2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23d8e5fb78a2885a478eb3525515ba57183b2b82b7a40b216d4838bf0a648deee405f1b99566279d7eb9b78084e6ac74a41d52a7bf36d4031bbf743865ee35e0"} 18:10:26 INFO - Running post-run listener: copy_logs_to_upload_dir 18:10:26 INFO - Copying logs to upload dir... 18:10:26 INFO - mkdir: /builds/slave/test/build/upload/logs 18:10:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.894833 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-24 18:10:26.930533) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 18:10:26.935294) ========= 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=523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854 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/sha512/2f941f532ac11de73d6296b584044fefef841caad02ef70fea1c372048e6f8a967514551951d175104c8451acde8bcec9012fe08a948d16a886d459aaba9ed42", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fd86c9dd8814b579bb6c1d01f52acdf4fbc20e7108dd01ffa842da29f035ac4c6f8e8404b9ca7617c4fdde0cd97ee9da70dc237199ea66caca17dc9d1b708d2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4890b2a732a3dea12c2bea6b3dace2dfa373289b1d617ab17134436c247df30a4e552a278bea19fd9d4d4794ffcc6b1a488ea13d78a024981ab79646da0f28d2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23d8e5fb78a2885a478eb3525515ba57183b2b82b7a40b216d4838bf0a648deee405f1b99566279d7eb9b78084e6ac74a41d52a7bf36d4031bbf743865ee35e0"} build_url:https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011400 build_url: 'https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f941f532ac11de73d6296b584044fefef841caad02ef70fea1c372048e6f8a967514551951d175104c8451acde8bcec9012fe08a948d16a886d459aaba9ed42", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fd86c9dd8814b579bb6c1d01f52acdf4fbc20e7108dd01ffa842da29f035ac4c6f8e8404b9ca7617c4fdde0cd97ee9da70dc237199ea66caca17dc9d1b708d2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4890b2a732a3dea12c2bea6b3dace2dfa373289b1d617ab17134436c247df30a4e552a278bea19fd9d4d4794ffcc6b1a488ea13d78a024981ab79646da0f28d2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23d8e5fb78a2885a478eb3525515ba57183b2b82b7a40b216d4838bf0a648deee405f1b99566279d7eb9b78084e6ac74a41d52a7bf36d4031bbf743865ee35e0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 18:10:26.966161) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 18:10:26.966487) ========= 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=523ca41ca1e0623de333ad52000001bf-1506300588.194349-375453854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 18:10:27.046212) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 18:10:27.046610) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 18:10:27.046996) ========= ========= Total master_lag: 0.21 =========