builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-027 starttime: 1506300733.08 results: success (0) revision: 7e962631ba4298bcefa571008661983d77c3e652 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 17:52:13.078923) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 17:52:13.079367) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 17:52:13.079647) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 17:52:13.097721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 17:52:13.098001) ========= 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=1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-24 17:52:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.8M=0s 2017-09-24 17:52:13 (36.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.255495 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 17:52:13.383118) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 17:52:13.383436) ========= 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=1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016272 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 17:52:13.435190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-24 17:52:13.435489) ========= 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=1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-24 17:52:13,295 truncating revision to first 12 chars 2017-09-24 17:52:13,295 Setting DEBUG logging. 2017-09-24 17:52:13,295 attempt 1/10 2017-09-24 17:52:13,295 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:52:14,344 unpacking tar archive at: mozilla-central-7e962631ba42/testing/mozharness/ program finished with exit code 0 elapsedTime=1.323402 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-24 17:52:14.781065) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 17:52:14.781376) ========= script_repo_revision: 7e962631ba4298bcefa571008661983d77c3e652 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 17:52:14.781746) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 17:52:14.782021) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 17:52:14.795549) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-24 17:52:14.795867) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:52:14 INFO - MultiFileLogger online at 20170924 17:52:14 in /builds/slave/test 17:52:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:52:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:52:14 INFO - {'append_to_log': False, 17:52:14 INFO - 'base_work_dir': '/builds/slave/test', 17:52:14 INFO - 'blob_upload_branch': 'Firefox', 17:52:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:52:14 INFO - 'branch': 'Firefox', 17:52:14 INFO - 'buildbot_json_path': 'buildprops.json', 17:52:14 INFO - 'code_coverage': False, 17:52:14 INFO - 'config_files': ('talos/linux_config.py',), 17:52:14 INFO - 'default_actions': ('clobber', 17:52:14 INFO - 'read-buildbot-config', 17:52:14 INFO - 'download-and-extract', 17:52:14 INFO - 'populate-webroot', 17:52:14 INFO - 'create-virtualenv', 17:52:14 INFO - 'install', 17:52:14 INFO - 'setup-mitmproxy', 17:52:14 INFO - 'run-tests'), 17:52:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:52:14 INFO - 'disable_ccov_upload': False, 17:52:14 INFO - 'disable_stylo': False, 17:52:14 INFO - 'download_minidump_stackwalk': True, 17:52:14 INFO - 'download_symbols': 'ondemand', 17:52:14 INFO - 'enable_stylo': False, 17:52:14 INFO - 'enable_webrender': False, 17:52:14 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:52:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:52:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:52:14 INFO - 'gecko_profile': False, 17:52:14 INFO - 'gecko_profile_interval': 0, 17:52:14 INFO - 'installer_path': 'installer.exe', 17:52:14 INFO - 'log_level': 'info', 17:52:14 INFO - 'log_name': 'talos', 17:52:14 INFO - 'log_to_console': True, 17:52:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:52:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:52:14 INFO - 'opt_config_files': (), 17:52:14 INFO - 'pip_index': False, 17:52:14 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 17:52:14 INFO - 'system_bits': '32', 17:52:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:52:14 INFO - 'title': 'talos-linux64-ix-027', 17:52:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:52:14 INFO - 'use_talos_json': True, 17:52:14 INFO - 'verify': 'False', 17:52:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:52:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:52:14 INFO - 'work_dir': 'build'} 17:52:14 INFO - [mozharness: 2017-09-25 00:52:14.893303Z] Running clobber step. 17:52:14 INFO - Running pre-action listener: _resource_record_pre_action 17:52:14 INFO - Running main action method: clobber 17:52:14 INFO - rmtree: /builds/slave/test/build 17:52:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:52:15 INFO - Running post-action listener: _resource_record_post_action 17:52:15 INFO - [mozharness: 2017-09-25 00:52:15.840702Z] Finished clobber step (success) 17:52:15 INFO - [mozharness: 2017-09-25 00:52:15.840799Z] Running read-buildbot-config step. 17:52:15 INFO - Running pre-action listener: _resource_record_pre_action 17:52:15 INFO - Running main action method: read_buildbot_config 17:52:15 INFO - Using buildbot properties: 17:52:15 INFO - { 17:52:15 INFO - "project": "", 17:52:15 INFO - "product": "firefox", 17:52:15 INFO - "who": "archaeopteryx@coole-files.de", 17:52:15 INFO - "installer_path": "public/build/target.tar.bz2", 17:52:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 17:52:15 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:52:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 17:52:15 INFO - "stage_platform": "linux64-pgo", 17:52:15 INFO - "basedir": "/builds/slave/test", 17:52:15 INFO - "buildnumber": 57, 17:52:15 INFO - "platform": "ubuntu64_hw", 17:52:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:52:15 INFO - "slavebuilddir": "test", 17:52:15 INFO - "taskId": "M9ymoZ0uRzymVTQowyoxdw", 17:52:15 INFO - "branch": "mozilla-central", 17:52:15 INFO - "script_repo_revision": "production", 17:52:15 INFO - "revision": "7e962631ba4298bcefa571008661983d77c3e652", 17:52:15 INFO - "slavename": "talos-linux64-ix-027", 17:52:15 INFO - "repo_path": "mozilla-central" 17:52:15 INFO - } 17:52:15 INFO - Finding installer, test and symbols from parent task. 17:52:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M9ymoZ0uRzymVTQowyoxdw'}, attempt #1 17:52:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M9ymoZ0uRzymVTQowyoxdw'}, attempt #1 17:52:16 INFO - Task dependencies: XNnhmb6FR56ecTjHY5Q_Pw 17:52:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw'}, attempt #1 17:52:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.tar.bz2 17:52:17 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.test_packages.json 17:52:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.crashreporter-symbols.zip 17:52:17 INFO - Running post-action listener: _resource_record_post_action 17:52:17 INFO - [mozharness: 2017-09-25 00:52:17.201709Z] Finished read-buildbot-config step (success) 17:52:17 INFO - [mozharness: 2017-09-25 00:52:17.201931Z] Running download-and-extract step. 17:52:17 INFO - Running pre-action listener: _resource_record_pre_action 17:52:17 INFO - Running main action method: download_and_extract 17:52:17 INFO - mkdir: /builds/slave/test/build/tests 17:52:17 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:52:17 INFO - trying https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.test_packages.json 17:52:17 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:52:17 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:52:17 INFO - Downloaded 989 bytes. 17:52:17 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:52:17 INFO - Using the following test package requirements: 17:52:17 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:52:17 INFO - u'common': [u'target.common.tests.zip'], 17:52:17 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:52:17 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:52:17 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:52:17 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:52:17 INFO - u'mozbase': [u'target.common.tests.zip'], 17:52:17 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:52:17 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:52:17 INFO - u'web-platform': [u'target.common.tests.zip', 17:52:17 INFO - u'target.web-platform.tests.tar.gz'], 17:52:17 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:52:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:52:17 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:52:17 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:52:17 INFO - Fetch https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.common.tests.zip into memory 17:52:18 INFO - Content-Length response header: 55353629 17:52:18 INFO - Bytes received: 55353629 17:52:30 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:52:30 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:52:30 INFO - Fetch https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.talos.tests.zip into memory 17:52:30 INFO - Content-Length response header: 14513823 17:52:30 INFO - Bytes received: 14513823 17:52:31 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:52:31 INFO - trying https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.tar.bz2 17:52:31 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:52:31 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:52:32 INFO - Downloaded 62310319 bytes. 17:52:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.tar.bz2 17:52:32 INFO - mkdir: /builds/slave/test/properties 17:52:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:52:32 INFO - Writing to file /builds/slave/test/properties/build_url 17:52:32 INFO - Contents: 17:52:32 INFO - build_url:https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.tar.bz2 17:52:32 INFO - Running post-action listener: _resource_record_post_action 17:52:32 INFO - Running post-action listener: find_tests_for_verification 17:52:32 INFO - Running post-action listener: set_extra_try_arguments 17:52:32 INFO - [mozharness: 2017-09-25 00:52:32.111505Z] Finished download-and-extract step (success) 17:52:32 INFO - [mozharness: 2017-09-25 00:52:32.111603Z] Running populate-webroot step. 17:52:32 INFO - Running pre-action listener: _resource_record_pre_action 17:52:32 INFO - Running main action method: populate_webroot 17:52:32 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:52:32 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:52:32 INFO - 'tests': ['tresize', 17:52:32 INFO - 'tcanvasmark']}, 17:52:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:52:32 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:52:32 INFO - 'tests': ['dromaeo_css', 17:52:32 INFO - 'kraken']}, 17:52:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:52:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:52:32 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:52:32 INFO - 'talos_options': ['--disable-stylo'], 17:52:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:52:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:52:32 INFO - 'tests': ['damp', 'tps']}, 17:52:32 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:52:32 INFO - 'talos_options': ['--disable-stylo'], 17:52:32 INFO - 'tests': ['damp', 'tps']}, 17:52:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:52:32 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:52:32 INFO - 'tests': ['dromaeo_dom']}, 17:52:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:52:32 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:52:32 INFO - 'tests': ['basic_compositor_video', 17:52:32 INFO - 'glvideo']}, 17:52:32 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:52:32 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:52:32 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:52:32 INFO - 'talos_options': ['--disable-stylo'], 17:52:32 INFO - 'tests': ['ts_paint_webext', 17:52:32 INFO - 'tp5o_webext']}, 17:52:32 INFO - 'other-e10s': {'tests': ['a11yr', 17:52:32 INFO - 'ts_paint', 17:52:32 INFO - 'tpaint', 17:52:32 INFO - 'sessionrestore', 17:52:32 INFO - 'sessionrestore_many_windows', 17:52:32 INFO - 'sessionrestore_no_auto_restore', 17:52:32 INFO - 'tabpaint']}, 17:52:32 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:52:32 INFO - 'tests': ['a11yr', 17:52:32 INFO - 'ts_paint', 17:52:32 INFO - 'tpaint', 17:52:32 INFO - 'sessionrestore', 17:52:32 INFO - 'sessionrestore_many_windows', 17:52:32 INFO - 'sessionrestore_no_auto_restore', 17:52:32 INFO - 'tabpaint']}, 17:52:32 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 17:52:32 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:52:32 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:52:32 INFO - 'tests': ['perf_reftest_singletons']}, 17:52:32 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:52:32 INFO - 'tests': ['perf_reftest']}, 17:52:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:52:32 INFO - 'tsvgr_opacity', 17:52:32 INFO - 'tart', 17:52:32 INFO - 'tscrollx', 17:52:32 INFO - 'tsvg_static']}, 17:52:32 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:52:32 INFO - 'tests': ['tsvgx', 17:52:32 INFO - 'tsvgr_opacity', 17:52:32 INFO - 'tart', 17:52:32 INFO - 'tscrollx', 17:52:32 INFO - 'tsvg_static']}, 17:52:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:52:32 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:52:32 INFO - 'talos_options': ['--disable-stylo'], 17:52:32 INFO - 'tests': ['tp5o']}, 17:52:32 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:52:32 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:52:32 INFO - 'talos_options': ['--mitmproxy', 17:52:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:52:32 INFO - '--firstNonBlankPaint'], 17:52:32 INFO - 'tests': ['tp6_google', 17:52:32 INFO - 'tp6_youtube', 17:52:32 INFO - 'tp6_amazon', 17:52:32 INFO - 'tp6_facebook']}, 17:52:32 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:52:32 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:52:32 INFO - 'talos_options': ['--disable-stylo', 17:52:32 INFO - '--mitmproxy', 17:52:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:52:32 INFO - '--firstNonBlankPaint'], 17:52:32 INFO - 'tests': ['tp6_google', 17:52:32 INFO - 'tp6_youtube', 17:52:32 INFO - 'tp6_amazon', 17:52:32 INFO - 'tp6_facebook']}, 17:52:32 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:52:32 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:52:32 INFO - 'talos_options': ['--stylo-threads=1', 17:52:32 INFO - '--mitmproxy', 17:52:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:52:32 INFO - '--firstNonBlankPaint'], 17:52:32 INFO - 'tests': ['tp6_google', 17:52:32 INFO - 'tp6_youtube', 17:52:32 INFO - 'tp6_amazon', 17:52:32 INFO - 'tp6_facebook']}, 17:52:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:52:32 INFO - 'talos_options': ['--xperf_path', 17:52:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:52:32 INFO - 'tests': ['tp5n']}, 17:52:32 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:52:32 INFO - 'talos_options': ['--disable-stylo', 17:52:32 INFO - '--xperf_path', 17:52:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:52:32 INFO - 'tests': ['tp5n']}}} 17:52:32 INFO - Running post-action listener: _resource_record_post_action 17:52:32 INFO - [mozharness: 2017-09-25 00:52:32.127009Z] Finished populate-webroot step (success) 17:52:32 INFO - [mozharness: 2017-09-25 00:52:32.127098Z] Running create-virtualenv step. 17:52:32 INFO - Running pre-action listener: _resource_record_pre_action 17:52:32 INFO - Running main action method: create_virtualenv 17:52:32 INFO - Creating virtualenv /builds/slave/test/build/venv 17:52:32 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:52:32 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:52:32 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:52:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:52:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:52:34 INFO - Installing distribute.............................................................................................................................................................................................done. 17:52:34 INFO - Installing pip...............done. 17:52:34 INFO - Return code: 0 17:52:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:52:34 INFO - Reading from file tmpfile_stdout 17:52:34 INFO - Output received: 17:52:34 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:52:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:52:34 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:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:34 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:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:34 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 0x24ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2692b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2834d60>, '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 0x2835a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2835ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', '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:52:34 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:52:34 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:52:34 INFO - Using env: {'DISPLAY': ':0', 17:52:34 INFO - 'HOME': '/home/cltbld', 17:52:34 INFO - 'LANG': 'en_US.UTF-8', 17:52:34 INFO - 'LANGUAGE': 'en_US:en', 17:52:34 INFO - 'LOGNAME': 'cltbld', 17:52:34 INFO - 'MAIL': '/var/mail/cltbld', 17:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:34 INFO - 'MOZ_NO_REMOTE': '1', 17:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:34 INFO - 'NO_EM_RESTART': '1', 17:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:34 INFO - 'PWD': '/builds/slave/test', 17:52:34 INFO - 'SHELL': '/bin/bash', 17:52:34 INFO - 'SHLVL': '1', 17:52:34 INFO - 'TERM': 'linux', 17:52:34 INFO - 'TMOUT': '86400', 17:52:34 INFO - 'USER': 'cltbld', 17:52:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', 17:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:34 INFO - '_': '/tools/buildbot/bin/python'} 17:52:36 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:52:36 INFO - Downloading/unpacking pip>=1.5 17:52:36 INFO - Running setup.py egg_info for package pip 17:52:36 INFO - warning: no files found matching 'pip/cacert.pem' 17:52:36 INFO - warning: no files found matching '*.html' under directory 'docs' 17:52:36 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:52:36 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:52:36 INFO - Installing collected packages: pip 17:52:36 INFO - Found existing installation: pip 1.1 17:52:36 INFO - Uninstalling pip: 17:52:36 INFO - Successfully uninstalled pip 17:52:36 INFO - Running setup.py install for pip 17:52:36 INFO - warning: no files found matching 'pip/cacert.pem' 17:52:36 INFO - warning: no files found matching '*.html' under directory 'docs' 17:52:36 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:52:36 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:52:36 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:52:36 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:52:36 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:52:36 INFO - Successfully installed pip 17:52:36 INFO - Cleaning up... 17:52:36 INFO - Return code: 0 17:52:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:52:36 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:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:36 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:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:36 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 0x24ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2692b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2834d60>, '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 0x2835a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2835ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', '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:52:36 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:52:36 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:52:36 INFO - Using env: {'DISPLAY': ':0', 17:52:36 INFO - 'HOME': '/home/cltbld', 17:52:36 INFO - 'LANG': 'en_US.UTF-8', 17:52:36 INFO - 'LANGUAGE': 'en_US:en', 17:52:36 INFO - 'LOGNAME': 'cltbld', 17:52:36 INFO - 'MAIL': '/var/mail/cltbld', 17:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:36 INFO - 'MOZ_NO_REMOTE': '1', 17:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:36 INFO - 'NO_EM_RESTART': '1', 17:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:36 INFO - 'PWD': '/builds/slave/test', 17:52:36 INFO - 'SHELL': '/bin/bash', 17:52:36 INFO - 'SHLVL': '1', 17:52:36 INFO - 'TERM': 'linux', 17:52:36 INFO - 'TMOUT': '86400', 17:52:36 INFO - 'USER': 'cltbld', 17:52:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', 17:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:36 INFO - '_': '/tools/buildbot/bin/python'} 17:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:36 INFO - Downloading/unpacking psutil>=3.1.1 17:52:36 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:52:36 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:52:36 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:52:36 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:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:52:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:52:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:52:37 INFO - Installing collected packages: psutil 17:52:37 INFO - Running setup.py install for psutil 17:52:37 INFO - building 'psutil._psutil_linux' extension 17:52:37 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:52:38 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:52:38 INFO - building 'psutil._psutil_posix' extension 17:52:38 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:52:39 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:52:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:52:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:52:39 INFO - Successfully installed psutil 17:52:39 INFO - Cleaning up... 17:52:39 INFO - Return code: 0 17:52:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:52:39 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:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:39 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:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:39 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 0x24ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2692b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2834d60>, '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 0x2835a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2835ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', '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:52:39 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:52:39 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:52:39 INFO - Using env: {'DISPLAY': ':0', 17:52:39 INFO - 'HOME': '/home/cltbld', 17:52:39 INFO - 'LANG': 'en_US.UTF-8', 17:52:39 INFO - 'LANGUAGE': 'en_US:en', 17:52:39 INFO - 'LOGNAME': 'cltbld', 17:52:39 INFO - 'MAIL': '/var/mail/cltbld', 17:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:39 INFO - 'MOZ_NO_REMOTE': '1', 17:52:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:39 INFO - 'NO_EM_RESTART': '1', 17:52:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:39 INFO - 'PWD': '/builds/slave/test', 17:52:39 INFO - 'SHELL': '/bin/bash', 17:52:39 INFO - 'SHLVL': '1', 17:52:39 INFO - 'TERM': 'linux', 17:52:39 INFO - 'TMOUT': '86400', 17:52:39 INFO - 'USER': 'cltbld', 17:52:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', 17:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:39 INFO - '_': '/tools/buildbot/bin/python'} 17:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:52:39 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:52:39 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:52:39 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:52:39 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:52:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:52:41 INFO - Installing collected packages: mozsystemmonitor 17:52:41 INFO - Running setup.py install for mozsystemmonitor 17:52:41 INFO - Successfully installed mozsystemmonitor 17:52:41 INFO - Cleaning up... 17:52:41 INFO - Return code: 0 17:52:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:52:41 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:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:41 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:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:41 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 0x24ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2692b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2834d60>, '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 0x2835a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2835ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', '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:52:41 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:52:41 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:52:41 INFO - Using env: {'DISPLAY': ':0', 17:52:41 INFO - 'HOME': '/home/cltbld', 17:52:41 INFO - 'LANG': 'en_US.UTF-8', 17:52:41 INFO - 'LANGUAGE': 'en_US:en', 17:52:41 INFO - 'LOGNAME': 'cltbld', 17:52:41 INFO - 'MAIL': '/var/mail/cltbld', 17:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:41 INFO - 'MOZ_NO_REMOTE': '1', 17:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:41 INFO - 'NO_EM_RESTART': '1', 17:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:41 INFO - 'PWD': '/builds/slave/test', 17:52:41 INFO - 'SHELL': '/bin/bash', 17:52:41 INFO - 'SHLVL': '1', 17:52:41 INFO - 'TERM': 'linux', 17:52:41 INFO - 'TMOUT': '86400', 17:52:41 INFO - 'USER': 'cltbld', 17:52:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', 17:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:41 INFO - '_': '/tools/buildbot/bin/python'} 17:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:41 INFO - Downloading/unpacking jsonschema==2.5.1 17:52:41 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:52:41 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:52:41 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:52:41 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:52:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:52:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:52:42 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:52:42 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:52:42 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:52:42 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:52:42 INFO - Downloading functools32-3.2.3-2.tar.gz 17:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:52:42 INFO - warning: no files found matching '*.txt' 17:52:42 INFO - no previously-included directories found matching 'build' 17:52:42 INFO - no previously-included directories found matching 'dist' 17:52:42 INFO - no previously-included directories found matching '.git*' 17:52:42 INFO - Installing collected packages: jsonschema, functools32 17:52:42 INFO - Running setup.py install for functools32 17:52:42 INFO - warning: no files found matching '*.txt' 17:52:42 INFO - no previously-included directories found matching 'build' 17:52:42 INFO - no previously-included directories found matching 'dist' 17:52:42 INFO - no previously-included directories found matching '.git*' 17:52:42 INFO - Successfully installed jsonschema functools32 17:52:42 INFO - Cleaning up... 17:52:43 INFO - Return code: 0 17:52:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2692b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2834d60>, '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 0x2835a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2835ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', '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:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:52:43 INFO - Using env: {'DISPLAY': ':0', 17:52:43 INFO - 'HOME': '/home/cltbld', 17:52:43 INFO - 'LANG': 'en_US.UTF-8', 17:52:43 INFO - 'LANGUAGE': 'en_US:en', 17:52:43 INFO - 'LOGNAME': 'cltbld', 17:52:43 INFO - 'MAIL': '/var/mail/cltbld', 17:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:43 INFO - 'MOZ_NO_REMOTE': '1', 17:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:43 INFO - 'NO_EM_RESTART': '1', 17:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:43 INFO - 'PWD': '/builds/slave/test', 17:52:43 INFO - 'SHELL': '/bin/bash', 17:52:43 INFO - 'SHLVL': '1', 17:52:43 INFO - 'TERM': 'linux', 17:52:43 INFO - 'TMOUT': '86400', 17:52:43 INFO - 'USER': 'cltbld', 17:52:43 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', 17:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:43 INFO - '_': '/tools/buildbot/bin/python'} 17:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:52:43 INFO - Cleaning up... 17:52:43 INFO - Return code: 0 17:52:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2692b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2834d60>, '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 0x2835a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2835ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', '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:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:52:43 INFO - Using env: {'DISPLAY': ':0', 17:52:43 INFO - 'HOME': '/home/cltbld', 17:52:43 INFO - 'LANG': 'en_US.UTF-8', 17:52:43 INFO - 'LANGUAGE': 'en_US:en', 17:52:43 INFO - 'LOGNAME': 'cltbld', 17:52:43 INFO - 'MAIL': '/var/mail/cltbld', 17:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:43 INFO - 'MOZ_NO_REMOTE': '1', 17:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:43 INFO - 'NO_EM_RESTART': '1', 17:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:43 INFO - 'PWD': '/builds/slave/test', 17:52:43 INFO - 'SHELL': '/bin/bash', 17:52:43 INFO - 'SHLVL': '1', 17:52:43 INFO - 'TERM': 'linux', 17:52:43 INFO - 'TMOUT': '86400', 17:52:43 INFO - 'USER': 'cltbld', 17:52:43 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', 17:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:43 INFO - '_': '/tools/buildbot/bin/python'} 17:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:43 INFO - Downloading/unpacking blobuploader==1.2.4 17:52:43 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:52:43 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:52:43 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:52:43 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:52:44 INFO - Downloading blobuploader-1.2.4.tar.gz 17:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:52:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:52:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:52:45 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:52:45 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:52:45 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:52:45 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:52:45 INFO - Downloading docopt-0.6.1.tar.gz 17:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:52:45 INFO - Installing collected packages: blobuploader, requests, docopt 17:52:45 INFO - Running setup.py install for blobuploader 17:52:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:52:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:52:45 INFO - Running setup.py install for requests 17:52:45 INFO - Running setup.py install for docopt 17:52:46 INFO - Successfully installed blobuploader requests docopt 17:52:46 INFO - Cleaning up... 17:52:46 INFO - Return code: 0 17:52:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:46 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 0x24ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2692b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2834d60>, '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 0x2835a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2835ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', '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:52:46 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:52:46 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:52:46 INFO - Using env: {'DISPLAY': ':0', 17:52:46 INFO - 'HOME': '/home/cltbld', 17:52:46 INFO - 'LANG': 'en_US.UTF-8', 17:52:46 INFO - 'LANGUAGE': 'en_US:en', 17:52:46 INFO - 'LOGNAME': 'cltbld', 17:52:46 INFO - 'MAIL': '/var/mail/cltbld', 17:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:46 INFO - 'MOZ_NO_REMOTE': '1', 17:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:46 INFO - 'NO_EM_RESTART': '1', 17:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:46 INFO - 'PWD': '/builds/slave/test', 17:52:46 INFO - 'SHELL': '/bin/bash', 17:52:46 INFO - 'SHLVL': '1', 17:52:46 INFO - 'TERM': 'linux', 17:52:46 INFO - 'TMOUT': '86400', 17:52:46 INFO - 'USER': 'cltbld', 17:52:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', 17:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:46 INFO - '_': '/tools/buildbot/bin/python'} 17:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:52:46 INFO - Running setup.py (path:/tmp/pip-nz2MvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:52:46 INFO - Running setup.py (path:/tmp/pip-Y8r9tA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:52:46 INFO - Running setup.py (path:/tmp/pip-WpplFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:52:46 INFO - Running setup.py (path:/tmp/pip-VA_O8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:52:46 INFO - Running setup.py (path:/tmp/pip-lOasaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:52:46 INFO - Running setup.py (path:/tmp/pip-zlcm0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:52:46 INFO - Running setup.py (path:/tmp/pip-p1SO8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:52:46 INFO - Running setup.py (path:/tmp/pip-W5Phi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:52:46 INFO - Running setup.py (path:/tmp/pip-eXVWpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:52:46 INFO - Running setup.py (path:/tmp/pip-F8HHCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:52:46 INFO - Running setup.py (path:/tmp/pip-KZIRxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:52:47 INFO - Running setup.py (path:/tmp/pip-AUY4Rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:52:47 INFO - Running setup.py (path:/tmp/pip-jztx_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:52:47 INFO - Running setup.py (path:/tmp/pip-DxUDVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:52:47 INFO - Running setup.py (path:/tmp/pip-VQLVNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:52:47 INFO - Running setup.py (path:/tmp/pip-CIVGfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:52:47 INFO - Running setup.py (path:/tmp/pip-HMPILv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:52:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:52:47 INFO - Running setup.py install for manifestparser 17:52:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:52:47 INFO - Running setup.py install for mozcrash 17:52:47 INFO - Running setup.py install for mozdebug 17:52:47 INFO - Running setup.py install for mozdevice 17:52:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:52:47 INFO - Running setup.py install for mozfile 17:52:47 INFO - Running setup.py install for mozhttpd 17:52:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:52:47 INFO - Running setup.py install for mozinfo 17:52:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:52:47 INFO - Running setup.py install for mozInstall 17:52:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:52:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:52:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:52:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:52:48 INFO - Running setup.py install for mozleak 17:52:48 INFO - Running setup.py install for mozlog 17:52:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:52:48 INFO - Running setup.py install for moznetwork 17:52:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:52:48 INFO - Running setup.py install for mozprocess 17:52:48 INFO - Running setup.py install for mozprofile 17:52:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:52:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:52:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:52:48 INFO - Running setup.py install for mozrunner 17:52:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:52:48 INFO - Running setup.py install for mozscreenshot 17:52:48 INFO - Running setup.py install for moztest 17:52:48 INFO - Running setup.py install for mozversion 17:52:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:52:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:52:49 INFO - Cleaning up... 17:52:49 INFO - Return code: 0 17:52:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:52:49 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:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:49 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:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:49 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 0x24ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2692b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2834d60>, '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 0x2835a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2835ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', '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:52:49 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:52:49 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:52:49 INFO - Using env: {'DISPLAY': ':0', 17:52:49 INFO - 'HOME': '/home/cltbld', 17:52:49 INFO - 'LANG': 'en_US.UTF-8', 17:52:49 INFO - 'LANGUAGE': 'en_US:en', 17:52:49 INFO - 'LOGNAME': 'cltbld', 17:52:49 INFO - 'MAIL': '/var/mail/cltbld', 17:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:49 INFO - 'MOZ_NO_REMOTE': '1', 17:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:49 INFO - 'NO_EM_RESTART': '1', 17:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:49 INFO - 'PWD': '/builds/slave/test', 17:52:49 INFO - 'SHELL': '/bin/bash', 17:52:49 INFO - 'SHLVL': '1', 17:52:49 INFO - 'TERM': 'linux', 17:52:49 INFO - 'TMOUT': '86400', 17:52:49 INFO - 'USER': 'cltbld', 17:52:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', 17:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:49 INFO - '_': '/tools/buildbot/bin/python'} 17:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:52:49 INFO - Running setup.py (path:/tmp/pip-myIq_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:52:49 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:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:52:49 INFO - Running setup.py (path:/tmp/pip-zBz0Y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:52:49 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:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:52:49 INFO - Running setup.py (path:/tmp/pip-uyF49v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:52:49 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:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:52:49 INFO - Running setup.py (path:/tmp/pip-zBJ0ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:52:49 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:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:52:49 INFO - Running setup.py (path:/tmp/pip-q04zJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:52:49 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:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:52:49 INFO - Running setup.py (path:/tmp/pip-nYKgAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:52:49 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:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:52:49 INFO - Running setup.py (path:/tmp/pip-ird74P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:52:49 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:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:52:49 INFO - Running setup.py (path:/tmp/pip-9hPPI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:52:49 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:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:52:49 INFO - Running setup.py (path:/tmp/pip-VXVNRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:52:49 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:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:52:49 INFO - Running setup.py (path:/tmp/pip-BHIq5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:52:49 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:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:52:49 INFO - Running setup.py (path:/tmp/pip-oo0BQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:52:50 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:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:52:50 INFO - Running setup.py (path:/tmp/pip-MJJoTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:52:50 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:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:52:50 INFO - Running setup.py (path:/tmp/pip-q3heWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:52:50 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:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:52:50 INFO - Running setup.py (path:/tmp/pip-qF2Z9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:52:50 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:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:52:50 INFO - Running setup.py (path:/tmp/pip-g3nQxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:52:50 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:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:52:50 INFO - Running setup.py (path:/tmp/pip-fPbdki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:52:50 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:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:52:50 INFO - Running setup.py (path:/tmp/pip-w_5Srb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:52:50 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:52:50 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:52:50 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:52:50 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:52:50 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:52:50 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:52:50 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:52:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:51 INFO - Downloading blessings-1.6.tar.gz 17:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:52:51 INFO - Installing collected packages: blessings 17:52:51 INFO - Running setup.py install for blessings 17:52:51 INFO - Successfully installed blessings 17:52:51 INFO - Cleaning up... 17:52:51 INFO - Return code: 0 17:52:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:52:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:52:52 INFO - Reading from file tmpfile_stdout 17:52:52 INFO - Current package versions: 17:52:52 INFO - argparse == 1.2.1 17:52:52 INFO - blessings == 1.6 17:52:52 INFO - blobuploader == 1.2.4 17:52:52 INFO - docopt == 0.6.1 17:52:52 INFO - functools32 == 3.2.3-2 17:52:52 INFO - jsonschema == 2.5.1 17:52:52 INFO - manifestparser == 1.1 17:52:52 INFO - mozInstall == 1.13 17:52:52 INFO - mozcrash == 1.0 17:52:52 INFO - mozdebug == 0.1 17:52:52 INFO - mozdevice == 0.51 17:52:52 INFO - mozfile == 1.2 17:52:52 INFO - mozhttpd == 0.7 17:52:52 INFO - mozinfo == 0.10 17:52:52 INFO - mozleak == 0.1 17:52:52 INFO - mozlog == 3.5 17:52:52 INFO - moznetwork == 0.27 17:52:52 INFO - mozprocess == 0.25 17:52:52 INFO - mozprofile == 0.28 17:52:52 INFO - mozrunner == 6.13 17:52:52 INFO - mozscreenshot == 0.1 17:52:52 INFO - mozsystemmonitor == 0.3 17:52:52 INFO - moztest == 0.8 17:52:52 INFO - mozversion == 1.4 17:52:52 INFO - psutil == 3.1.1 17:52:52 INFO - requests == 1.2.3 17:52:52 INFO - wsgiref == 0.1.2 17:52:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:52 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 0x24ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2692b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2834d60>, '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 0x2835a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2835ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', '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:52:52 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:52:52 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:52:52 INFO - Using env: {'DISPLAY': ':0', 17:52:52 INFO - 'HOME': '/home/cltbld', 17:52:52 INFO - 'LANG': 'en_US.UTF-8', 17:52:52 INFO - 'LANGUAGE': 'en_US:en', 17:52:52 INFO - 'LOGNAME': 'cltbld', 17:52:52 INFO - 'MAIL': '/var/mail/cltbld', 17:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:52 INFO - 'MOZ_NO_REMOTE': '1', 17:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:52 INFO - 'NO_EM_RESTART': '1', 17:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:52 INFO - 'PWD': '/builds/slave/test', 17:52:52 INFO - 'SHELL': '/bin/bash', 17:52:52 INFO - 'SHLVL': '1', 17:52:52 INFO - 'TERM': 'linux', 17:52:52 INFO - 'TMOUT': '86400', 17:52:52 INFO - 'USER': 'cltbld', 17:52:52 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', 17:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:52 INFO - '_': '/tools/buildbot/bin/python'} 17:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:52 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:52:52 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:52:52 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:52:52 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:52:52 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:52:52 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:52:52 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:52:52 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:52:52 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:52:52 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:52:53 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:52:53 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:52:53 INFO - Installing collected packages: simplejson 17:52:53 INFO - Running setup.py install for simplejson 17:52:53 INFO - building 'simplejson._speedups' extension 17:52:53 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:52:54 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:52:54 INFO - Successfully installed simplejson 17:52:54 INFO - Cleaning up... 17:52:54 INFO - Return code: 0 17:52:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2692b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28379c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2834d60>, '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 0x2835a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2835ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', '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:52:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:52:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:52:54 INFO - Using env: {'DISPLAY': ':0', 17:52:54 INFO - 'HOME': '/home/cltbld', 17:52:54 INFO - 'LANG': 'en_US.UTF-8', 17:52:54 INFO - 'LANGUAGE': 'en_US:en', 17:52:54 INFO - 'LOGNAME': 'cltbld', 17:52:54 INFO - 'MAIL': '/var/mail/cltbld', 17:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:54 INFO - 'MOZ_NO_REMOTE': '1', 17:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:54 INFO - 'NO_EM_RESTART': '1', 17:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:54 INFO - 'PWD': '/builds/slave/test', 17:52:54 INFO - 'SHELL': '/bin/bash', 17:52:54 INFO - 'SHLVL': '1', 17:52:54 INFO - 'TERM': 'linux', 17:52:54 INFO - 'TMOUT': '86400', 17:52:54 INFO - 'USER': 'cltbld', 17:52:54 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', 17:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:54 INFO - '_': '/tools/buildbot/bin/python'} 17:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:52:54 INFO - Cleaning up... 17:52:54 INFO - Return code: 0 17:52:54 INFO - Running post-action listener: _resource_record_post_action 17:52:54 INFO - Running post-action listener: _start_resource_monitoring 17:52:54 INFO - Starting resource monitoring. 17:52:54 INFO - [mozharness: 2017-09-25 00:52:54.796579Z] Finished create-virtualenv step (success) 17:52:54 INFO - [mozharness: 2017-09-25 00:52:54.797603Z] Running install step. 17:52:54 INFO - Running pre-action listener: _resource_record_pre_action 17:52:54 INFO - Running main action method: install 17:52:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:52:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:52:55 INFO - Reading from file tmpfile_stdout 17:52:55 INFO - Detecting whether we're running mozinstall >=1.0... 17:52:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:52:55 INFO - Reading from file tmpfile_stdout 17:52:55 INFO - Output received: 17:52:55 INFO - Usage: mozinstall [options] installer 17:52:55 INFO - Options: 17:52:55 INFO - -h, --help show this help message and exit 17:52:55 INFO - -d DEST, --destination=DEST 17:52:55 INFO - Directory to install application into. [default: 17:52:55 INFO - "/builds/slave/test"] 17:52:55 INFO - --app=APP Application being installed. [default: firefox] 17:52:55 INFO - mkdir: /builds/slave/test/build/application 17:52:55 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:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:53:12 INFO - Reading from file tmpfile_stdout 17:53:12 INFO - Output received: 17:53:12 INFO - /builds/slave/test/build/application/firefox/firefox 17:53:12 INFO - Running post-action listener: _resource_record_post_action 17:53:12 INFO - [mozharness: 2017-09-25 00:53:12.722246Z] Finished install step (success) 17:53:12 INFO - [mozharness: 2017-09-25 00:53:12.722498Z] Running setup-mitmproxy step. 17:53:12 INFO - Running pre-action listener: _resource_record_pre_action 17:53:12 INFO - Running main action method: setup_mitmproxy 17:53:12 INFO - Skipping: mitmproxy is not required 17:53:12 INFO - Running post-action listener: _resource_record_post_action 17:53:12 INFO - [mozharness: 2017-09-25 00:53:12.723627Z] Finished setup-mitmproxy step (success) 17:53:12 INFO - [mozharness: 2017-09-25 00:53:12.723847Z] Running run-tests step. 17:53:12 INFO - Running pre-action listener: _resource_record_pre_action 17:53:12 INFO - Running pre-action listener: _set_gcov_prefix 17:53:12 INFO - Running main action method: run_tests 17:53:12 WARNING - Try message not found. 17:53:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:53:12 INFO - Python 2.7.3 17:53:12 INFO - Return code: 0 17:53:12 INFO - grabbing minidump binary from tooltool 17:53: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:53:12 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 0x2834d60>, '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 0x2835a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2835ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:53:12 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:53:12 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:53:12 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:53:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:53:12 INFO - Return code: 0 17:53:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:53:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:53:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:53:12 INFO - ENV: RUST_BACKTRACE is now full 17:53:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:53:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:53:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-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-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 17:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-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-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 17:53:12 INFO - Using env: {'DISPLAY': ':0', 17:53:12 INFO - 'HOME': '/home/cltbld', 17:53:12 INFO - 'LANG': 'en_US.UTF-8', 17:53:12 INFO - 'LANGUAGE': 'en_US:en', 17:53:12 INFO - 'LOGNAME': 'cltbld', 17:53:12 INFO - 'MAIL': '/var/mail/cltbld', 17:53:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:53:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:12 INFO - 'MOZ_NO_REMOTE': '1', 17:53:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:53:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:12 INFO - 'NO_EM_RESTART': '1', 17:53:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:12 INFO - 'PWD': '/builds/slave/test', 17:53:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:53:12 INFO - 'RUST_BACKTRACE': 'full', 17:53:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:53:12 INFO - 'SHELL': '/bin/bash', 17:53:12 INFO - 'SHLVL': '1', 17:53:12 INFO - 'TERM': 'linux', 17:53:12 INFO - 'TMOUT': '86400', 17:53:12 INFO - 'USER': 'cltbld', 17:53:12 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', 17:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:12 INFO - '_': '/tools/buildbot/bin/python'} 17:53:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-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-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 17:53:13 INFO - mozversion application_buildid: 20170924232050 17:53:13 INFO - mozversion application_changeset: 7e962631ba4298bcefa571008661983d77c3e652 17:53:13 INFO - mozversion application_display_name: Nightly 17:53:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:53:13 INFO - mozversion application_name: Firefox 17:53:13 INFO - mozversion application_remotingname: firefox 17:53:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:53:13 INFO - mozversion application_vendor: Mozilla 17:53:13 INFO - mozversion application_version: 58.0a1 17:53:13 INFO - mozversion platform_buildid: 20170924232050 17:53:13 INFO - mozversion platform_changeset: 7e962631ba4298bcefa571008661983d77c3e652 17:53:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:53:13 INFO - mozversion platform_version: 58.0a1 17:53:13 INFO - using testdate: 1506300793 17:53:13 INFO - actual date: 1506300793 17:53:13 INFO - starting webserver on 'localhost:51646' 17:53:13 INFO - SUITE-START | Running 2 tests 17:53:13 INFO - TEST-START | dromaeo_css 17:53:13 INFO - Initialising browser for dromaeo_css test... 17:53:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51646/getInfo.html -profile /tmp/tmpopZWfQ/profile 17:53:13 INFO - TEST-INFO | started process 3552 (/builds/slave/test/build/application/firefox/firefox http://localhost:51646/getInfo.html) 17:53:22 INFO - TEST-INFO | 3552: exit 0 17:53:22 INFO - Browser initialized. 17:53:22 INFO - Running cycle 1/1 for dromaeo_css test... 17:53:22 INFO - Using env: {'DISPLAY': ':0', 17:53:22 INFO - 'HOME': '/home/cltbld', 17:53:22 INFO - 'JSGC_DISABLE_POISONING': '1', 17:53:22 INFO - 'LANG': 'en_US.UTF-8', 17:53:22 INFO - 'LANGUAGE': 'en_US:en', 17:53:22 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:53:22 INFO - 'LOGNAME': 'cltbld', 17:53:22 INFO - 'MAIL': '/var/mail/cltbld', 17:53:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:53:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:53:22 INFO - 'MOZ_CRASHREPORTER': '1', 17:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:53:22 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:53:22 INFO - 'MOZ_NO_REMOTE': '1', 17:53:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:53:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:53:22 INFO - 'NO_EM_RESTART': '1', 17:53:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:53:22 INFO - 'PWD': '/builds/slave/test', 17:53:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:53:22 INFO - 'RUST_BACKTRACE': 'full', 17:53:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:53:22 INFO - 'SHELL': '/bin/bash', 17:53:22 INFO - 'SHLVL': '1', 17:53:22 INFO - 'STYLO_FORCE_DISABLED': '1', 17:53:22 INFO - 'TERM': 'linux', 17:53:22 INFO - 'TMOUT': '86400', 17:53:22 INFO - 'USER': 'cltbld', 17:53:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', 17:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:53:22 INFO - '_': '/tools/buildbot/bin/python'} 17:53:22 INFO - TEST-INFO | started process 3788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpopZWfQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:53:23 INFO - PID 3788 | 17:53:23 INFO - PID 3788 | (/builds/slave/test/build/application/firefox/firefox:3837): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:53:23 INFO - PID 3788 | 17:53:33 INFO - PID 3788 | RSS: Main: 141656064 17:53:33 INFO - PID 3788 | 17:56:31 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:51646/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51646/tests/dromaeo/cssquery-ext.html) 17:56:32 INFO - PID 3788 | RSS: Main: 146575360 17:56:32 INFO - PID 3788 | 17:59:34 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:51646/tests/dromaeo/cssquery-ext.html (next: http://localhost:51646/tests/dromaeo/cssquery-jquery.html) 17:59:35 INFO - PID 3788 | RSS: Main: 146370560 17:59:35 INFO - PID 3788 | 18:02:36 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:51646/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51646/tests/dromaeo/cssquery-mootools.html) 18:02:37 INFO - PID 3788 | RSS: Main: 147042304 18:02:37 INFO - PID 3788 | 18:05:38 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:51646/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51646/tests/dromaeo/cssquery-prototype.html) 18:05:39 INFO - PID 3788 | RSS: Main: 146984960 18:05:39 INFO - PID 3788 | 18:08:42 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:51646/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51646/tests/dromaeo/cssquery-yui.html) 18:08:43 INFO - PID 3788 | RSS: Main: 146800640 18:08:43 INFO - PID 3788 | 18:11:44 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:51646/tests/dromaeo/cssquery-yui.html (next: http://localhost:51646/tests/dromaeo/cssquery-dojo.html) 18:11:44 INFO - PID 3788 | RSS: Main: 150872064 18:11:44 INFO - PID 3788 | 18:11:44 INFO - PID 3788 | __start_tp_report 18:11:44 INFO - PID 3788 | _x_x_mozilla_page_load 18:11:44 INFO - PID 3788 | _x_x_mozilla_page_load_details 18:11:44 INFO - PID 3788 | |i|pagename|runs| 18:11:44 INFO - PID 3788 | |0;dojo.html;3852.4413959975786;3877.9806100969495;3912.9608703912954;3918.157596116834;3933.8623148189818;6109.847253818646;6217.471514921232;6231.096491008801;6274.466670333027;6319.684015799215;6295.653739044351;6302.495800335973;6319.842003949892;6344.841378965528;6345.524085693568;5639.351474580435;5649.180868774036;5652.660840349572;5671.234383358235;5692.686902220376;5691.288588926384;5740.081586946089;5763.366029736726;5781.913271300934;5809.04150815115;5651.2653355063785;5712.9428705713035;5732.968065748164;5737.569682273846;5774.451427114438;5436.592255580807;5565.638233514849;5576.358718747356;5661.575381846378;5703.486686198241;5481.698506582136;5601.775928962837;5630.971845140789;5667.914981275243;5689.345725241567;6222.253329600431;6222.315545290015;6233.2208473940755;6293.811185664437;6301.6219026858535;6675.899861502081;6741.224759152711;6771.830704232384;6791.151106111736;6853;6831.248562658104;6847.897281540781;6855.108835851357;6859.965700171467;6862.759803406857;6293.213348331458;6386.808395748135;6437.0988061671405;6439.452646525051;6458.870822583569;7004.859902802017;7011.579305241702;7019.719211231493;7030.086088808423;7115.786526404217;6615.900761488581;6737.797866064026;6786.660666966632;6856.520043597;6871.518993670495;6790.354916282945;6855.143107111611;6867.587944723333;6870.003849441803;6907.516473846883;6746.898796518056;6829.863402731918;6899.448044156456;6906.205786334636;6918.584884906821;6847.144106986627;6856.348646878539;6861.1080559526945;6952.965235173791;6962.164540255202;4878.07316609843;4911.7544122793715;4975.104481193348;5051.494850514919;5082.390113186368;4473.217186992263;4605.746683932416;4650.837220697327;4662.277347011219;4668.3697700810635;6323.5573509854785;6346.714397852015;6422.743090276336;6426.903596446057;6443.613383197023;6562.278149403562;6722.159730033746;6747;6855.5886646801355;6927.445804335641;6372.36276372359;6440.130582371414;6440.67796610177;6450.6774661266745;6451.41937225652;5525.143602741581;5538.584606154554;5604.523615492729;5618.943810561842;5639.661620302795;6974.197967233732;7046.048783414276;7069.116360454943;7070.222275549685;7098.645067746592;6756.054152418764;6770.119884414995;6771.289014653587;6775.559588626724;6779.288174741779;6979.371856532734;7037.929620703728;7065.22282548909;7156.785296441115;7184.568925864465;6791.864162716817;6800.591964482147;6845.897311540231;6860.245373009065;6885.242623311532;6586.242582103119;6734.898976515258;6865.691043902936;6865.897011544931;6985.755498557526;6596.175478065242;6603;6605.53761236728;6606.372394622503;6608.372204640552;6538.640374779433;6621.33786621334;6621.370969757865;6632.767853125118;6643.966780166068;6573.309802470863;6654.301298363602;6658;6679.0315404267085;6692.83267918306;6597.901031484435;6701.865962680817;6728.899066513908;6809.182898052265;6823.692933817891;6361.777337793155;6470.38531339522;6470.579412338183;6524.021396790519;6535.509836762167 18:11:44 INFO - PID 3788 | |1;ext.html;957.0812020460357;986.6004268271353;990.5938565188272;994.3487016004519;995.4425521707849;40389.79805100974;44473.55526444734;44551.77724111379;44635.107297854025;44661;41022;41204.38193427093;41332;41354.7932260339;41390.37914431286;7522.623868806579;7566.508176968507;7566.962165189194;7575.734849280277;7576.659050342748;7544.585047822395;7577.431692623048;7580.734674286401;7625.694972201105;7684.500507466997;7627.961860190691;7706.845863082735;7718.459707820455;8407.95796021022;8527.701530446435;8481.491110533389;8548.487090774543;8551.358648101417;8551.743447696548;8553.187447192508;8444.957775211145;8454.492730436132;8459.915400845974;8496.02295735992;8496.915030849736;40027.399589006185;40055;41024.79487602543;41031.179376412605;41261.1747765046;3768.924621507582;3777.697784177259;3824.29250588642;3824.8852534424013;3839.36650452675;34345.82827085849;34574.481382779275;34774.6522534774;34827.30345393103;34873.30253394918;5430.0768869292315;5489;5497.752601132958;5502.972485137549;5511.22842802008;220934;221505;221798;222061.88969055214;223721;47836.28245576319;48531;53882.19176712353;54011.459885401426;54203;56830.43169568334;57245.71377143088;57255.42744572584;57304.713476433186;57305;17042.31830726782;17059.402920897708;17101;17124;17160.82839171617;13812.447502100005;13867.029307948347;13886.166829990232;13907;13923.58229253124;15551.611209719847;15560.144192069545;15576.610584735472;15749.26758056613;15808.36766529349;4799.472058073609;4934.259861020875;4965.90068198634;4991.450940396553;5022.949770502321;1113.9888601114046;1119.9832002519968;1138.1407037686658;1141.14414189358;1145.570411095839;25627.48745025089;26024.8698756505;26180.345491362867;26240;26281;1222.9938850305869;1226.270369130366;1234.6419538333962;1240.8697086805755;1244.104244943639;13908.165510069226;13965.511207107702;13977.301134943416;14024.298785060706;14050.789238161437;268172;277910;282419;282801;282855;57594;57811.42188578145;58073.4192658068;58250.70874645685;58339.70830145907;1507.4347119830063;1565.420794306114;1567.42005457979;1572.3081843988837;1573.0797483472068;25514.617280740433;25514.744852551237;25573.616395754452;25676.358091047874;25689.486210276064;41735.58264417317;41739.791301043304;41786.791066044476;41799.37300940428;41919.580804191566;241374;242576;242998;243440;244254;36592.81703591465;37769.62230377771;38621.227575448895;38874.22251555009;38879.41680874846;48006.5199348016;49681;49681;49745.502544974086;50082.2487662678;36312.27375452529;36657;36706.8164659175;37175.81412092922;37387.06532336713;36401.27197455983;36829.63170368262;36830.26339473142;36836.63163368332;36845.26309473849;41131.58868411277;41460.1707965833;41600.79199603983;41658.1668366637;41672.79163604163;35192.472112917814;35308;35572.64427355797;35597.82201088978;35640.28719425649;27274.04540841061;27304.044358447358;27388.315292117855;27392.315192120357;27950.58074128849 18:11:44 INFO - PID 3788 | |2;jquery.html;591.8254115036063;596.6539407143857;610.8472881779558;632.4181752787435;641.7978336823902;23058.76941230587;23912.04351825925;23981.880090599567;23989.880050599768;24029.519409611818;24602.75397246027;26320.552369619712;26500.204993850166;26501.602475962827;26535.601965970476;6682.164729408824;6855.211650660188;6860.142482189726;6870.587764734107;6873.553219040771;6538.705758240867;6796.048553202556;6871.690773915161;6890.517663763539;6897.137857767779;6801.897971530406;6820.215675197366;6824.965875170642;6827.453803695693;6827.52207345486;6589.242237142694;6838.589684618939;6841.3842754152365;6841.486888483359;6842.589444633313;6398.200224971879;6431.292557818636;6437.452816510602;6443.677816109176;6446.516511261674;29768;30436.847815761;30443;30444.238894027825;30502.084937451913;2363.291012696184;2383.9642405363934;2397.9640305395433;2400.663907053014;2403.807695384365;20795;21249.36251912445;21414.464638384165;21610.567788644297;21613.351599452042;2560.244727805283;2584.37974886026;2654.1772050664354;2671.0918287782247;2679.5310820606314;127352;133433;146461;152505;152508;16088.356465741474;16881.40915067967;17025.744613830553;17176.656466870594;17265;25824.741752582235;25831.61252581213;25878;25927.74072259291;25996;10602.840957385646;10679.73300667474;10745.462726863781;10921.290116142425;10968.945155274172;9668.371555848847;9843.950780246196;9862.753431164136;9900.158486528582;9910.603575857029;9664.855027174597;9778.315517913677;9865.210783137332;10094.141997930112;10275.691729248134;2874.8275103493856;2887.945899746577;2925.546540286259;2949.7787665925143;2974.7471464925725;1048.1405247696969;1053.6206965492418;1075.7579544602402;1077.2459278505078;1081.9621313254;22080.116795328006;22091.447713807283;22101.557968840854;22172.55654886893;22272.109115635194;1113.8050841102936;1116.17403121691;1124.7244425115734;1124.8087825069758;1127.7124333294958;12111;12238.347823043952;12319;12359.443825027894;12384.690382740324;558700;572666;574180;608319;609458;118567;119247.40376298236;119907;121062;121845.39077304734;1230.1204638683205;1247.9376031198403;1250.5498020712537;1252.2111070025826;1253.4359538207843;19273.614527709087;19353.8064619352;19435.61128777445;19760.703589446457;19916;60090.39909601023;61103.69448152731;61487.692561536904;61995.690021549606;63309.36690633219;74095.62952185204;74186;74464.62767686127;74781.6260918692;76227.237727622;15736.449224277554;15793.36826526926;15967.760483592987;16026.358945642043;16037.117958512394;23980.40048998789;24006.87996560006;24125.155619553232;24303.14938977127;24356;19492.8050719491;19983.300584479475;20030.098645560694;20121.2957546491;20149.39551813448;16555.50333489997;16589.17054147312;17040.06279654631;17256;17832;20273.898630506752;20504.58990820205;20524.486887827923;20652.277170299567;20730.27444039512;15621.14083725406;15730.606734831721;15772.60568485797;15811.051336919822;15819.209039548206;18954.52613684669;19632.90183549073;19759.60480790405;19796.703049454558;19835.30576429818 18:11:44 INFO - PID 3788 | |3;mootools.html;1445.1473630557969;1548.3110016042858;1555.2379334126274;1564.0303012132479;1573.370651739304;16839.326426942924;17550.648987020253;17557.91221043893;17567.64864702705;17605.11974401278;17228.655426891484;17278.22247998843;17300.740488892676;17335.91332043341;17376.478705638852;2780.8748606312765;2827.5051865923433;2858.728420800031;2865.1261365283685;2865.7707383409384;2614.372550587864;2640.9964213598805;2644.0877897125556;2648.4967856107373;2657.4419371931917;2392.497575509145;2520.5715028445206;2582.1349847801007;2584.7673709366154;2592.62406950992;2600.1289567994745;2607.5958226474927;2620.6331113644105;2621.5019146362224;2639.326971622243;2576.1369941069765;2579.8968041278326;2591.7796987256106;2598.8960441582312;2602.3103877472486;16631;16706.331746730117;16762;16799.580010499714;16919.91540042292;8573.399862009663;8816.426932249384;8820.029796722356;8842;8854.468731876108;5518.530924871391;5752.0796672532615;5781.855453613652;5848.356680765112;5863.912041319383;2175.8368122390884;2181.2365672014826;2201.5376770878133;2205.8235341172826;2240.3950933248093;30307.545386819216;30375.544366834514;30532;30548.54177187366;30565.388692226254;7325.853482930312;7356;7400.185979542246;7447.88828167578;7517.398608111447;19590.412287631392;19592.804071959385;19598;19613.21547138127;19645.214191432184;8623.094575069654;8630.611622477003;8636.611352489153;8640.827183456422;8648.1784230498;7779.57212353326;7787.649555770004;7807.843843123106;8022.318102961313;8041.517508949481;5411.431799660979;5547.223388725582;5590.5248053915875;5642.589352661835;5650.180723795027;1424.8387564135196;1640.1799100449775;1655.6026553627044;1664.8251933547047;1688.8480036796748;861.0528418739336;970.1511177719495;976.9218462522981;980.7008862297068;998.4059484606647;8155.184481551916;8246;8249.133840946733;8405.453645513022;8527.786805329792;1055.1822337688352;1055.3667799320347;1057.0803401041144;1081.8864019277862;1092.808758467265;5156.458571849977;5157.123289040872;5185.066687996122;5200.583953283728;5252.816151434758;24324.148654796998;24971;25529.61705574418;25590;25748.227553173434;23564.7643523566;24646.50706985886;24902.252932412055;24914.750852491605;25046.499070018497;12588.748225035448;12743.299118548568;12774.978001760022;12782.872171278354;12846.550370736979;9176.816463670822;9264;9286.72139835806;9312.813743724952;9344.579493922925;20455.8977205113;20711;21004.159833607097;21560.353189404344;21857.562848743255;21653.891730541876;21738.239161629266;21813.78186218181;21825.126994920025;22080.668789967844;12082;12269.202501837352;12351.135420520477;12381.442835072623;12383.814242786186;15237.847621523642;15306.311215995529;15449.691006180039;15560;15569.221538922782;12437.37813109359;12760.489580416679;12851.357432128543;13034.739305214032;13226.4048117833;12014.63956081319;12045.277283363026;12235.265884046985;12528.874711253135;12705.301208433255;10348.275620706478;10401.271910966463;10478.161747060369;10484.528196231035;10495.79008419812;7862.882056769038;8029.558374289237;8076.4750291230885;8111.756647300354;8166.387520936072;8011.559364234789;8155.5514446706;8181.263686268265;8264.504129752235;8295.792605184919 18:11:44 INFO - PID 3788 | |4;prototype.html;561.9803306884259;562.878981019081;569.7293785451911;581.5227132415907;582.8630271886107;5800.361960184377;6087.482563982061;6198.44214020738;6229.283632382278;6302.888532341671;6101.755929762815;6111.297200821907;6111.7249723762425;6166.229221347332;6205;4915.459299477055;4972.726500042496;4992.151334273164;5003.17447621142;5016.824411145611;4991.276264941581;5010.549050585447;5015.799368025275;5035.974820125894;5055.797768089272;4926.797581571971;4963.677360971526;4966.106100901836;4967.379077615298;4969.478204788499;4926.507349265081;4930.161872481651;4952;4958.9752051239875;4965.205567109281;4523.140603285398;4539.682222244412;4561.863144105682;4595.655325850541;4606.746628935407;6119.938800611982;6148.6925653717135;6174.289956654998;6187.628742275478;6264.6241225526155;5794.478496935296;5803.622764520293;5808.506276966463;5858.619189752652;5867.677277749722;6607.834804129887;6615.338466153395;6655.46756259498;6693.732250709966;6704.865902681919;4838.758062096881;5064.164412871872;5064.772085256172;5073.137566613685;5108.923366149511;6688.498362622774;6779.5932244065025;6796.728130874759;6920.792376228721;6970.999999999949;5194.948050519446;5209.947900521022;5211.530962213419;5218.66078704883;5230.790768369298;5230.476952304815;5274.97362513185;5300.575953923677;5323.520883120537;5330.626856120034;5758.827235182951;5759.6832174229985;5778.393268706809;5791.160281759121;5791.9710401448565;6629.784554491068;6631.3700198481065;6651.334866513407;6689.665516724242;6709.698063587052;1772.929082836698;1798.5162241151102;1819.3814103204975;1823.4165067178642;1830.9450716478527;1231.5381731850557;1291.689994401337;1297.3967105296083;1302.2419733359889;1315.0925861155772;6172.6913654318005;6186.845328866724;6207.193064901534;6218.440340369389;6250.624962502265;6650.135482387259;6671.666416679243;6677;6711.395974362331;6738.460923126138;6198.721057552421;6213.596116252429;6233.158523599256;6260.186175797117;6261.937380626136;3575.213453040327;3576.195356044869;3576.946345804815;3588.1209103769743;3589.6410358964417;7012.439004879598;7016.403605693471;7038.788836334918;7048.647567621599;7091.539049961736;6924.6537673116145;6948.409385202213;6981.965090174516;6991.265917078736;6995.93004069963;7033.226345101933;7057.541259818096;7073.257307982691;7082.504224704221;7087.858242835217;6641.369069938348;6674.833129171615;6718;6750.1562304711915;6758.594484330759;6515.967420162869;6671.33286671329;6677.198736151498;6707.4969377297875;6722.428593569602;6911.654417279216;6933.341332573397;6961.477889158232;7004.334588214111;7061.6469176542;5138.409082955508;5172.9741351293005;5195.012947540106;5223.216517522402;5228.921566176587;6625.635590042594;6742.86514269702;6792.456603471612;6818.727250909908;6829.190264579791;6291.653959032297;6465.935340646533;6498.967505162444;6551.115599394211;6561.245456772533;6484.157059582413;6550.641768963264;6560.803175904731;6581.835454113685;6604.589324896282;6422.710978005907;6454.1609590752905;6471.417572418505;6534.869302614016;6572.145621069421;6528.314526974599;6688.163979502562;6694.230163531061;6695.966520167368;6711.127553418024;6349.142865713255;6433.903491447726;6440.871182576228;6459.741610335534;6507.609543427409 18:11:44 INFO - PID 3788 | |5;yui.html;953.2897990996709;967.6274634265808;975.8341082016057;987.1855719031801;994.0655783563452;17961.640767184665;18247.452576422696;23215.187468438588;23815.404614884592;23855.76144238557;19993.400197994048;20002.199912003503;20051.398458046282;20390.490237744063;20485.897570512163;977.3207620703614;983.8671779309773;990.2375171118234;991.7173605522428;993.92545559083;1038.8026275007762;1071.539238127605;1077.6713102503734;1088.7985722641297;1088.9564417423294;1119.289251325406;1119.5074167366374;1120.025577747357;1121.3776354123459;1121.4673030310619;1110.6945589962745;1116.419461879822;1117.251441534174;1117.776444711061;1119.1326721790597;817.0522194254695;817.9509229446252;818.0960039156765;818.7666515043244;818.8526065308242;19497.902510487358;20384.28654997068;20401.8979905101;20571.5885682287;20584.485387865272;22051.66922496164;22238.444038898997;22528.43678908024;22582.88708556463;22612.77387226123;17824;17850.821491785176;17942.282308707636;18000.36998705039;18031.188596513057;3725.9068523286865;3770.057485628593;3841.154945911895;3853.325668008087;3865.903352416184;152171;153041;154889;154942.22528887397;155829;17480;17625.647487050188;17663.558411039827;17694.823051769574;17753.467395978143;26459.47081058368;26653.20040398791;30392.240193995327;33656.663433365844;33833.83083084569;9058.094190580889;9117.589708463134;9212.723618291462;9252.444853308823;9303.488308143116;4431.556844315543;4734.479207287196;4821.325014497973;4860.562549370574;4896.2655601660035;6230.221222347207;6256.562040657202;6305.527085468608;6320.641062171655;6343.873122537523;1108.8225883858706;1136.1649187846926;1141.8858114188515;1144.210494758614;1153.0544953138515;689.8309914070984;696.8397268628142;698.8392669685899;702.0767690486994;705.3581241070601;12688.429020694091;12734.61796146117;12996.545120920722;13114.278714670785;13224.933875330562;691.4952084977893;700.8808502554577;702.1574111066741;714.6248219684708;716.0262043620671;6003.249593800775;6097.878042439126;6152.477039451607;6159.6612186329285;6163;148267.258663706;148536;148645;148700;149098;132996;134402.91978101683;135919.32040339932;136401.3179934094;141841;115279;115404;115853.8414615843;116473;117068;11661.591844285409;11752.764944700886;11778.46996885125;11785.764284714429;11885.930266276077;52934.61794219192;53058;53242.935141297734;54843.45156548383;55505.44494555003;65870.67064664837;66975.66512167602;67391.32608673851;67678.32321676917;69917.30082699108;15580.143092130042;15884.60288492797;15997.840021599635;16051.759223611421;16066.116363600115;17978.2808687651;18043.458696239133;18139.90930045341;18232.90883545574;18331.816681833545;16382.262798173871;16858;16932;16978;17033.233504492575;15922.522324330288;16018;16120.596985075466;16191;16240.837591624406;16181.1100389475;16241.187940602686;16446.177691115634;16526.752098718287;16552.172391380143;13222.735545289233;13462.192268463923;13508.392122354715;13512.324383780575;13542.322883855964;12970.675733106747;13120.803187952379;13159.93420032932;13253.337333133497;13309.068365214342 18:11:44 INFO - PID 3788 | __end_tp_report 18:11:44 INFO - PID 3788 | __start_cc_report 18:11:44 INFO - PID 3788 | _x_x_mozilla_cycle_collect,265 18:11:44 INFO - PID 3788 | __end_cc_report 18:11:44 INFO - PID 3788 | __startTimestamp1506301904877__endTimestamp 18:11:44 INFO - PID 3788 | 18:11:44 INFO - PID 3788 | ------- Summary: start ------- 18:11:44 INFO - PID 3788 | Number of tests: 6 18:11:44 INFO - PID 3788 | 18:11:44 INFO - PID 3788 | [#0] dojo.html Cycles:165 Average:6299.44 Median:6573.31 stddev:740.98 (11.3%) stddev-sans-first:717.95 18:11:44 INFO - PID 3788 | Values: 3852.4 3878.0 3913.0 3918.2 3933.9 6109.8 6217.5 6231.1 6274.5 6319.7 6295.7 6302.5 6319.8 6344.8 6345.5 5639.4 5649.2 5652.7 5671.2 5692.7 5691.3 5740.1 5763.4 5781.9 5809.0 5651.3 5712.9 5733.0 5737.6 5774.5 5436.6 5565.6 5576.4 5661.6 5703.5 5481.7 5601.8 5631.0 5667.9 5689.3 6222.3 6222.3 6233.2 6293.8 6301.6 6675.9 6741.2 6771.8 6791.2 6853.0 6831.2 6847.9 6855.1 6860.0 6862.8 6293.2 6386.8 6437.1 6439.5 6458.9 7004.9 7011.6 7019.7 7030.1 7115.8 6615.9 6737.8 6786.7 6856.5 6871.5 6790.4 6855.1 6867.6 6870.0 6907.5 6746.9 6829.9 6899.4 6906.2 6918.6 6847.1 6856.3 6861.1 6953.0 6962.2 4878.1 4911.8 4975.1 5051.5 5082.4 4473.2 4605.7 4650.8 4662.3 4668.4 6323.6 6346.7 6422.7 6426.9 6443.6 6562.3 6722.2 6747.0 6855.6 6927.4 6372.4 6440.1 6440.7 6450.7 6451.4 5525.1 5538.6 5604.5 5618.9 5639.7 6974.2 7046.0 7069.1 7070.2 7098.6 6756.1 6770.1 6771.3 6775.6 6779.3 6979.4 7037.9 7065.2 7156.8 7184.6 6791.9 6800.6 6845.9 6860.2 6885.2 6586.2 6734.9 6865.7 6865.9 6985.8 6596.2 6603.0 6605.5 6606.4 6608.4 6538.6 6621.3 6621.4 6632.8 6644.0 6573.3 6654.3 6658.0 6679.0 6692.8 6597.9 6701.9 6728.9 6809.2 6823.7 6361.8 6470.4 6470.6 6524.0 6535.5 18:11:44 INFO - PID 3788 | 18:11:44 INFO - PID 3788 | [#1] ext.html Cycles:180 Average:43056.05 Median:3832.13 stddev:64705.14 (1688.5%) stddev-sans-first:64809.44 18:11:44 INFO - PID 3788 | Values: 957.1 986.6 990.6 994.3 995.4 40389.8 44473.6 44551.8 44635.1 44661.0 41022.0 41204.4 41332.0 41354.8 41390.4 7522.6 7566.5 7567.0 7575.7 7576.7 7544.6 7577.4 7580.7 7625.7 7684.5 7628.0 7706.8 7718.5 8408.0 8527.7 8481.5 8548.5 8551.4 8551.7 8553.2 8445.0 8454.5 8459.9 8496.0 8496.9 40027.4 40055.0 41024.8 41031.2 41261.2 3768.9 3777.7 3824.3 3824.9 3839.4 34345.8 34574.5 34774.7 34827.3 34873.3 5430.1 5489.0 5497.8 5503.0 5511.2 220934.0 221505.0 221798.0 222061.9 223721.0 47836.3 48531.0 53882.2 54011.5 54203.0 56830.4 57245.7 57255.4 57304.7 57305.0 17042.3 17059.4 17101.0 17124.0 17160.8 13812.4 13867.0 13886.2 13907.0 13923.6 15551.6 15560.1 15576.6 15749.3 15808.4 4799.5 4934.3 4965.9 4991.5 5022.9 1114.0 1120.0 1138.1 1141.1 1145.6 25627.5 26024.9 26180.3 26240.0 26281.0 1223.0 1226.3 1234.6 1240.9 1244.1 13908.2 13965.5 13977.3 14024.3 14050.8 268172.0 277910.0 282419.0 282801.0 282855.0 57594.0 57811.4 58073.4 58250.7 58339.7 1507.4 1565.4 1567.4 1572.3 1573.1 25514.6 25514.7 25573.6 25676.4 25689.5 41735.6 41739.8 41786.8 41799.4 41919.6 241374.0 242576.0 242998.0 243440.0 244254.0 36592.8 37769.6 38621.2 38874.2 38879.4 48006.5 49681.0 49681.0 49745.5 50082.2 36312.3 36657.0 36706.8 37175.8 37387.1 36401.3 36829.6 36830.3 36836.6 36845.3 41131.6 41460.2 41600.8 41658.2 41672.8 35192.5 35308.0 35572.6 35597.8 35640.3 27274.0 27304.0 27388.3 27392.3 27950.6 18:11:44 INFO - PID 3788 | 18:11:44 INFO - PID 3788 | [#2] jquery.html Cycles:180 Average:38640.69 Median:13155.00 stddev:97519.59 (741.3%) stddev-sans-first:97751.31 18:11:44 INFO - PID 3788 | Values: 591.8 596.7 610.8 632.4 641.8 23058.8 23912.0 23981.9 23989.9 24029.5 24602.8 26320.6 26500.2 26501.6 26535.6 6682.2 6855.2 6860.1 6870.6 6873.6 6538.7 6796.0 6871.7 6890.5 6897.1 6801.9 6820.2 6825.0 6827.5 6827.5 6589.2 6838.6 6841.4 6841.5 6842.6 6398.2 6431.3 6437.5 6443.7 6446.5 29768.0 30436.8 30443.0 30444.2 30502.1 2363.3 2384.0 2398.0 2400.7 2403.8 20795.0 21249.4 21414.5 21610.6 21613.4 2560.2 2584.4 2654.2 2671.1 2679.5 127352.0 133433.0 146461.0 152505.0 152508.0 16088.4 16881.4 17025.7 17176.7 17265.0 25824.7 25831.6 25878.0 25927.7 25996.0 10602.8 10679.7 10745.5 10921.3 10968.9 9668.4 9844.0 9862.8 9900.2 9910.6 9664.9 9778.3 9865.2 10094.1 10275.7 2874.8 2887.9 2925.5 2949.8 2974.7 1048.1 1053.6 1075.8 1077.2 1082.0 22080.1 22091.4 22101.6 22172.6 22272.1 1113.8 1116.2 1124.7 1124.8 1127.7 12111.0 12238.3 12319.0 12359.4 12384.7 558700.0 572666.0 574180.0 608319.0 609458.0 118567.0 119247.4 119907.0 121062.0 121845.4 1230.1 1247.9 1250.5 1252.2 1253.4 19273.6 19353.8 19435.6 19760.7 19916.0 60090.4 61103.7 61487.7 61995.7 63309.4 74095.6 74186.0 74464.6 74781.6 76227.2 15736.4 15793.4 15967.8 16026.4 16037.1 23980.4 24006.9 24125.2 24303.1 24356.0 19492.8 19983.3 20030.1 20121.3 20149.4 16555.5 16589.2 17040.1 17256.0 17832.0 20273.9 20504.6 20524.5 20652.3 20730.3 15621.1 15730.6 15772.6 15811.1 15819.2 18954.5 19632.9 19759.6 19796.7 19835.3 18:11:44 INFO - PID 3788 | 18:11:44 INFO - PID 3788 | [#3] mootools.html Cycles:180 Average:10391.14 Median:25669.11 stddev:7743.68 (30.2%) stddev-sans-first:7736.24 18:11:44 INFO - PID 3788 | Values: 1445.1 1548.3 1555.2 1564.0 1573.4 16839.3 17550.6 17557.9 17567.6 17605.1 17228.7 17278.2 17300.7 17335.9 17376.5 2780.9 2827.5 2858.7 2865.1 2865.8 2614.4 2641.0 2644.1 2648.5 2657.4 2392.5 2520.6 2582.1 2584.8 2592.6 2600.1 2607.6 2620.6 2621.5 2639.3 2576.1 2579.9 2591.8 2598.9 2602.3 16631.0 16706.3 16762.0 16799.6 16919.9 8573.4 8816.4 8820.0 8842.0 8854.5 5518.5 5752.1 5781.9 5848.4 5863.9 2175.8 2181.2 2201.5 2205.8 2240.4 30307.5 30375.5 30532.0 30548.5 30565.4 7325.9 7356.0 7400.2 7447.9 7517.4 19590.4 19592.8 19598.0 19613.2 19645.2 8623.1 8630.6 8636.6 8640.8 8648.2 7779.6 7787.6 7807.8 8022.3 8041.5 5411.4 5547.2 5590.5 5642.6 5650.2 1424.8 1640.2 1655.6 1664.8 1688.8 861.1 970.2 976.9 980.7 998.4 8155.2 8246.0 8249.1 8405.5 8527.8 1055.2 1055.4 1057.1 1081.9 1092.8 5156.5 5157.1 5185.1 5200.6 5252.8 24324.1 24971.0 25529.6 25590.0 25748.2 23564.8 24646.5 24902.3 24914.8 25046.5 12588.7 12743.3 12775.0 12782.9 12846.6 9176.8 9264.0 9286.7 9312.8 9344.6 20455.9 20711.0 21004.2 21560.4 21857.6 21653.9 21738.2 21813.8 21825.1 22080.7 12082.0 12269.2 12351.1 12381.4 12383.8 15237.8 15306.3 15449.7 15560.0 15569.2 12437.4 12760.5 12851.4 13034.7 13226.4 12014.6 12045.3 12235.3 12528.9 12705.3 10348.3 10401.3 10478.2 10484.5 10495.8 7862.9 8029.6 8076.5 8111.8 8166.4 8011.6 8155.6 8181.3 8264.5 8295.8 18:11:44 INFO - PID 3788 | 18:11:44 INFO - PID 3788 | [#4] prototype.html Cycles:180 Average:5627.14 Median:6210.39 stddev:1571.99 (25.3%) stddev-sans-first:1529.74 18:11:44 INFO - PID 3788 | Values: 562.0 562.9 569.7 581.5 582.9 5800.4 6087.5 6198.4 6229.3 6302.9 6101.8 6111.3 6111.7 6166.2 6205.0 4915.5 4972.7 4992.2 5003.2 5016.8 4991.3 5010.5 5015.8 5036.0 5055.8 4926.8 4963.7 4966.1 4967.4 4969.5 4926.5 4930.2 4952.0 4959.0 4965.2 4523.1 4539.7 4561.9 4595.7 4606.7 6119.9 6148.7 6174.3 6187.6 6264.6 5794.5 5803.6 5808.5 5858.6 5867.7 6607.8 6615.3 6655.5 6693.7 6704.9 4838.8 5064.2 5064.8 5073.1 5108.9 6688.5 6779.6 6796.7 6920.8 6971.0 5194.9 5209.9 5211.5 5218.7 5230.8 5230.5 5275.0 5300.6 5323.5 5330.6 5758.8 5759.7 5778.4 5791.2 5792.0 6629.8 6631.4 6651.3 6689.7 6709.7 1772.9 1798.5 1819.4 1823.4 1830.9 1231.5 1291.7 1297.4 1302.2 1315.1 6172.7 6186.8 6207.2 6218.4 6250.6 6650.1 6671.7 6677.0 6711.4 6738.5 6198.7 6213.6 6233.2 6260.2 6261.9 3575.2 3576.2 3576.9 3588.1 3589.6 7012.4 7016.4 7038.8 7048.6 7091.5 6924.7 6948.4 6982.0 6991.3 6995.9 7033.2 7057.5 7073.3 7082.5 7087.9 6641.4 6674.8 6718.0 6750.2 6758.6 6516.0 6671.3 6677.2 6707.5 6722.4 6911.7 6933.3 6961.5 7004.3 7061.6 5138.4 5173.0 5195.0 5223.2 5228.9 6625.6 6742.9 6792.5 6818.7 6829.2 6291.7 6465.9 6499.0 6551.1 6561.2 6484.2 6550.6 6560.8 6581.8 6604.6 6422.7 6454.2 6471.4 6534.9 6572.1 6528.3 6688.2 6694.2 6696.0 6711.1 6349.1 6433.9 6440.9 6459.7 6507.6 18:11:44 INFO - PID 3788 | 18:11:44 INFO - PID 3788 | [#5] yui.html Cycles:180 Average:27783.67 Median:18015.78 stddev:42018.90 (233.2%) stddev-sans-first:42088.48 18:11:44 INFO - PID 3788 | Values: 953.3 967.6 975.8 987.2 994.1 17961.6 18247.5 23215.2 23815.4 23855.8 19993.4 20002.2 20051.4 20390.5 20485.9 977.3 983.9 990.2 991.7 993.9 1038.8 1071.5 1077.7 1088.8 1089.0 1119.3 1119.5 1120.0 1121.4 1121.5 1110.7 1116.4 1117.3 1117.8 1119.1 817.1 818.0 818.1 818.8 818.9 19497.9 20384.3 20401.9 20571.6 20584.5 22051.7 22238.4 22528.4 22582.9 22612.8 17824.0 17850.8 17942.3 18000.4 18031.2 3725.9 3770.1 3841.2 3853.3 3865.9 152171.0 153041.0 154889.0 154942.2 155829.0 17480.0 17625.6 17663.6 17694.8 17753.5 26459.5 26653.2 30392.2 33656.7 33833.8 9058.1 9117.6 9212.7 9252.4 9303.5 4431.6 4734.5 4821.3 4860.6 4896.3 6230.2 6256.6 6305.5 6320.6 6343.9 1108.8 1136.2 1141.9 1144.2 1153.1 689.8 696.8 698.8 702.1 705.4 12688.4 12734.6 12996.5 13114.3 13224.9 691.5 700.9 702.2 714.6 716.0 6003.2 6097.9 6152.5 6159.7 6163.0 148267.3 148536.0 148645.0 148700.0 149098.0 132996.0 134402.9 135919.3 136401.3 141841.0 115279.0 115404.0 115853.8 116473.0 117068.0 11661.6 11752.8 11778.5 11785.8 11885.9 52934.6 53058.0 53242.9 54843.5 55505.4 65870.7 66975.7 67391.3 67678.3 69917.3 15580.1 15884.6 15997.8 16051.8 16066.1 17978.3 18043.5 18139.9 18232.9 18331.8 16382.3 16858.0 16932.0 16978.0 17033.2 15922.5 16018.0 16120.6 16191.0 16240.8 16181.1 16241.2 16446.2 16526.8 16552.2 13222.7 13462.2 13508.4 13512.3 13542.3 12970.7 13120.8 13159.9 13253.3 13309.1 18:11:44 INFO - PID 3788 | -------- Summary: end -------- 18:11:44 INFO - PID 3788 | 18:11:45 INFO - TEST-INFO | 3788: exit 0 18:11:45 INFO - TEST-OK | dromaeo_css | took 1112426ms 18:11:45 INFO - TEST-START | kraken 18:11:45 INFO - Initialising browser for kraken test... 18:11:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51646/getInfo.html -profile /tmp/tmpyfmpLG/profile 18:11:45 INFO - TEST-INFO | started process 4157 (/builds/slave/test/build/application/firefox/firefox http://localhost:51646/getInfo.html) 18:11:50 INFO - TEST-INFO | 4157: exit 0 18:11:50 INFO - Browser initialized. 18:11:50 INFO - Running cycle 1/1 for kraken test... 18:11:50 INFO - Using env: {'DISPLAY': ':0', 18:11:50 INFO - 'HOME': '/home/cltbld', 18:11:50 INFO - 'JSGC_DISABLE_POISONING': '1', 18:11:50 INFO - 'LANG': 'en_US.UTF-8', 18:11:50 INFO - 'LANGUAGE': 'en_US:en', 18:11:50 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:11:50 INFO - 'LOGNAME': 'cltbld', 18:11:51 INFO - 'MAIL': '/var/mail/cltbld', 18:11:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:11:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:11:51 INFO - 'MOZ_CRASHREPORTER': '1', 18:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:51 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:11:51 INFO - 'MOZ_NO_REMOTE': '1', 18:11:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:51 INFO - 'NO_EM_RESTART': '1', 18:11:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:51 INFO - 'PWD': '/builds/slave/test', 18:11:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:11:51 INFO - 'RUST_BACKTRACE': 'full', 18:11:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:11:51 INFO - 'SHELL': '/bin/bash', 18:11:51 INFO - 'SHLVL': '1', 18:11:51 INFO - 'STYLO_FORCE_DISABLED': '1', 18:11:51 INFO - 'TERM': 'linux', 18:11:51 INFO - 'TMOUT': '86400', 18:11:51 INFO - 'USER': 'cltbld', 18:11:51 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154', 18:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:51 INFO - '_': '/tools/buildbot/bin/python'} 18:11:51 INFO - TEST-INFO | started process 4397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyfmpLG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:11:51 INFO - PID 4397 | 18:11:51 INFO - PID 4397 | (/builds/slave/test/build/application/firefox/firefox:4447): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:11:51 INFO - PID 4397 | 18:12:02 INFO - PID 4397 | RSS: Main: 144113664 18:12:02 INFO - PID 4397 | 18:12:04 INFO - PID 4397 | Cycle 1(1): loaded http://localhost:51646/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51646/tests/kraken/driver.html?testName=audio-beat-detection) 18:12:05 INFO - PID 4397 | RSS: Main: 151511040 18:12:05 INFO - PID 4397 | 18:12:08 INFO - PID 4397 | Cycle 1(1): loaded http://localhost:51646/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51646/tests/kraken/driver.html?testName=audio-dft) 18:12:08 INFO - PID 4397 | RSS: Main: 151625728 18:12:08 INFO - PID 4397 | 18:12:11 INFO - PID 4397 | Cycle 1(1): loaded http://localhost:51646/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51646/tests/kraken/driver.html?testName=audio-fft) 18:12:12 INFO - PID 4397 | RSS: Main: 147292160 18:12:12 INFO - PID 4397 | 18:12:14 INFO - PID 4397 | Cycle 1(1): loaded http://localhost:51646/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51646/tests/kraken/driver.html?testName=audio-oscillator) 18:12:14 INFO - PID 4397 | RSS: Main: 148008960 18:12:14 INFO - PID 4397 | 18:12:16 INFO - PID 4397 | Cycle 1(1): loaded http://localhost:51646/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51646/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:12:17 INFO - PID 4397 | RSS: Main: 148254720 18:12:17 INFO - PID 4397 | 18:12:20 INFO - PID 4397 | Cycle 1(1): loaded http://localhost:51646/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51646/tests/kraken/driver.html?testName=imaging-darkroom) 18:12:21 INFO - PID 4397 | RSS: Main: 148111360 18:12:21 INFO - PID 4397 | 18:12:24 INFO - PID 4397 | Cycle 1(1): loaded http://localhost:51646/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51646/tests/kraken/driver.html?testName=imaging-desaturate) 18:12:25 INFO - PID 4397 | RSS: Main: 149852160 18:12:25 INFO - PID 4397 | 18:12:28 INFO - PID 4397 | Cycle 1(1): loaded http://localhost:51646/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51646/tests/kraken/driver.html?testName=json-parse-financial) 18:12:28 INFO - PID 4397 | RSS: Main: 150827008 18:12:28 INFO - PID 4397 | 18:12:30 INFO - PID 4397 | Cycle 1(1): loaded http://localhost:51646/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51646/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:12:30 INFO - PID 4397 | RSS: Main: 150622208 18:12:30 INFO - PID 4397 | 18:12:32 INFO - PID 4397 | Cycle 1(1): loaded http://localhost:51646/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51646/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:12:33 INFO - PID 4397 | RSS: Main: 150859776 18:12:33 INFO - PID 4397 | 18:12:35 INFO - PID 4397 | Cycle 1(1): loaded http://localhost:51646/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51646/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:12:35 INFO - PID 4397 | RSS: Main: 147841024 18:12:35 INFO - PID 4397 | 18:12:38 INFO - PID 4397 | Cycle 1(1): loaded http://localhost:51646/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:12:38 INFO - PID 4397 | RSS: Main: 147996672 18:12:38 INFO - PID 4397 | 18:12:41 INFO - PID 4397 | Cycle 1(1): loaded http://localhost:51646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:12:42 INFO - PID 4397 | RSS: Main: 148381696 18:12:42 INFO - PID 4397 | 18:12:43 INFO - PID 4397 | Cycle 1(1): loaded http://localhost:51646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51646/tests/kraken/driver.html?testName=ai-astar) 18:12:44 INFO - PID 4397 | RSS: Main: 149659648 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | __start_tp_report 18:12:44 INFO - PID 4397 | _x_x_mozilla_page_load 18:12:44 INFO - PID 4397 | _x_x_mozilla_page_load_details 18:12:44 INFO - PID 4397 | |i|pagename|runs| 18:12:44 INFO - PID 4397 | |0;ai-astar;106;104;107;105;105;96;107;107;105;104 18:12:44 INFO - PID 4397 | |1;audio-beat-detection;117;113;116;120;113;116;138;119;119;113 18:12:44 INFO - PID 4397 | |2;audio-dft;162;162;163;162;160;161;162;163;163;172 18:12:44 INFO - PID 4397 | |3;audio-fft;73;73;74;74;72;75;73;74;73;76 18:12:44 INFO - PID 4397 | |4;audio-oscillator;78;87;78;77;78;77;78;78;79;79 18:12:44 INFO - PID 4397 | |5;imaging-gaussian-blur;115;113;113;114;114;113;114;114;115;115 18:12:44 INFO - PID 4397 | |6;imaging-darkroom;149;150;149;150;149;149;149;153;150;150 18:12:44 INFO - PID 4397 | |7;imaging-desaturate;95;94;96;94;95;94;94;94;95;95 18:12:44 INFO - PID 4397 | |8;json-parse-financial;57;44;43;45;46;44;43;43;43;44 18:12:44 INFO - PID 4397 | |9;json-stringify-tinderbox;37;37;36;38;36;37;37;37;36;37 18:12:44 INFO - PID 4397 | |10;stanford-crypto-aes;77;73;70;72;76;73;75;76;70;70 18:12:44 INFO - PID 4397 | |11;stanford-crypto-ccm;103;105;105;107;109;104;116;103;110;111 18:12:44 INFO - PID 4397 | |12;stanford-crypto-pbkdf2;162;168;153;150;151;149;152;151;153;148 18:12:44 INFO - PID 4397 | |13;stanford-crypto-sha256-iterative;60;60;61;71;68;61;59;58;64;61 18:12:44 INFO - PID 4397 | __end_tp_report 18:12:44 INFO - PID 4397 | __start_cc_report 18:12:44 INFO - PID 4397 | _x_x_mozilla_cycle_collect,729 18:12:44 INFO - PID 4397 | __end_cc_report 18:12:44 INFO - PID 4397 | __startTimestamp1506301964084__endTimestamp 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | ------- Summary: start ------- 18:12:44 INFO - PID 4397 | Number of tests: 14 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | [#0] ai-astar Cycles:10 Average:104.60 Median:106.50 stddev:3.24 (3.0%) stddev-sans-first:3.40 18:12:44 INFO - PID 4397 | Values: 106.0 104.0 107.0 105.0 105.0 96.0 107.0 107.0 105.0 104.0 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | [#1] audio-beat-detection Cycles:10 Average:118.40 Median:118.00 stddev:7.37 (6.2%) stddev-sans-first:7.80 18:12:44 INFO - PID 4397 | Values: 117.0 113.0 116.0 120.0 113.0 116.0 138.0 119.0 119.0 113.0 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:3.30 (2.0%) stddev-sans-first:3.48 18:12:44 INFO - PID 4397 | Values: 162.0 162.0 163.0 162.0 160.0 161.0 162.0 163.0 163.0 172.0 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | [#3] audio-fft Cycles:10 Average:73.70 Median:74.00 stddev:1.16 (1.6%) stddev-sans-first:1.20 18:12:44 INFO - PID 4397 | Values: 73.0 73.0 74.0 74.0 72.0 75.0 73.0 74.0 73.0 76.0 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | [#4] audio-oscillator Cycles:10 Average:78.90 Median:78.00 stddev:2.92 (3.7%) stddev-sans-first:3.08 18:12:44 INFO - PID 4397 | Values: 78.0 87.0 78.0 77.0 78.0 77.0 78.0 78.0 79.0 79.0 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 18:12:44 INFO - PID 4397 | Values: 115.0 113.0 113.0 114.0 114.0 113.0 114.0 114.0 115.0 115.0 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 18:12:44 INFO - PID 4397 | Values: 149.0 150.0 149.0 150.0 149.0 149.0 149.0 153.0 150.0 150.0 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 18:12:44 INFO - PID 4397 | Values: 95.0 94.0 96.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | [#8] json-parse-financial Cycles:10 Average:45.20 Median:44.00 stddev:4.26 (9.7%) stddev-sans-first:1.05 18:12:44 INFO - PID 4397 | Values: 57.0 44.0 43.0 45.0 46.0 44.0 43.0 43.0 43.0 44.0 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | [#9] json-stringify-tinderbox Cycles:10 Average:36.80 Median:37.00 stddev:0.63 (1.7%) stddev-sans-first:0.67 18:12:44 INFO - PID 4397 | Values: 37.0 37.0 36.0 38.0 36.0 37.0 37.0 37.0 36.0 37.0 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:74.00 stddev:2.70 (3.6%) stddev-sans-first:2.49 18:12:44 INFO - PID 4397 | Values: 77.0 73.0 70.0 72.0 76.0 73.0 75.0 76.0 70.0 70.0 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | [#11] stanford-crypto-ccm Cycles:10 Average:107.30 Median:108.00 stddev:4.19 (3.9%) stddev-sans-first:4.15 18:12:44 INFO - PID 4397 | Values: 103.0 105.0 105.0 107.0 109.0 104.0 116.0 103.0 110.0 111.0 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:152.50 stddev:6.33 (4.1%) stddev-sans-first:5.95 18:12:44 INFO - PID 4397 | Values: 162.0 168.0 153.0 150.0 151.0 149.0 152.0 151.0 153.0 148.0 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:61.00 stddev:4.16 (6.8%) stddev-sans-first:4.33 18:12:44 INFO - PID 4397 | Values: 60.0 60.0 61.0 71.0 68.0 61.0 59.0 58.0 64.0 61.0 18:12:44 INFO - PID 4397 | -------- Summary: end -------- 18:12:44 INFO - PID 4397 | 18:12:44 INFO - PID 4397 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:12:44 INFO - TEST-INFO | 4397: exit 0 18:12:44 INFO - TEST-OK | kraken | took 59150ms 18:12:44 INFO - SUITE-END | took 1171s 18:12:44 INFO - Completed test suite (00:19:31) 18:12:44 INFO - javascript benchmark 18:12:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9051.323380271424, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3852.4413959975786, 3877.9806100969495, 3912.9608703912954, 3918.157596116834, 3933.8623148189818, 6109.847253818646, 6217.471514921232, 6231.096491008801, 6274.466670333027, 6319.684015799215, 6295.653739044351, 6302.495800335973, 6319.842003949892, 6344.841378965528, 6345.524085693568, 5639.351474580435, 5649.180868774036, 5652.660840349572, 5671.234383358235, 5692.686902220376, 5691.288588926384, 5740.081586946089, 5763.366029736726, 5781.913271300934, 5809.04150815115, 5651.2653355063785, 5712.9428705713035, 5732.968065748164, 5737.569682273846, 5774.451427114438, 5436.592255580807, 5565.638233514849, 5576.358718747356, 5661.575381846378, 5703.486686198241, 5481.698506582136, 5601.775928962837, 5630.971845140789, 5667.914981275243, 5689.345725241567, 6222.253329600431, 6222.315545290015, 6233.2208473940755, 6293.811185664437, 6301.6219026858535, 6675.899861502081, 6741.224759152711, 6771.830704232384, 6791.151106111736, 6853.0, 6831.248562658104, 6847.897281540781, 6855.108835851357, 6859.965700171467, 6862.759803406857, 6293.213348331458, 6386.808395748135, 6437.0988061671405, 6439.452646525051, 6458.870822583569, 7004.859902802017, 7011.579305241702, 7019.719211231493, 7030.086088808423, 7115.786526404217, 6615.900761488581, 6737.797866064026, 6786.660666966632, 6856.520043597, 6871.518993670495, 6790.354916282945, 6855.143107111611, 6867.587944723333, 6870.003849441803, 6907.516473846883, 6746.898796518056, 6829.863402731918, 6899.448044156456, 6906.205786334636, 6918.584884906821, 6847.144106986627, 6856.348646878539, 6861.1080559526945, 6952.965235173791, 6962.164540255202, 4878.07316609843, 4911.7544122793715, 4975.104481193348, 5051.494850514919, 5082.390113186368, 4473.217186992263, 4605.746683932416, 4650.837220697327, 4662.277347011219, 4668.3697700810635, 6323.5573509854785, 6346.714397852015, 6422.743090276336, 6426.903596446057, 6443.613383197023, 6562.278149403562, 6722.159730033746, 6747.0, 6855.5886646801355, 6927.445804335641, 6372.36276372359, 6440.130582371414, 6440.67796610177, 6450.6774661266745, 6451.41937225652, 5525.143602741581, 5538.584606154554, 5604.523615492729, 5618.943810561842, 5639.661620302795, 6974.197967233732, 7046.048783414276, 7069.116360454943, 7070.222275549685, 7098.645067746592, 6756.054152418764, 6770.119884414995, 6771.289014653587, 6775.559588626724, 6779.288174741779, 6979.371856532734, 7037.929620703728, 7065.22282548909, 7156.785296441115, 7184.568925864465, 6791.864162716817, 6800.591964482147, 6845.897311540231, 6860.245373009065, 6885.242623311532, 6586.242582103119, 6734.898976515258, 6865.691043902936, 6865.897011544931, 6985.755498557526, 6596.175478065242, 6603.0, 6605.53761236728, 6606.372394622503, 6608.372204640552, 6538.640374779433, 6621.33786621334, 6621.370969757865, 6632.767853125118, 6643.966780166068, 6573.309802470863, 6654.301298363602, 6658.0, 6679.0315404267085, 6692.83267918306, 6597.901031484435, 6701.865962680817, 6728.899066513908, 6809.182898052265, 6823.692933817891, 6361.777337793155, 6470.38531339522, 6470.579412338183, 6524.021396790519, 6535.509836762167], "value": 6249.6539435801515, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [957.0812020460357, 986.6004268271353, 990.5938565188272, 994.3487016004519, 995.4425521707849, 40389.79805100974, 44473.55526444734, 44551.77724111379, 44635.107297854025, 44661.0, 41022.0, 41204.38193427093, 41332.0, 41354.7932260339, 41390.37914431286, 7522.623868806579, 7566.508176968507, 7566.962165189194, 7575.734849280277, 7576.659050342748, 7544.585047822395, 7577.431692623048, 7580.734674286401, 7625.694972201105, 7684.500507466997, 7627.961860190691, 7706.845863082735, 7718.459707820455, 8407.95796021022, 8527.701530446435, 8481.491110533389, 8548.487090774543, 8551.358648101417, 8551.743447696548, 8553.187447192508, 8444.957775211145, 8454.492730436132, 8459.915400845974, 8496.02295735992, 8496.915030849736, 40027.399589006185, 40055.0, 41024.79487602543, 41031.179376412605, 41261.1747765046, 3768.924621507582, 3777.697784177259, 3824.29250588642, 3824.8852534424013, 3839.36650452675, 34345.82827085849, 34574.481382779275, 34774.6522534774, 34827.30345393103, 34873.30253394918, 5430.0768869292315, 5489.0, 5497.752601132958, 5502.972485137549, 5511.22842802008, 220934.0, 221505.0, 221798.0, 222061.88969055214, 223721.0, 47836.28245576319, 48531.0, 53882.19176712353, 54011.459885401426, 54203.0, 56830.43169568334, 57245.71377143088, 57255.42744572584, 57304.713476433186, 57305.0, 17042.31830726782, 17059.402920897708, 17101.0, 17124.0, 17160.82839171617, 13812.447502100005, 13867.029307948347, 13886.166829990232, 13907.0, 13923.58229253124, 15551.611209719847, 15560.144192069545, 15576.610584735472, 15749.26758056613, 15808.36766529349, 4799.472058073609, 4934.259861020875, 4965.90068198634, 4991.450940396553, 5022.949770502321, 1113.9888601114046, 1119.9832002519968, 1138.1407037686658, 1141.14414189358, 1145.570411095839, 25627.48745025089, 26024.8698756505, 26180.345491362867, 26240.0, 26281.0, 1222.9938850305869, 1226.270369130366, 1234.6419538333962, 1240.8697086805755, 1244.104244943639, 13908.165510069226, 13965.511207107702, 13977.301134943416, 14024.298785060706, 14050.789238161437, 268172.0, 277910.0, 282419.0, 282801.0, 282855.0, 57594.0, 57811.42188578145, 58073.4192658068, 58250.70874645685, 58339.70830145907, 1507.4347119830063, 1565.420794306114, 1567.42005457979, 1572.3081843988837, 1573.0797483472068, 25514.617280740433, 25514.744852551237, 25573.616395754452, 25676.358091047874, 25689.486210276064, 41735.58264417317, 41739.791301043304, 41786.791066044476, 41799.37300940428, 41919.580804191566, 241374.0, 242576.0, 242998.0, 243440.0, 244254.0, 36592.81703591465, 37769.62230377771, 38621.227575448895, 38874.22251555009, 38879.41680874846, 48006.5199348016, 49681.0, 49681.0, 49745.502544974086, 50082.2487662678, 36312.27375452529, 36657.0, 36706.8164659175, 37175.81412092922, 37387.06532336713, 36401.27197455983, 36829.63170368262, 36830.26339473142, 36836.63163368332, 36845.26309473849, 41131.58868411277, 41460.1707965833, 41600.79199603983, 41658.1668366637, 41672.79163604163, 35192.472112917814, 35308.0, 35572.64427355797, 35597.82201088978, 35640.28719425649, 27274.04540841061, 27304.044358447358, 27388.315292117855, 27392.315192120357, 27950.58074128849], "value": 18788.087563205827, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.8254115036063, 596.6539407143857, 610.8472881779558, 632.4181752787435, 641.7978336823902, 23058.76941230587, 23912.04351825925, 23981.880090599567, 23989.880050599768, 24029.519409611818, 24602.75397246027, 26320.552369619712, 26500.204993850166, 26501.602475962827, 26535.601965970476, 6682.164729408824, 6855.211650660188, 6860.142482189726, 6870.587764734107, 6873.553219040771, 6538.705758240867, 6796.048553202556, 6871.690773915161, 6890.517663763539, 6897.137857767779, 6801.897971530406, 6820.215675197366, 6824.965875170642, 6827.453803695693, 6827.52207345486, 6589.242237142694, 6838.589684618939, 6841.3842754152365, 6841.486888483359, 6842.589444633313, 6398.200224971879, 6431.292557818636, 6437.452816510602, 6443.677816109176, 6446.516511261674, 29768.0, 30436.847815761, 30443.0, 30444.238894027825, 30502.084937451913, 2363.291012696184, 2383.9642405363934, 2397.9640305395433, 2400.663907053014, 2403.807695384365, 20795.0, 21249.36251912445, 21414.464638384165, 21610.567788644297, 21613.351599452042, 2560.244727805283, 2584.37974886026, 2654.1772050664354, 2671.0918287782247, 2679.5310820606314, 127352.0, 133433.0, 146461.0, 152505.0, 152508.0, 16088.356465741474, 16881.40915067967, 17025.744613830553, 17176.656466870594, 17265.0, 25824.741752582235, 25831.61252581213, 25878.0, 25927.74072259291, 25996.0, 10602.840957385646, 10679.73300667474, 10745.462726863781, 10921.290116142425, 10968.945155274172, 9668.371555848847, 9843.950780246196, 9862.753431164136, 9900.158486528582, 9910.603575857029, 9664.855027174597, 9778.315517913677, 9865.210783137332, 10094.141997930112, 10275.691729248134, 2874.8275103493856, 2887.945899746577, 2925.546540286259, 2949.7787665925143, 2974.7471464925725, 1048.1405247696969, 1053.6206965492418, 1075.7579544602402, 1077.2459278505078, 1081.9621313254, 22080.116795328006, 22091.447713807283, 22101.557968840854, 22172.55654886893, 22272.109115635194, 1113.8050841102936, 1116.17403121691, 1124.7244425115734, 1124.8087825069758, 1127.7124333294958, 12111.0, 12238.347823043952, 12319.0, 12359.443825027894, 12384.690382740324, 558700.0, 572666.0, 574180.0, 608319.0, 609458.0, 118567.0, 119247.40376298236, 119907.0, 121062.0, 121845.39077304734, 1230.1204638683205, 1247.9376031198403, 1250.5498020712537, 1252.2111070025826, 1253.4359538207843, 19273.614527709087, 19353.8064619352, 19435.61128777445, 19760.703589446457, 19916.0, 60090.39909601023, 61103.69448152731, 61487.692561536904, 61995.690021549606, 63309.36690633219, 74095.62952185204, 74186.0, 74464.62767686127, 74781.6260918692, 76227.237727622, 15736.449224277554, 15793.36826526926, 15967.760483592987, 16026.358945642043, 16037.117958512394, 23980.40048998789, 24006.87996560006, 24125.155619553232, 24303.14938977127, 24356.0, 19492.8050719491, 19983.300584479475, 20030.098645560694, 20121.2957546491, 20149.39551813448, 16555.50333489997, 16589.17054147312, 17040.06279654631, 17256.0, 17832.0, 20273.898630506752, 20504.58990820205, 20524.486887827923, 20652.277170299567, 20730.27444039512, 15621.14083725406, 15730.606734831721, 15772.60568485797, 15811.051336919822, 15819.209039548206, 18954.52613684669, 19632.90183549073, 19759.60480790405, 19796.703049454558, 19835.30576429818], "value": 12869.665040038792, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.1473630557969, 1548.3110016042858, 1555.2379334126274, 1564.0303012132479, 1573.370651739304, 16839.326426942924, 17550.648987020253, 17557.91221043893, 17567.64864702705, 17605.11974401278, 17228.655426891484, 17278.22247998843, 17300.740488892676, 17335.91332043341, 17376.478705638852, 2780.8748606312765, 2827.5051865923433, 2858.728420800031, 2865.1261365283685, 2865.7707383409384, 2614.372550587864, 2640.9964213598805, 2644.0877897125556, 2648.4967856107373, 2657.4419371931917, 2392.497575509145, 2520.5715028445206, 2582.1349847801007, 2584.7673709366154, 2592.62406950992, 2600.1289567994745, 2607.5958226474927, 2620.6331113644105, 2621.5019146362224, 2639.326971622243, 2576.1369941069765, 2579.8968041278326, 2591.7796987256106, 2598.8960441582312, 2602.3103877472486, 16631.0, 16706.331746730117, 16762.0, 16799.580010499714, 16919.91540042292, 8573.399862009663, 8816.426932249384, 8820.029796722356, 8842.0, 8854.468731876108, 5518.530924871391, 5752.0796672532615, 5781.855453613652, 5848.356680765112, 5863.912041319383, 2175.8368122390884, 2181.2365672014826, 2201.5376770878133, 2205.8235341172826, 2240.3950933248093, 30307.545386819216, 30375.544366834514, 30532.0, 30548.54177187366, 30565.388692226254, 7325.853482930312, 7356.0, 7400.185979542246, 7447.88828167578, 7517.398608111447, 19590.412287631392, 19592.804071959385, 19598.0, 19613.21547138127, 19645.214191432184, 8623.094575069654, 8630.611622477003, 8636.611352489153, 8640.827183456422, 8648.1784230498, 7779.57212353326, 7787.649555770004, 7807.843843123106, 8022.318102961313, 8041.517508949481, 5411.431799660979, 5547.223388725582, 5590.5248053915875, 5642.589352661835, 5650.180723795027, 1424.8387564135196, 1640.1799100449775, 1655.6026553627044, 1664.8251933547047, 1688.8480036796748, 861.0528418739336, 970.1511177719495, 976.9218462522981, 980.7008862297068, 998.4059484606647, 8155.184481551916, 8246.0, 8249.133840946733, 8405.453645513022, 8527.786805329792, 1055.1822337688352, 1055.3667799320347, 1057.0803401041144, 1081.8864019277862, 1092.808758467265, 5156.458571849977, 5157.123289040872, 5185.066687996122, 5200.583953283728, 5252.816151434758, 24324.148654796998, 24971.0, 25529.61705574418, 25590.0, 25748.227553173434, 23564.7643523566, 24646.50706985886, 24902.252932412055, 24914.750852491605, 25046.499070018497, 12588.748225035448, 12743.299118548568, 12774.978001760022, 12782.872171278354, 12846.550370736979, 9176.816463670822, 9264.0, 9286.72139835806, 9312.813743724952, 9344.579493922925, 20455.8977205113, 20711.0, 21004.159833607097, 21560.353189404344, 21857.562848743255, 21653.891730541876, 21738.239161629266, 21813.78186218181, 21825.126994920025, 22080.668789967844, 12082.0, 12269.202501837352, 12351.135420520477, 12381.442835072623, 12383.814242786186, 15237.847621523642, 15306.311215995529, 15449.691006180039, 15560.0, 15569.221538922782, 12437.37813109359, 12760.489580416679, 12851.357432128543, 13034.739305214032, 13226.4048117833, 12014.63956081319, 12045.277283363026, 12235.265884046985, 12528.874711253135, 12705.301208433255, 10348.275620706478, 10401.271910966463, 10478.161747060369, 10484.528196231035, 10495.79008419812, 7862.882056769038, 8029.558374289237, 8076.4750291230885, 8111.756647300354, 8166.387520936072, 8011.559364234789, 8155.5514446706, 8181.263686268265, 8264.504129752235, 8295.792605184919], "value": 7249.155318143617, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.9803306884259, 562.878981019081, 569.7293785451911, 581.5227132415907, 582.8630271886107, 5800.361960184377, 6087.482563982061, 6198.44214020738, 6229.283632382278, 6302.888532341671, 6101.755929762815, 6111.297200821907, 6111.7249723762425, 6166.229221347332, 6205.0, 4915.459299477055, 4972.726500042496, 4992.151334273164, 5003.17447621142, 5016.824411145611, 4991.276264941581, 5010.549050585447, 5015.799368025275, 5035.974820125894, 5055.797768089272, 4926.797581571971, 4963.677360971526, 4966.106100901836, 4967.379077615298, 4969.478204788499, 4926.507349265081, 4930.161872481651, 4952.0, 4958.9752051239875, 4965.205567109281, 4523.140603285398, 4539.682222244412, 4561.863144105682, 4595.655325850541, 4606.746628935407, 6119.938800611982, 6148.6925653717135, 6174.289956654998, 6187.628742275478, 6264.6241225526155, 5794.478496935296, 5803.622764520293, 5808.506276966463, 5858.619189752652, 5867.677277749722, 6607.834804129887, 6615.338466153395, 6655.46756259498, 6693.732250709966, 6704.865902681919, 4838.758062096881, 5064.164412871872, 5064.772085256172, 5073.137566613685, 5108.923366149511, 6688.498362622774, 6779.5932244065025, 6796.728130874759, 6920.792376228721, 6970.999999999949, 5194.948050519446, 5209.947900521022, 5211.530962213419, 5218.66078704883, 5230.790768369298, 5230.476952304815, 5274.97362513185, 5300.575953923677, 5323.520883120537, 5330.626856120034, 5758.827235182951, 5759.6832174229985, 5778.393268706809, 5791.160281759121, 5791.9710401448565, 6629.784554491068, 6631.3700198481065, 6651.334866513407, 6689.665516724242, 6709.698063587052, 1772.929082836698, 1798.5162241151102, 1819.3814103204975, 1823.4165067178642, 1830.9450716478527, 1231.5381731850557, 1291.689994401337, 1297.3967105296083, 1302.2419733359889, 1315.0925861155772, 6172.6913654318005, 6186.845328866724, 6207.193064901534, 6218.440340369389, 6250.624962502265, 6650.135482387259, 6671.666416679243, 6677.0, 6711.395974362331, 6738.460923126138, 6198.721057552421, 6213.596116252429, 6233.158523599256, 6260.186175797117, 6261.937380626136, 3575.213453040327, 3576.195356044869, 3576.946345804815, 3588.1209103769743, 3589.6410358964417, 7012.439004879598, 7016.403605693471, 7038.788836334918, 7048.647567621599, 7091.539049961736, 6924.6537673116145, 6948.409385202213, 6981.965090174516, 6991.265917078736, 6995.93004069963, 7033.226345101933, 7057.541259818096, 7073.257307982691, 7082.504224704221, 7087.858242835217, 6641.369069938348, 6674.833129171615, 6718.0, 6750.1562304711915, 6758.594484330759, 6515.967420162869, 6671.33286671329, 6677.198736151498, 6707.4969377297875, 6722.428593569602, 6911.654417279216, 6933.341332573397, 6961.477889158232, 7004.334588214111, 7061.6469176542, 5138.409082955508, 5172.9741351293005, 5195.012947540106, 5223.216517522402, 5228.921566176587, 6625.635590042594, 6742.86514269702, 6792.456603471612, 6818.727250909908, 6829.190264579791, 6291.653959032297, 6465.935340646533, 6498.967505162444, 6551.115599394211, 6561.245456772533, 6484.157059582413, 6550.641768963264, 6560.803175904731, 6581.835454113685, 6604.589324896282, 6422.710978005907, 6454.1609590752905, 6471.417572418505, 6534.869302614016, 6572.145621069421, 6528.314526974599, 6688.163979502562, 6694.230163531061, 6695.966520167368, 6711.127553418024, 6349.142865713255, 6433.903491447726, 6440.871182576228, 6459.741610335534, 6507.609543427409], "value": 5177.322316413573, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [953.2897990996709, 967.6274634265808, 975.8341082016057, 987.1855719031801, 994.0655783563452, 17961.640767184665, 18247.452576422696, 23215.187468438588, 23815.404614884592, 23855.76144238557, 19993.400197994048, 20002.199912003503, 20051.398458046282, 20390.490237744063, 20485.897570512163, 977.3207620703614, 983.8671779309773, 990.2375171118234, 991.7173605522428, 993.92545559083, 1038.8026275007762, 1071.539238127605, 1077.6713102503734, 1088.7985722641297, 1088.9564417423294, 1119.289251325406, 1119.5074167366374, 1120.025577747357, 1121.3776354123459, 1121.4673030310619, 1110.6945589962745, 1116.419461879822, 1117.251441534174, 1117.776444711061, 1119.1326721790597, 817.0522194254695, 817.9509229446252, 818.0960039156765, 818.7666515043244, 818.8526065308242, 19497.902510487358, 20384.28654997068, 20401.8979905101, 20571.5885682287, 20584.485387865272, 22051.66922496164, 22238.444038898997, 22528.43678908024, 22582.88708556463, 22612.77387226123, 17824.0, 17850.821491785176, 17942.282308707636, 18000.36998705039, 18031.188596513057, 3725.9068523286865, 3770.057485628593, 3841.154945911895, 3853.325668008087, 3865.903352416184, 152171.0, 153041.0, 154889.0, 154942.22528887397, 155829.0, 17480.0, 17625.647487050188, 17663.558411039827, 17694.823051769574, 17753.467395978143, 26459.47081058368, 26653.20040398791, 30392.240193995327, 33656.663433365844, 33833.83083084569, 9058.094190580889, 9117.589708463134, 9212.723618291462, 9252.444853308823, 9303.488308143116, 4431.556844315543, 4734.479207287196, 4821.325014497973, 4860.562549370574, 4896.2655601660035, 6230.221222347207, 6256.562040657202, 6305.527085468608, 6320.641062171655, 6343.873122537523, 1108.8225883858706, 1136.1649187846926, 1141.8858114188515, 1144.210494758614, 1153.0544953138515, 689.8309914070984, 696.8397268628142, 698.8392669685899, 702.0767690486994, 705.3581241070601, 12688.429020694091, 12734.61796146117, 12996.545120920722, 13114.278714670785, 13224.933875330562, 691.4952084977893, 700.8808502554577, 702.1574111066741, 714.6248219684708, 716.0262043620671, 6003.249593800775, 6097.878042439126, 6152.477039451607, 6159.6612186329285, 6163.0, 148267.258663706, 148536.0, 148645.0, 148700.0, 149098.0, 132996.0, 134402.91978101683, 135919.32040339932, 136401.3179934094, 141841.0, 115279.0, 115404.0, 115853.8414615843, 116473.0, 117068.0, 11661.591844285409, 11752.764944700886, 11778.46996885125, 11785.764284714429, 11885.930266276077, 52934.61794219192, 53058.0, 53242.935141297734, 54843.45156548383, 55505.44494555003, 65870.67064664837, 66975.66512167602, 67391.32608673851, 67678.32321676917, 69917.30082699108, 15580.143092130042, 15884.60288492797, 15997.840021599635, 16051.759223611421, 16066.116363600115, 17978.2808687651, 18043.458696239133, 18139.90930045341, 18232.90883545574, 18331.816681833545, 16382.262798173871, 16858.0, 16932.0, 16978.0, 17033.233504492575, 15922.522324330288, 16018.0, 16120.596985075466, 16191.0, 16240.837591624406, 16181.1100389475, 16241.187940602686, 16446.177691115634, 16526.752098718287, 16552.172391380143, 13222.735545289233, 13462.192268463923, 13508.392122354715, 13512.324383780575, 13542.322883855964, 12970.675733106747, 13120.803187952379, 13159.93420032932, 13253.337333133497, 13309.068365214342], "value": 9694.982815148322, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1375.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 104.0, 107.0, 105.0, 105.0, 96.0, 107.0, 107.0, 105.0, 104.0], "value": 104.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 116.0, 120.0, 113.0, 116.0, 138.0, 119.0, 119.0, 113.0], "value": 118.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 160.0, 161.0, 162.0, 163.0, 163.0, 172.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 74.0, 72.0, 75.0, 73.0, 74.0, 73.0, 76.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 87.0, 78.0, 77.0, 78.0, 77.0, 78.0, 78.0, 79.0, 79.0], "value": 78.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 115.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 150.0, 149.0, 149.0, 149.0, 153.0, 150.0, 150.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 44.0, 43.0, 45.0, 46.0, 44.0, 43.0, 43.0, 43.0, 44.0], "value": 45.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 36.0, 38.0, 36.0, 37.0, 37.0, 37.0, 36.0, 37.0], "value": 36.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 70.0, 72.0, 76.0, 73.0, 75.0, 76.0, 70.0, 70.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 105.0, 105.0, 107.0, 109.0, 104.0, 116.0, 103.0, 110.0, 111.0], "value": 107.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 153.0, 150.0, 151.0, 149.0, 152.0, 151.0, 153.0, 148.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 71.0, 68.0, 61.0, 59.0, 58.0, 64.0, 61.0], "value": 62.3, "unit": "score"}]}]} 18:12:44 INFO - Return code: 0 18:12:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:12:44 INFO - # TBPL SUCCESS # 18:12:44 INFO - Running post-action listener: _package_coverage_data 18:12:44 INFO - Running post-action listener: _resource_record_post_action 18:12:44 INFO - [mozharness: 2017-09-25 01:12:44.862060Z] Finished run-tests step (success) 18:12:44 INFO - Running post-run listener: _resource_record_post_run 18:12:44 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 10784768; Write bytes: 459186176; Read time: 2740; Write time: 441720 18:12:44 INFO - TinderboxPrint: CPU usage
13.1% 18:12:44 INFO - TinderboxPrint: I/O read bytes / time
10,784,768 / 2,740 18:12:44 INFO - TinderboxPrint: I/O write bytes / time
459,186,176 / 441,720 18:12:44 INFO - TinderboxPrint: CPU idle
8,242.8 (86.9%) 18:12:44 INFO - TinderboxPrint: CPU user
1,187.9 (12.5%) 18:12:44 INFO - TinderboxPrint: Swap in / out
0 / 0 18:12:44 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 14467072; Read time: 0; Write time: 4104 18:12:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:12:44 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 9039872; Write bytes: 444719104; Read time: 2704; Write time: 437616 18:12:45 INFO - Running post-run listener: _upload_blobber_files 18:12:45 INFO - Blob upload gear active. 18:12:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:12:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:12:45 INFO - (blobuploader) - INFO - Open directory for files ... 18:12:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:12:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:12:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:12:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:12:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:12:47 INFO - (blobuploader) - INFO - Done attempting. 18:12:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:12:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:12:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:12:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:12:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:12:53 INFO - (blobuploader) - INFO - Done attempting. 18:12:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 18:12:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:12:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:12:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 18:12:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:12:54 INFO - (blobuploader) - INFO - Done attempting. 18:12:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 18:12:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:12:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:12:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 18:12:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:12:55 INFO - (blobuploader) - INFO - Done attempting. 18:12:55 INFO - (blobuploader) - INFO - Iteration through files over. 18:12:55 INFO - Return code: 0 18:12:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:12:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:12:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77693102f250de6a70bd9ed35491108d48641859a17bbcfae1c54fc0e109b73ca75a8d7ae41f97ce701e22c12b9974a0affe045520c9aca0a724dd05d332d57b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e55534174d97a5685983d95a4c95b4ba860b98ed05edf8f0ab463aa99f0dca21a3b3701ad3c8d48a3dd9e51f00d33b8c36de91ff185e2ba7e752857f6497f2dc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90e11e952259050e599bf1201b4ae4d2501ceb9e3f35d53d54c21f0059f08f6174ee9c3cfceaef27b60658e69b8f863e4dd80f53a2a8e03b24810e80afd5ff60", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e777ed67a7370a2a8c3942bb92c5fb8440e03dddc537ac52a1530b8629dcc74330c0b5bc8b9786f0d090d62bcccb87a1d7762f7b17bec9542eb4a9f7d613ae6c"} 18:12:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:12:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:12:55 INFO - Contents: 18:12:55 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77693102f250de6a70bd9ed35491108d48641859a17bbcfae1c54fc0e109b73ca75a8d7ae41f97ce701e22c12b9974a0affe045520c9aca0a724dd05d332d57b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e55534174d97a5685983d95a4c95b4ba860b98ed05edf8f0ab463aa99f0dca21a3b3701ad3c8d48a3dd9e51f00d33b8c36de91ff185e2ba7e752857f6497f2dc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90e11e952259050e599bf1201b4ae4d2501ceb9e3f35d53d54c21f0059f08f6174ee9c3cfceaef27b60658e69b8f863e4dd80f53a2a8e03b24810e80afd5ff60", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e777ed67a7370a2a8c3942bb92c5fb8440e03dddc537ac52a1530b8629dcc74330c0b5bc8b9786f0d090d62bcccb87a1d7762f7b17bec9542eb4a9f7d613ae6c"} 18:12:55 INFO - Running post-run listener: copy_logs_to_upload_dir 18:12:55 INFO - Copying logs to upload dir... 18:12:55 INFO - mkdir: /builds/slave/test/build/upload/logs 18:12:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.880291 ========= master_lag: -0.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-24 18:12:55.397356) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 18:12:55.404988) ========= 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=1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77693102f250de6a70bd9ed35491108d48641859a17bbcfae1c54fc0e109b73ca75a8d7ae41f97ce701e22c12b9974a0affe045520c9aca0a724dd05d332d57b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e55534174d97a5685983d95a4c95b4ba860b98ed05edf8f0ab463aa99f0dca21a3b3701ad3c8d48a3dd9e51f00d33b8c36de91ff185e2ba7e752857f6497f2dc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90e11e952259050e599bf1201b4ae4d2501ceb9e3f35d53d54c21f0059f08f6174ee9c3cfceaef27b60658e69b8f863e4dd80f53a2a8e03b24810e80afd5ff60", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e777ed67a7370a2a8c3942bb92c5fb8440e03dddc537ac52a1530b8629dcc74330c0b5bc8b9786f0d090d62bcccb87a1d7762f7b17bec9542eb4a9f7d613ae6c"} build_url:https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/XNnhmb6FR56ecTjHY5Q_Pw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77693102f250de6a70bd9ed35491108d48641859a17bbcfae1c54fc0e109b73ca75a8d7ae41f97ce701e22c12b9974a0affe045520c9aca0a724dd05d332d57b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e55534174d97a5685983d95a4c95b4ba860b98ed05edf8f0ab463aa99f0dca21a3b3701ad3c8d48a3dd9e51f00d33b8c36de91ff185e2ba7e752857f6497f2dc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90e11e952259050e599bf1201b4ae4d2501ceb9e3f35d53d54c21f0059f08f6174ee9c3cfceaef27b60658e69b8f863e4dd80f53a2a8e03b24810e80afd5ff60", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e777ed67a7370a2a8c3942bb92c5fb8440e03dddc537ac52a1530b8629dcc74330c0b5bc8b9786f0d090d62bcccb87a1d7762f7b17bec9542eb4a9f7d613ae6c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 18:12:55.435805) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 18:12:55.436118) ========= 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=1f5564757af27664ca02d71f000001b0-1506300731.271411-751861154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 18:12:55.521585) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 18:12:55.521903) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 18:12:55.522214) ========= ========= Total master_lag: -0.09 =========