builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-076 starttime: 1505687023.22 results: success (0) revision: ae39864562c6048fdc2950c5dfedb48e247c3300 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 15:23:43.218287) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 15:23:43.218711) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 15:23:43.218982) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 15:23:43.267806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:23:43.268111) ========= 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=9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-17 15:23:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2017-09-17 15:23:43 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.155835 ========= master_lag: 0.57 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:23:43.991325) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:23:43.997725) ========= 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=9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019384 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:23:44.043413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:23:44.043743) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ae39864562c6048fdc2950c5dfedb48e247c3300 --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 ae39864562c6048fdc2950c5dfedb48e247c3300 --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=9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-17 15:23:44,242 truncating revision to first 12 chars 2017-09-17 15:23:44,242 Setting DEBUG logging. 2017-09-17 15:23:44,242 attempt 1/10 2017-09-17 15:23:44,242 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ae39864562c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-17 15:23:44,759 unpacking tar archive at: mozilla-central-ae39864562c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.777376 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:23:44.845345) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 15:23:44.845652) ========= script_repo_revision: ae39864562c6048fdc2950c5dfedb48e247c3300 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 15:23:44.846011) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 15:23:44.846306) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 15:23:44.864124) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-17 15:23:44.864392) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:23:45 INFO - MultiFileLogger online at 20170917 15:23:45 in /builds/slave/test 15:23:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:23:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:23:45 INFO - {'append_to_log': False, 15:23:45 INFO - 'base_work_dir': '/builds/slave/test', 15:23:45 INFO - 'blob_upload_branch': 'Firefox', 15:23:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:23:45 INFO - 'branch': 'Firefox', 15:23:45 INFO - 'buildbot_json_path': 'buildprops.json', 15:23:45 INFO - 'code_coverage': False, 15:23:45 INFO - 'config_files': ('talos/linux_config.py',), 15:23:45 INFO - 'default_actions': ('clobber', 15:23:45 INFO - 'read-buildbot-config', 15:23:45 INFO - 'download-and-extract', 15:23:45 INFO - 'populate-webroot', 15:23:45 INFO - 'create-virtualenv', 15:23:45 INFO - 'install', 15:23:45 INFO - 'setup-mitmproxy', 15:23:45 INFO - 'run-tests'), 15:23:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:23:45 INFO - 'disable_ccov_upload': False, 15:23:45 INFO - 'disable_stylo': False, 15:23:45 INFO - 'download_minidump_stackwalk': True, 15:23:45 INFO - 'download_symbols': 'ondemand', 15:23:45 INFO - 'enable_stylo': False, 15:23:45 INFO - 'enable_webrender': False, 15:23:45 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:23:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:23:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:23:45 INFO - 'gecko_profile': False, 15:23:45 INFO - 'gecko_profile_interval': 0, 15:23:45 INFO - 'installer_path': 'installer.exe', 15:23:45 INFO - 'log_level': 'info', 15:23:45 INFO - 'log_name': 'talos', 15:23:45 INFO - 'log_to_console': True, 15:23:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:23:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:23:45 INFO - 'opt_config_files': (), 15:23:45 INFO - 'pip_index': False, 15:23:45 INFO - 'suite': 'dromaeojs-e10s', 15:23:45 INFO - 'system_bits': '32', 15:23:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:23:45 INFO - 'title': 'talos-linux64-ix-076', 15:23:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:23:45 INFO - 'use_talos_json': True, 15:23:45 INFO - 'verify': 'False', 15:23:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:23:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:23:45 INFO - 'work_dir': 'build'} 15:23:45 INFO - [mozharness: 2017-09-17 22:23:45.207942Z] Running clobber step. 15:23:45 INFO - Running pre-action listener: _resource_record_pre_action 15:23:45 INFO - Running main action method: clobber 15:23:45 INFO - rmtree: /builds/slave/test/build 15:23:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:23:46 INFO - Running post-action listener: _resource_record_post_action 15:23:46 INFO - [mozharness: 2017-09-17 22:23:46.705003Z] Finished clobber step (success) 15:23:46 INFO - [mozharness: 2017-09-17 22:23:46.705099Z] Running read-buildbot-config step. 15:23:46 INFO - Running pre-action listener: _resource_record_pre_action 15:23:46 INFO - Running main action method: read_buildbot_config 15:23:46 INFO - Using buildbot properties: 15:23:46 INFO - { 15:23:46 INFO - "project": "", 15:23:46 INFO - "product": "firefox", 15:23:46 INFO - "who": "archaeopteryx@coole-files.de", 15:23:46 INFO - "installer_path": "public/build/target.tar.bz2", 15:23:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 15:23:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:23:46 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 15:23:46 INFO - "stage_platform": "linux64-qr", 15:23:46 INFO - "basedir": "/builds/slave/test", 15:23:46 INFO - "buildnumber": 72, 15:23:46 INFO - "platform": "ubuntu64_hw_qr", 15:23:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:23:46 INFO - "slavebuilddir": "test", 15:23:46 INFO - "taskId": "VU8ftzuRSYucvdkJ1lYhJQ", 15:23:46 INFO - "branch": "mozilla-central", 15:23:46 INFO - "script_repo_revision": "production", 15:23:46 INFO - "revision": "ae39864562c6048fdc2950c5dfedb48e247c3300", 15:23:46 INFO - "slavename": "talos-linux64-ix-076", 15:23:46 INFO - "repo_path": "mozilla-central" 15:23:46 INFO - } 15:23:46 INFO - Finding installer, test and symbols from parent task. 15:23:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VU8ftzuRSYucvdkJ1lYhJQ'}, attempt #1 15:23:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VU8ftzuRSYucvdkJ1lYhJQ'}, attempt #1 15:23:47 INFO - Task dependencies: b2Y79Ct6TZem2FvxMKycGw 15:23:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw'}, attempt #1 15:23:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 15:23:48 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.test_packages.json 15:23:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.crashreporter-symbols.zip 15:23:48 INFO - Running post-action listener: _resource_record_post_action 15:23:48 INFO - [mozharness: 2017-09-17 22:23:48.033199Z] Finished read-buildbot-config step (success) 15:23:48 INFO - [mozharness: 2017-09-17 22:23:48.033415Z] Running download-and-extract step. 15:23:48 INFO - Running pre-action listener: _resource_record_pre_action 15:23:48 INFO - Running main action method: download_and_extract 15:23:48 INFO - mkdir: /builds/slave/test/build/tests 15:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:48 INFO - trying https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.test_packages.json 15:23:48 INFO - Downloading https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:23:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:23:48 INFO - Downloaded 989 bytes. 15:23:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:23:48 INFO - Using the following test package requirements: 15:23:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:23:48 INFO - u'common': [u'target.common.tests.zip'], 15:23:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:23:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:23:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:23:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:23:48 INFO - u'mozbase': [u'target.common.tests.zip'], 15:23:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:23:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:23:48 INFO - u'web-platform': [u'target.common.tests.zip', 15:23:48 INFO - u'target.web-platform.tests.tar.gz'], 15:23:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:23:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:23:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.common.tests.zip 15:23:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:23:48 INFO - Fetch https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.common.tests.zip into memory 15:23:50 INFO - Content-Length response header: 54731154 15:23:50 INFO - Bytes received: 54731154 15:24:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.talos.tests.zip 15:24:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:24:01 INFO - Fetch https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.talos.tests.zip into memory 15:24:02 INFO - Content-Length response header: 14508748 15:24:02 INFO - Bytes received: 14508748 15:24:03 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')]} 15:24:03 INFO - trying https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 15:24:03 INFO - Downloading https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:24:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:24:05 INFO - Downloaded 61436042 bytes. 15:24:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 15:24:05 INFO - mkdir: /builds/slave/test/properties 15:24:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:24:05 INFO - Writing to file /builds/slave/test/properties/build_url 15:24:05 INFO - Contents: 15:24:05 INFO - build_url:https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 15:24:05 INFO - Running post-action listener: _resource_record_post_action 15:24:05 INFO - Running post-action listener: find_tests_for_verification 15:24:05 INFO - Running post-action listener: set_extra_try_arguments 15:24:05 INFO - [mozharness: 2017-09-17 22:24:05.952986Z] Finished download-and-extract step (success) 15:24:05 INFO - [mozharness: 2017-09-17 22:24:05.953085Z] Running populate-webroot step. 15:24:05 INFO - Running pre-action listener: _resource_record_pre_action 15:24:05 INFO - Running main action method: populate_webroot 15:24:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:24:05 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:05 INFO - 'tests': ['tresize', 15:24:05 INFO - 'tcanvasmark']}, 15:24:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:24:05 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:05 INFO - 'tests': ['dromaeo_css', 15:24:05 INFO - 'kraken']}, 15:24:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:24:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:05 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:24:05 INFO - 'talos_options': ['--disable-stylo'], 15:24:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:24:05 INFO - 'tests': ['damp', 'tps']}, 15:24:05 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:24:05 INFO - 'talos_options': ['--disable-stylo'], 15:24:05 INFO - 'tests': ['damp', 'tps']}, 15:24:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:24:05 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:05 INFO - 'tests': ['dromaeo_dom']}, 15:24:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:24:05 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:05 INFO - 'tests': ['basic_compositor_video', 15:24:05 INFO - 'glvideo']}, 15:24:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:24:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:24:05 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:24:05 INFO - 'talos_options': ['--disable-stylo'], 15:24:05 INFO - 'tests': ['ts_paint_webext', 15:24:05 INFO - 'tp5o_webext']}, 15:24:05 INFO - 'other-e10s': {'tests': ['a11yr', 15:24:05 INFO - 'ts_paint', 15:24:05 INFO - 'tpaint', 15:24:05 INFO - 'sessionrestore', 15:24:05 INFO - 'sessionrestore_many_windows', 15:24:05 INFO - 'sessionrestore_no_auto_restore', 15:24:05 INFO - 'tabpaint']}, 15:24:05 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:05 INFO - 'tests': ['a11yr', 15:24:05 INFO - 'ts_paint', 15:24:05 INFO - 'tpaint', 15:24:05 INFO - 'sessionrestore', 15:24:05 INFO - 'sessionrestore_many_windows', 15:24:05 INFO - 'sessionrestore_no_auto_restore', 15:24:05 INFO - 'tabpaint']}, 15:24:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:24:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:24:05 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:05 INFO - 'tests': ['perf_reftest_singletons']}, 15:24:05 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:05 INFO - 'tests': ['bloom_basic']}, 15:24:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:24:05 INFO - 'tsvgr_opacity', 15:24:05 INFO - 'tart', 15:24:05 INFO - 'tscrollx', 15:24:05 INFO - 'tsvg_static']}, 15:24:05 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:05 INFO - 'tests': ['tsvgx', 15:24:05 INFO - 'tsvgr_opacity', 15:24:05 INFO - 'tart', 15:24:05 INFO - 'tscrollx', 15:24:05 INFO - 'tsvg_static']}, 15:24:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:24:05 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:24:05 INFO - 'talos_options': ['--disable-stylo'], 15:24:05 INFO - 'tests': ['tp5o']}, 15:24:05 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:24:05 INFO - 'talos_options': ['--mitmproxy', 15:24:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:24:05 INFO - '--firstNonBlankPaint'], 15:24:05 INFO - 'tests': ['tp6_google', 15:24:05 INFO - 'tp6_youtube', 15:24:05 INFO - 'tp6_amazon', 15:24:05 INFO - 'tp6_facebook']}, 15:24:05 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:24:05 INFO - 'talos_options': ['--disable-stylo', 15:24:05 INFO - '--mitmproxy', 15:24:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:24:05 INFO - '--firstNonBlankPaint'], 15:24:05 INFO - 'tests': ['tp6_google', 15:24:05 INFO - 'tp6_youtube', 15:24:05 INFO - 'tp6_amazon', 15:24:05 INFO - 'tp6_facebook']}, 15:24:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:24:05 INFO - 'talos_options': ['--stylo-threads=1', 15:24:05 INFO - '--mitmproxy', 15:24:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:24:05 INFO - '--firstNonBlankPaint'], 15:24:05 INFO - 'tests': ['tp6_google', 15:24:05 INFO - 'tp6_youtube', 15:24:05 INFO - 'tp6_amazon', 15:24:05 INFO - 'tp6_facebook']}, 15:24:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:24:05 INFO - 'talos_options': ['--xperf_path', 15:24:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:05 INFO - 'tests': ['tp5n']}, 15:24:05 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:24:05 INFO - 'talos_options': ['--disable-stylo', 15:24:05 INFO - '--xperf_path', 15:24:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:05 INFO - 'tests': ['tp5n']}}} 15:24:05 INFO - Running post-action listener: _resource_record_post_action 15:24:05 INFO - [mozharness: 2017-09-17 22:24:05.970940Z] Finished populate-webroot step (success) 15:24:05 INFO - [mozharness: 2017-09-17 22:24:05.971029Z] Running create-virtualenv step. 15:24:05 INFO - Running pre-action listener: _resource_record_pre_action 15:24:05 INFO - Running main action method: create_virtualenv 15:24:05 INFO - Creating virtualenv /builds/slave/test/build/venv 15:24:05 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:24:05 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:24:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:24:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:24:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:24:06 INFO - Installing distribute.............................................................................................................................................................................................done. 15:24:06 INFO - Installing pip...............done. 15:24:06 INFO - Return code: 0 15:24:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:24:06 INFO - Reading from file tmpfile_stdout 15:24:06 INFO - Output received: 15:24:06 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:24:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247a090>, '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 0x247ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2474f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', '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 15:24:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:24:06 INFO - Using env: {'DISPLAY': ':0', 15:24:06 INFO - 'HOME': '/home/cltbld', 15:24:06 INFO - 'LANG': 'en_US.UTF-8', 15:24:06 INFO - 'LANGUAGE': 'en_US:en', 15:24:06 INFO - 'LOGNAME': 'cltbld', 15:24:06 INFO - 'MAIL': '/var/mail/cltbld', 15:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:06 INFO - 'MOZ_NO_REMOTE': '1', 15:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:06 INFO - 'NO_EM_RESTART': '1', 15:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:06 INFO - 'PWD': '/builds/slave/test', 15:24:06 INFO - 'SHELL': '/bin/bash', 15:24:06 INFO - 'SHLVL': '1', 15:24:06 INFO - 'TERM': 'linux', 15:24:06 INFO - 'TMOUT': '86400', 15:24:06 INFO - 'USER': 'cltbld', 15:24:06 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', 15:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:06 INFO - '_': '/tools/buildbot/bin/python'} 15:24:08 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:24:08 INFO - Downloading/unpacking pip>=1.5 15:24:08 INFO - Running setup.py egg_info for package pip 15:24:08 INFO - warning: no files found matching 'pip/cacert.pem' 15:24:08 INFO - warning: no files found matching '*.html' under directory 'docs' 15:24:08 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:24:08 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:24:08 INFO - Installing collected packages: pip 15:24:08 INFO - Found existing installation: pip 1.1 15:24:08 INFO - Uninstalling pip: 15:24:08 INFO - Successfully uninstalled pip 15:24:08 INFO - Running setup.py install for pip 15:24:08 INFO - warning: no files found matching 'pip/cacert.pem' 15:24:08 INFO - warning: no files found matching '*.html' under directory 'docs' 15:24:08 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:24:08 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:24:08 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:24:08 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:24:08 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:24:08 INFO - Successfully installed pip 15:24:08 INFO - Cleaning up... 15:24:08 INFO - Return code: 0 15:24:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:08 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 0x210a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247a090>, '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 0x247ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2474f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', '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 15:24:08 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 15:24:08 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 15:24:08 INFO - Using env: {'DISPLAY': ':0', 15:24:08 INFO - 'HOME': '/home/cltbld', 15:24:08 INFO - 'LANG': 'en_US.UTF-8', 15:24:08 INFO - 'LANGUAGE': 'en_US:en', 15:24:08 INFO - 'LOGNAME': 'cltbld', 15:24:08 INFO - 'MAIL': '/var/mail/cltbld', 15:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:08 INFO - 'MOZ_NO_REMOTE': '1', 15:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:08 INFO - 'NO_EM_RESTART': '1', 15:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:08 INFO - 'PWD': '/builds/slave/test', 15:24:08 INFO - 'SHELL': '/bin/bash', 15:24:08 INFO - 'SHLVL': '1', 15:24:08 INFO - 'TERM': 'linux', 15:24:08 INFO - 'TMOUT': '86400', 15:24:08 INFO - 'USER': 'cltbld', 15:24:08 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', 15:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:08 INFO - '_': '/tools/buildbot/bin/python'} 15:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:08 INFO - Downloading/unpacking psutil>=3.1.1 15:24:08 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 15:24:08 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 15:24:08 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 15:24:08 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 15:24:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:24:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:09 INFO - Installing collected packages: psutil 15:24:09 INFO - Running setup.py install for psutil 15:24:09 INFO - building 'psutil._psutil_linux' extension 15:24:09 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 15:24:09 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 15:24:09 INFO - building 'psutil._psutil_posix' extension 15:24:09 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 15:24:10 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 15:24:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:10 INFO - Successfully installed psutil 15:24:10 INFO - Cleaning up... 15:24:10 INFO - Return code: 0 15:24:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:24:10 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')]} 15:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:10 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')]} 15:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:10 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 0x210a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247a090>, '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 0x247ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2474f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', '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 15:24:10 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 15:24:10 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 15:24:10 INFO - Using env: {'DISPLAY': ':0', 15:24:10 INFO - 'HOME': '/home/cltbld', 15:24:10 INFO - 'LANG': 'en_US.UTF-8', 15:24:10 INFO - 'LANGUAGE': 'en_US:en', 15:24:10 INFO - 'LOGNAME': 'cltbld', 15:24:10 INFO - 'MAIL': '/var/mail/cltbld', 15:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:10 INFO - 'MOZ_NO_REMOTE': '1', 15:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:10 INFO - 'NO_EM_RESTART': '1', 15:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:10 INFO - 'PWD': '/builds/slave/test', 15:24:10 INFO - 'SHELL': '/bin/bash', 15:24:10 INFO - 'SHLVL': '1', 15:24:10 INFO - 'TERM': 'linux', 15:24:10 INFO - 'TMOUT': '86400', 15:24:10 INFO - 'USER': 'cltbld', 15:24:10 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', 15:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:10 INFO - '_': '/tools/buildbot/bin/python'} 15:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:24:10 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 15:24:10 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 15:24:10 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 15:24:10 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 15:24:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:24:11 INFO - Installing collected packages: mozsystemmonitor 15:24:11 INFO - Running setup.py install for mozsystemmonitor 15:24:11 INFO - Successfully installed mozsystemmonitor 15:24:11 INFO - Cleaning up... 15:24:12 INFO - Return code: 0 15:24:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:24: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')]} 15:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24: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')]} 15:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x210a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247a090>, '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 0x247ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2474f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', '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 15:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:24:12 INFO - Using env: {'DISPLAY': ':0', 15:24:12 INFO - 'HOME': '/home/cltbld', 15:24:12 INFO - 'LANG': 'en_US.UTF-8', 15:24:12 INFO - 'LANGUAGE': 'en_US:en', 15:24:12 INFO - 'LOGNAME': 'cltbld', 15:24:12 INFO - 'MAIL': '/var/mail/cltbld', 15:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:12 INFO - 'MOZ_NO_REMOTE': '1', 15:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:12 INFO - 'NO_EM_RESTART': '1', 15:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:12 INFO - 'PWD': '/builds/slave/test', 15:24:12 INFO - 'SHELL': '/bin/bash', 15:24:12 INFO - 'SHLVL': '1', 15:24:12 INFO - 'TERM': 'linux', 15:24:12 INFO - 'TMOUT': '86400', 15:24:12 INFO - 'USER': 'cltbld', 15:24:12 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', 15:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:12 INFO - '_': '/tools/buildbot/bin/python'} 15:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:12 INFO - Downloading/unpacking jsonschema==2.5.1 15:24:12 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 15:24:12 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 15:24:12 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 15:24:12 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 15:24:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:24:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:24:14 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 15:24:14 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 15:24:14 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 15:24:14 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 15:24:14 INFO - Downloading functools32-3.2.3-2.tar.gz 15:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:24:14 INFO - warning: no files found matching '*.txt' 15:24:14 INFO - no previously-included directories found matching 'build' 15:24:14 INFO - no previously-included directories found matching 'dist' 15:24:14 INFO - no previously-included directories found matching '.git*' 15:24:14 INFO - Installing collected packages: jsonschema, functools32 15:24:14 INFO - Running setup.py install for functools32 15:24:14 INFO - warning: no files found matching '*.txt' 15:24:14 INFO - no previously-included directories found matching 'build' 15:24:14 INFO - no previously-included directories found matching 'dist' 15:24:14 INFO - no previously-included directories found matching '.git*' 15:24:14 INFO - Successfully installed jsonschema functools32 15:24:14 INFO - Cleaning up... 15:24:14 INFO - Return code: 0 15:24:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:24:14 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')]} 15:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:14 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')]} 15:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:14 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 0x210a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247a090>, '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 0x247ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2474f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', '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 15:24:14 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 15:24:14 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 15:24:14 INFO - Using env: {'DISPLAY': ':0', 15:24:14 INFO - 'HOME': '/home/cltbld', 15:24:14 INFO - 'LANG': 'en_US.UTF-8', 15:24:14 INFO - 'LANGUAGE': 'en_US:en', 15:24:14 INFO - 'LOGNAME': 'cltbld', 15:24:14 INFO - 'MAIL': '/var/mail/cltbld', 15:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:14 INFO - 'MOZ_NO_REMOTE': '1', 15:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:14 INFO - 'NO_EM_RESTART': '1', 15:24:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:14 INFO - 'PWD': '/builds/slave/test', 15:24:14 INFO - 'SHELL': '/bin/bash', 15:24:14 INFO - 'SHLVL': '1', 15:24:14 INFO - 'TERM': 'linux', 15:24:14 INFO - 'TMOUT': '86400', 15:24:14 INFO - 'USER': 'cltbld', 15:24:14 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', 15:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:14 INFO - '_': '/tools/buildbot/bin/python'} 15:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:24:14 INFO - Cleaning up... 15:24:14 INFO - Return code: 0 15:24:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:24:14 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')]} 15:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:14 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')]} 15:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:14 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 0x210a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247a090>, '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 0x247ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2474f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', '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 15:24:14 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 15:24:14 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 15:24:14 INFO - Using env: {'DISPLAY': ':0', 15:24:14 INFO - 'HOME': '/home/cltbld', 15:24:14 INFO - 'LANG': 'en_US.UTF-8', 15:24:14 INFO - 'LANGUAGE': 'en_US:en', 15:24:14 INFO - 'LOGNAME': 'cltbld', 15:24:14 INFO - 'MAIL': '/var/mail/cltbld', 15:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:14 INFO - 'MOZ_NO_REMOTE': '1', 15:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:14 INFO - 'NO_EM_RESTART': '1', 15:24:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:14 INFO - 'PWD': '/builds/slave/test', 15:24:14 INFO - 'SHELL': '/bin/bash', 15:24:14 INFO - 'SHLVL': '1', 15:24:14 INFO - 'TERM': 'linux', 15:24:14 INFO - 'TMOUT': '86400', 15:24:14 INFO - 'USER': 'cltbld', 15:24:14 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', 15:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:14 INFO - '_': '/tools/buildbot/bin/python'} 15:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:14 INFO - Downloading/unpacking blobuploader==1.2.4 15:24:14 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 15:24:14 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 15:24:14 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 15:24:14 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 15:24:16 INFO - Downloading blobuploader-1.2.4.tar.gz 15:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:24:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:24:16 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 15:24:16 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 15:24:16 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 15:24:16 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 15:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:24:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:24:16 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 15:24:16 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 15:24:16 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 15:24:16 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 15:24:16 INFO - Downloading docopt-0.6.1.tar.gz 15:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:24:16 INFO - Installing collected packages: blobuploader, requests, docopt 15:24:16 INFO - Running setup.py install for blobuploader 15:24:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:24:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:24:16 INFO - Running setup.py install for requests 15:24:17 INFO - Running setup.py install for docopt 15:24:17 INFO - Successfully installed blobuploader requests docopt 15:24:17 INFO - Cleaning up... 15:24:17 INFO - Return code: 0 15:24:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24: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')]} 15:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24: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')]} 15:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:17 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 0x210a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247a090>, '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 0x247ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2474f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', '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 15:24:17 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 15:24:17 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 15:24:17 INFO - Using env: {'DISPLAY': ':0', 15:24:17 INFO - 'HOME': '/home/cltbld', 15:24:17 INFO - 'LANG': 'en_US.UTF-8', 15:24:17 INFO - 'LANGUAGE': 'en_US:en', 15:24:17 INFO - 'LOGNAME': 'cltbld', 15:24:17 INFO - 'MAIL': '/var/mail/cltbld', 15:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:17 INFO - 'MOZ_NO_REMOTE': '1', 15:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:17 INFO - 'NO_EM_RESTART': '1', 15:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:17 INFO - 'PWD': '/builds/slave/test', 15:24:17 INFO - 'SHELL': '/bin/bash', 15:24:17 INFO - 'SHLVL': '1', 15:24:17 INFO - 'TERM': 'linux', 15:24:17 INFO - 'TMOUT': '86400', 15:24:17 INFO - 'USER': 'cltbld', 15:24:17 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', 15:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:17 INFO - '_': '/tools/buildbot/bin/python'} 15:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:24:17 INFO - Running setup.py (path:/tmp/pip-p2yFnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:24:17 INFO - Running setup.py (path:/tmp/pip-WAyViI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:24:17 INFO - Running setup.py (path:/tmp/pip-KPPk8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:24:17 INFO - Running setup.py (path:/tmp/pip-B1Zybz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:24:17 INFO - Running setup.py (path:/tmp/pip-0XUMgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:24:18 INFO - Running setup.py (path:/tmp/pip-Z1LL1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:24:18 INFO - Running setup.py (path:/tmp/pip-_5ajQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:24:18 INFO - Running setup.py (path:/tmp/pip-badiJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:24:18 INFO - Running setup.py (path:/tmp/pip-1nKqCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:24:18 INFO - Running setup.py (path:/tmp/pip-zkS60t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:24:18 INFO - Running setup.py (path:/tmp/pip-u3hILt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:24:18 INFO - Running setup.py (path:/tmp/pip-lIdL7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:24:18 INFO - Running setup.py (path:/tmp/pip-BZIIbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:24:18 INFO - Running setup.py (path:/tmp/pip-egw0rA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:18 INFO - Running setup.py (path:/tmp/pip-FmuBDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:24:18 INFO - Running setup.py (path:/tmp/pip-fqIpGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:24:18 INFO - Running setup.py (path:/tmp/pip-eAThzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:24:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:24:18 INFO - Running setup.py install for manifestparser 15:24:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:24:18 INFO - Running setup.py install for mozcrash 15:24:19 INFO - Running setup.py install for mozdebug 15:24:19 INFO - Running setup.py install for mozdevice 15:24:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:24:19 INFO - Running setup.py install for mozfile 15:24:19 INFO - Running setup.py install for mozhttpd 15:24:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:24:19 INFO - Running setup.py install for mozinfo 15:24:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:24:19 INFO - Running setup.py install for mozInstall 15:24:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:24:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:24:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:24:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:24:19 INFO - Running setup.py install for mozleak 15:24:19 INFO - Running setup.py install for mozlog 15:24:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:24:19 INFO - Running setup.py install for moznetwork 15:24:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:24:19 INFO - Running setup.py install for mozprocess 15:24:20 INFO - Running setup.py install for mozprofile 15:24:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:24:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:24:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:24:20 INFO - Running setup.py install for mozrunner 15:24:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:24:20 INFO - Running setup.py install for mozscreenshot 15:24:20 INFO - Running setup.py install for moztest 15:24:20 INFO - Running setup.py install for mozversion 15:24:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:24:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:24:20 INFO - Cleaning up... 15:24:20 INFO - Return code: 0 15:24:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:20 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 0x210a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247a090>, '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 0x247ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2474f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', '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 15:24:20 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 15:24:20 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 15:24:20 INFO - Using env: {'DISPLAY': ':0', 15:24:20 INFO - 'HOME': '/home/cltbld', 15:24:20 INFO - 'LANG': 'en_US.UTF-8', 15:24:20 INFO - 'LANGUAGE': 'en_US:en', 15:24:20 INFO - 'LOGNAME': 'cltbld', 15:24:20 INFO - 'MAIL': '/var/mail/cltbld', 15:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:20 INFO - 'MOZ_NO_REMOTE': '1', 15:24:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:20 INFO - 'NO_EM_RESTART': '1', 15:24:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:20 INFO - 'PWD': '/builds/slave/test', 15:24:20 INFO - 'SHELL': '/bin/bash', 15:24:20 INFO - 'SHLVL': '1', 15:24:20 INFO - 'TERM': 'linux', 15:24:20 INFO - 'TMOUT': '86400', 15:24:20 INFO - 'USER': 'cltbld', 15:24:20 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', 15:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:20 INFO - '_': '/tools/buildbot/bin/python'} 15:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:24:20 INFO - Running setup.py (path:/tmp/pip-b6OFBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:24:20 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)) 15:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:24:20 INFO - Running setup.py (path:/tmp/pip-kpw9Mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:24:21 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)) 15:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:24:21 INFO - Running setup.py (path:/tmp/pip-Hkvgfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:24:21 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)) 15:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:24:21 INFO - Running setup.py (path:/tmp/pip-pLICEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:24:21 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)) 15:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:24:21 INFO - Running setup.py (path:/tmp/pip-Je6ikJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:24:21 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)) 15:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:24:21 INFO - Running setup.py (path:/tmp/pip-Ch91mH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:24:21 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)) 15:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:24:21 INFO - Running setup.py (path:/tmp/pip-_0RGzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:24:21 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)) 15:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:24:21 INFO - Running setup.py (path:/tmp/pip-pcHUtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:24:21 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)) 15:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:24:21 INFO - Running setup.py (path:/tmp/pip-fMQeV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:24:21 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)) 15:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:24:21 INFO - Running setup.py (path:/tmp/pip-aYvzhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:24:21 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)) 15:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:24:21 INFO - Running setup.py (path:/tmp/pip-wzSvLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:24:21 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)) 15:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:24:21 INFO - Running setup.py (path:/tmp/pip-Rvq6aA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:24:21 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)) 15:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:24:21 INFO - Running setup.py (path:/tmp/pip-8zKrvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:24:21 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)) 15:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:24:21 INFO - Running setup.py (path:/tmp/pip-mfBLzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:24:21 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)) 15:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:21 INFO - Running setup.py (path:/tmp/pip-8_Vf6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:21 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)) 15:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:24:21 INFO - Running setup.py (path:/tmp/pip-DKWiHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:24:21 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)) 15:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:24:21 INFO - Running setup.py (path:/tmp/pip-2DGSrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:23 INFO - Downloading blessings-1.6.tar.gz 15:24:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:24:23 INFO - Installing collected packages: blessings 15:24:23 INFO - Running setup.py install for blessings 15:24:23 INFO - Successfully installed blessings 15:24:23 INFO - Cleaning up... 15:24:23 INFO - Return code: 0 15:24:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:24:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:23 INFO - Reading from file tmpfile_stdout 15:24:23 INFO - Current package versions: 15:24:23 INFO - argparse == 1.2.1 15:24:23 INFO - blessings == 1.6 15:24:23 INFO - blobuploader == 1.2.4 15:24:23 INFO - docopt == 0.6.1 15:24:23 INFO - functools32 == 3.2.3-2 15:24:23 INFO - jsonschema == 2.5.1 15:24:23 INFO - manifestparser == 1.1 15:24:23 INFO - mozInstall == 1.13 15:24:23 INFO - mozcrash == 1.0 15:24:23 INFO - mozdebug == 0.1 15:24:23 INFO - mozdevice == 0.51 15:24:23 INFO - mozfile == 1.2 15:24:23 INFO - mozhttpd == 0.7 15:24:23 INFO - mozinfo == 0.10 15:24:23 INFO - mozleak == 0.1 15:24:23 INFO - mozlog == 3.5 15:24:23 INFO - moznetwork == 0.27 15:24:23 INFO - mozprocess == 0.25 15:24:23 INFO - mozprofile == 0.28 15:24:23 INFO - mozrunner == 6.13 15:24:23 INFO - mozscreenshot == 0.1 15:24:23 INFO - mozsystemmonitor == 0.3 15:24:23 INFO - moztest == 0.8 15:24:23 INFO - mozversion == 1.4 15:24:23 INFO - psutil == 3.1.1 15:24:23 INFO - requests == 1.2.3 15:24:23 INFO - wsgiref == 0.1.2 15:24:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:23 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 0x210a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247a090>, '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 0x247ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2474f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', '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 15:24:23 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 15:24:23 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 15:24:23 INFO - Using env: {'DISPLAY': ':0', 15:24:23 INFO - 'HOME': '/home/cltbld', 15:24:23 INFO - 'LANG': 'en_US.UTF-8', 15:24:23 INFO - 'LANGUAGE': 'en_US:en', 15:24:23 INFO - 'LOGNAME': 'cltbld', 15:24:23 INFO - 'MAIL': '/var/mail/cltbld', 15:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:23 INFO - 'MOZ_NO_REMOTE': '1', 15:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:23 INFO - 'NO_EM_RESTART': '1', 15:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:23 INFO - 'PWD': '/builds/slave/test', 15:24:23 INFO - 'SHELL': '/bin/bash', 15:24:23 INFO - 'SHLVL': '1', 15:24:23 INFO - 'TERM': 'linux', 15:24:23 INFO - 'TMOUT': '86400', 15:24:23 INFO - 'USER': 'cltbld', 15:24:23 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', 15:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:23 INFO - '_': '/tools/buildbot/bin/python'} 15:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:23 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)) 15:24:23 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)) 15:24:23 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)) 15:24:23 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)) 15:24:23 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)) 15:24:23 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)) 15:24:23 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)) 15:24:23 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)) 15:24:23 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)) 15:24:23 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:24:23 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 15:24:23 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 15:24:23 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 15:24:23 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 15:24:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:24:25 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)) 15:24:25 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)) 15:24:25 INFO - Installing collected packages: simplejson 15:24:25 INFO - Running setup.py install for simplejson 15:24:25 INFO - building 'simplejson._speedups' extension 15:24:25 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 15:24:25 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 15:24:26 INFO - Successfully installed simplejson 15:24:26 INFO - Cleaning up... 15:24:26 INFO - Return code: 0 15:24:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:26 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 0x210a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2476a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247a090>, '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 0x247ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2474f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', '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 15:24:26 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 15:24:26 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 15:24:26 INFO - Using env: {'DISPLAY': ':0', 15:24:26 INFO - 'HOME': '/home/cltbld', 15:24:26 INFO - 'LANG': 'en_US.UTF-8', 15:24:26 INFO - 'LANGUAGE': 'en_US:en', 15:24:26 INFO - 'LOGNAME': 'cltbld', 15:24:26 INFO - 'MAIL': '/var/mail/cltbld', 15:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:26 INFO - 'MOZ_NO_REMOTE': '1', 15:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:26 INFO - 'NO_EM_RESTART': '1', 15:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:26 INFO - 'PWD': '/builds/slave/test', 15:24:26 INFO - 'SHELL': '/bin/bash', 15:24:26 INFO - 'SHLVL': '1', 15:24:26 INFO - 'TERM': 'linux', 15:24:26 INFO - 'TMOUT': '86400', 15:24:26 INFO - 'USER': 'cltbld', 15:24:26 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', 15:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:26 INFO - '_': '/tools/buildbot/bin/python'} 15:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:24:26 INFO - Cleaning up... 15:24:26 INFO - Return code: 0 15:24:26 INFO - Running post-action listener: _resource_record_post_action 15:24:26 INFO - Running post-action listener: _start_resource_monitoring 15:24:26 INFO - Starting resource monitoring. 15:24:26 INFO - [mozharness: 2017-09-17 22:24:26.318990Z] Finished create-virtualenv step (success) 15:24:26 INFO - [mozharness: 2017-09-17 22:24:26.319506Z] Running install step. 15:24:26 INFO - Running pre-action listener: _resource_record_pre_action 15:24:26 INFO - Running main action method: install 15:24:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:26 INFO - Reading from file tmpfile_stdout 15:24:26 INFO - Detecting whether we're running mozinstall >=1.0... 15:24:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:24:26 INFO - Reading from file tmpfile_stdout 15:24:26 INFO - Output received: 15:24:26 INFO - Usage: mozinstall [options] installer 15:24:26 INFO - Options: 15:24:26 INFO - -h, --help show this help message and exit 15:24:26 INFO - -d DEST, --destination=DEST 15:24:26 INFO - Directory to install application into. [default: 15:24:26 INFO - "/builds/slave/test"] 15:24:26 INFO - --app=APP Application being installed. [default: firefox] 15:24:26 INFO - mkdir: /builds/slave/test/build/application 15:24:26 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'] 15:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:24:44 INFO - Reading from file tmpfile_stdout 15:24:44 INFO - Output received: 15:24:44 INFO - /builds/slave/test/build/application/firefox/firefox 15:24:44 INFO - Running post-action listener: _resource_record_post_action 15:24:44 INFO - [mozharness: 2017-09-17 22:24:44.490322Z] Finished install step (success) 15:24:44 INFO - [mozharness: 2017-09-17 22:24:44.490574Z] Running setup-mitmproxy step. 15:24:44 INFO - Running pre-action listener: _resource_record_pre_action 15:24:44 INFO - Running main action method: setup_mitmproxy 15:24:44 INFO - Skipping: mitmproxy is not required 15:24:44 INFO - Running post-action listener: _resource_record_post_action 15:24:44 INFO - [mozharness: 2017-09-17 22:24:44.491699Z] Finished setup-mitmproxy step (success) 15:24:44 INFO - [mozharness: 2017-09-17 22:24:44.491918Z] Running run-tests step. 15:24:44 INFO - Running pre-action listener: _resource_record_pre_action 15:24:44 INFO - Running pre-action listener: _set_gcov_prefix 15:24:44 INFO - Running main action method: run_tests 15:24:44 WARNING - Try message not found. 15:24:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:24:44 INFO - Python 2.7.3 15:24:44 INFO - Return code: 0 15:24:44 INFO - grabbing minidump binary from tooltool 15:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:44 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 0x247a090>, '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 0x247ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2474f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:24:44 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 15:24:44 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 15:24:44 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 15:24:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:24:44 INFO - Return code: 0 15:24:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:24:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:24:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:24:44 INFO - ENV: RUST_BACKTRACE is now full 15:24:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:24:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:24:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:24:44 INFO - Using env: {'DISPLAY': ':0', 15:24:44 INFO - 'HOME': '/home/cltbld', 15:24:44 INFO - 'LANG': 'en_US.UTF-8', 15:24:44 INFO - 'LANGUAGE': 'en_US:en', 15:24:44 INFO - 'LOGNAME': 'cltbld', 15:24:44 INFO - 'MAIL': '/var/mail/cltbld', 15:24:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:24:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:24:44 INFO - 'MOZ_ACCELERATED': '1', 15:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:44 INFO - 'MOZ_NO_REMOTE': '1', 15:24:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:24:44 INFO - 'MOZ_WEBRENDER': '1', 15:24:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:44 INFO - 'NO_EM_RESTART': '1', 15:24:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:44 INFO - 'PWD': '/builds/slave/test', 15:24:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:24:44 INFO - 'RUST_BACKTRACE': 'full', 15:24:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:24:44 INFO - 'SHELL': '/bin/bash', 15:24:44 INFO - 'SHLVL': '1', 15:24:44 INFO - 'TERM': 'linux', 15:24:44 INFO - 'TMOUT': '86400', 15:24:44 INFO - 'USER': 'cltbld', 15:24:44 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', 15:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:44 INFO - '_': '/tools/buildbot/bin/python'} 15:24:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:24:44 INFO - mozversion application_buildid: 20170917213235 15:24:44 INFO - mozversion application_changeset: ae39864562c6048fdc2950c5dfedb48e247c3300 15:24:44 INFO - mozversion application_display_name: Nightly 15:24:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:24:44 INFO - mozversion application_name: Firefox 15:24:44 INFO - mozversion application_remotingname: firefox 15:24:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:24:44 INFO - mozversion application_vendor: Mozilla 15:24:44 INFO - mozversion application_version: 57.0a1 15:24:44 INFO - mozversion platform_buildid: 20170917213235 15:24:44 INFO - mozversion platform_changeset: ae39864562c6048fdc2950c5dfedb48e247c3300 15:24:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:24:44 INFO - mozversion platform_version: 57.0a1 15:24:44 INFO - using testdate: 1505687084 15:24:44 INFO - actual date: 1505687084 15:24:44 INFO - starting webserver on 'localhost:50570' 15:24:44 INFO - SUITE-START | Running 2 tests 15:24:44 INFO - TEST-START | dromaeo_css 15:24:44 INFO - Initialising browser for dromaeo_css test... 15:24:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50570/getInfo.html -profile /tmp/tmpKIIqwS/profile 15:24:44 INFO - TEST-INFO | started process 21504 (/builds/slave/test/build/application/firefox/firefox http://localhost:50570/getInfo.html) 15:24:51 INFO - TEST-INFO | 21504: exit 0 15:24:51 INFO - Browser initialized. 15:24:51 INFO - Running cycle 1/1 for dromaeo_css test... 15:24:51 INFO - Using env: {'DISPLAY': ':0', 15:24:51 INFO - 'HOME': '/home/cltbld', 15:24:51 INFO - 'JSGC_DISABLE_POISONING': '1', 15:24:51 INFO - 'LANG': 'en_US.UTF-8', 15:24:51 INFO - 'LANGUAGE': 'en_US:en', 15:24:51 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:24:51 INFO - 'LOGNAME': 'cltbld', 15:24:51 INFO - 'MAIL': '/var/mail/cltbld', 15:24:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:24:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:24:51 INFO - 'MOZ_ACCELERATED': '1', 15:24:51 INFO - 'MOZ_CRASHREPORTER': '1', 15:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:51 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:24:51 INFO - 'MOZ_NO_REMOTE': '1', 15:24:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:24:51 INFO - 'MOZ_WEBRENDER': '1', 15:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:51 INFO - 'NO_EM_RESTART': '1', 15:24:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:51 INFO - 'PWD': '/builds/slave/test', 15:24:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:24:51 INFO - 'RUST_BACKTRACE': 'full', 15:24:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:24:51 INFO - 'SHELL': '/bin/bash', 15:24:51 INFO - 'SHLVL': '1', 15:24:51 INFO - 'TERM': 'linux', 15:24:51 INFO - 'TMOUT': '86400', 15:24:51 INFO - 'USER': 'cltbld', 15:24:51 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', 15:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:51 INFO - '_': '/tools/buildbot/bin/python'} 15:24:51 INFO - TEST-INFO | started process 21751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKIIqwS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:24:52 INFO - PID 21751 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:24:52 INFO - PID 21751 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:24:53 INFO - PID 21751 | 15:24:53 INFO - PID 21751 | (/builds/slave/test/build/application/firefox/firefox:21810): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:24:53 INFO - PID 21751 | 15:25:03 INFO - PID 21751 | RSS: Main: 185110528 15:25:03 INFO - PID 21751 | 15:28:01 INFO - PID 21751 | Cycle 1(1): loaded http://localhost:50570/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50570/tests/dromaeo/cssquery-ext.html) 15:28:02 INFO - PID 21751 | RSS: Main: 186212352 15:28:02 INFO - PID 21751 | 15:31:04 INFO - PID 21751 | Cycle 1(1): loaded http://localhost:50570/tests/dromaeo/cssquery-ext.html (next: http://localhost:50570/tests/dromaeo/cssquery-jquery.html) 15:31:05 INFO - PID 21751 | RSS: Main: 187592704 15:31:05 INFO - PID 21751 | 15:34:07 INFO - PID 21751 | Cycle 1(1): loaded http://localhost:50570/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50570/tests/dromaeo/cssquery-mootools.html) 15:34:08 INFO - PID 21751 | RSS: Main: 189612032 15:34:08 INFO - PID 21751 | 15:37:10 INFO - PID 21751 | Cycle 1(1): loaded http://localhost:50570/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50570/tests/dromaeo/cssquery-prototype.html) 15:37:10 INFO - PID 21751 | RSS: Main: 184823808 15:37:10 INFO - PID 21751 | 15:40:14 INFO - PID 21751 | Cycle 1(1): loaded http://localhost:50570/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50570/tests/dromaeo/cssquery-yui.html) 15:40:14 INFO - PID 21751 | RSS: Main: 189497344 15:40:14 INFO - PID 21751 | 15:43:16 INFO - PID 21751 | Cycle 1(1): loaded http://localhost:50570/tests/dromaeo/cssquery-yui.html (next: http://localhost:50570/tests/dromaeo/cssquery-dojo.html) 15:43:17 INFO - PID 21751 | RSS: Main: 192172032 15:43:17 INFO - PID 21751 | 15:43:17 INFO - PID 21751 | __start_tp_report 15:43:17 INFO - PID 21751 | _x_x_mozilla_page_load 15:43:17 INFO - PID 21751 | _x_x_mozilla_page_load_details 15:43:17 INFO - PID 21751 | |i|pagename|runs| 15:43:17 INFO - PID 21751 | |0;dojo.html;3112.3152906360606;3112.4708799504083;3112.891048813292;3143.481325581279;3168.2554599669074;6106.511479081674;6268.341824108471;6307.148534947781;6322.051692246166;6378.872422551558;6189.597676151047;6207.37926207379;6342.0486926960975;6371.139896114023;6372.203474565679;5627.184058311543;5777.046787280094;5816.941830581683;5834.2998840139135;5848.502877255439;5665.433456654322;5733.512651424634;5810.070388737803;5815.273090863642;5837.824865254049;5558.416366281523;5649.661020338752;5706.1440783882335;5775.10485874688;5790.942090579082;5647.43525647436;5667.744951477193;5672.858178545528;5692;5698.202251684767;5655.745491452894;5706.172604972297;5718.685472299064;5721.170430287585;5728.79949201776;6191.81424557264;6203.906941395882;6233.688315584202;6251.499880009634;6297.275813281485;6638.336166383323;6679.9980002999455;6716.764913228014;6737.3599508046655;6765.357291057391;6444.935550644481;6622.4370928471135;6679.866402671968;6735.93264067358;6740.595564266159;6173.444390004921;6243.500519958392;6255.624662520263;6286.057091436275;6301.180846489973;6825.658717064127;6872.209695884937;6884.965575172092;6971.198312194163;6988.93011069893;6399.232092148972;6577.287616730395;6592.17597800275;6671.132752742113;6692.130023097064;6613.338666133348;6649.601023938482;6657.23441804189;6660.234073081658;6669.866602668017;6643;6644.966775166094;6660.967550029656;6704.329567043256;6728.461723062143;6736.157980252468;6780.050792888999;6816.182058153054;6816.284290149562;6816.965915170393;5267.078261304257;5295.602829787781;5320.600954928396;5333.066713325153;5363.222332761728;4569.017661202791;4574.4968053514085;4630.652701047435;4632.467266264355;4640.930386044212;5670.489655930986;5694.08894576874;5760.135979603093;5790.826275211751;5806.564507661942;6736.46108311334;6762.526623136333;6842.828929276709;6844;6844.691988860513;5777.422257774189;5778.8266352009505;5829.358770535237;5857;5884.146798714162;5567.387587365387;5728.942710572925;5760.567957403127;5819.359870414251;5855.882882342329;6414.967925160345;6493.31820158886;6498.025296205513;6501.772437964649;6511.088447617338;6723.327667233433;6733.2593414725325;6772.2211945625895;6811.795646130624;6821.3519715626935;6444.9355506444335;6475.902861457176;6536.281009089092;6538.117354157128;6567.573107747981;6456.063870738811;6474.5791523550815;6504.577202481823;6627.502937279627;6692.196936367667;6731.091302674076;6745.730170793114;6769.120014398097;6802.285759995327;6836.658167091725;6459.095726598186;6470.935290647033;6510.0885875976455;6513.706883190173;6536.607803531803;6507.349265073455;6519.674016299071;6540.9861471471995;6564.901526477202;6586.407223349922;6311.400416960381;6363.809085727436;6413.262474815269;6496.805095847132;6503;6532.444742196966;6574.572652777554;6607.372299631527;6607.933920660732;6620.2386725527185;6300.653464059521;6326.873462530815;6352.6506042166275;6431.678416079084;6439.323870993666 15:43:17 INFO - PID 21751 | |1;ext.html;839.6767244610825;860.672944281173;869.8390797702424;871.7123349294733;872.276010910944;38388.42417363738;41655.79172104135;41852.58147418525;41950.16099678005;42071.579284207146;38110.23779524408;38481.230375392544;38502.61497385025;38717.61282387182;38750.481218720764;6875.346842050009;6899.827504312382;6955.547889387173;6970.860582788341;7729.574873381962;7675.194104619019;7685.923140768605;7688.538687678757;7693.615319234043;7707.07515098189;7731.7680469586;7762.495437796525;7767.533947963112;7783.4940728852725;7812.53124812513;7649.770506884803;7693.615319234072;7709.922900770976;7758;7768.184340644236;7778.766637000899;7816.101148367954;7829.491083079582;7835.4123440741605;7857.0964339101165;37785.62214377876;37933.620663793285;38136;38262.80868595667;38275.808620956996;3570.696490798285;3572.0534058474527;3578.58846232684;3585.175409655768;3607.116256517144;31553.684463155303;31581.21046973821;31733.365332693447;31757.20606984821;31876.521852172235;5002.449730529639;5255.921161182585;5292.417834038291;5319.0957537218765;5362.946370536284;177062;178884.10557947258;179216;179364;182881.99999999866;43229.35155972663;49531.75234123806;49612.751936240085;50009.749951250014;50055;46141.769291154;51199.48800512022;51331.23003154956;51703.48296517062;51968.74015629973;16169.676606467805;16190.190490475428;16381.344746210018;16440;16473.6705265894;13347.866521334856;13414.597562073153;13463.798043029363;13567.59297221085;13645.38595763193;13474.663133421744;13489.123206991515;13547.390367433489;13693;13751.656208594864;5522;5558.305211848519;5627.606067575231;5726.055200891807;5729;986.3736527305069;987.3116969981269;992.1715367667933;1000.214831357381;1010.4493051286919;22774.43063923382;23084.192053278053;23112.306630801104;23166.37835351509;23223.303300901;1107.2304748199924;1109.91120710343;1113.4154568851418;1117.6423544465692;1125.8029844777132;11901.631312399011;11936.403179840972;12029.398530073462;12111.394430278451;12244.142909996393;217719;219944;220570;220752;221215;53570.46429535655;53797.46202538003;53923.73038134863;54467.18299225515;54605.45394546004;1397.6156556946921;1429.328215738622;1439.5465428390023;1455.097839339595;1455.6288146522782;22131.66802497996;22450.438739031;22971.425714357276;23009.769902301432;23038.193663221708;37902.62097378991;38028.61971380251;38102.618973809906;38272.42591361188;38365.61634383732;188024;189508.20983580526;189824;190063;190264;30199.547006794477;31056.534151987285;33724.156896077795;34947.47578786269;35590.28819423649;43619.78190109029;43726;44028;44475;44819.55180448154;32336.514952276204;32558;32573.837130814194;32735.508967365986;32876.835615821765;31978;32089.839550802095;32201.677983220805;32283.51574726334;32414.189645259055;33913.83043084868;35894.641053590174;36140.27719445544;36318.818405907805;36522.269554608225;31320;31431.21421964469;31513.8424307877;31731.52402713915;32234.35531289314;23210.65184022207;23557.29328120159;23775.762242377354;24025;24277.271681849572 15:43:17 INFO - PID 21751 | |2;jquery.html;560.763516446236;563.4956713741202;570.3811364669334;574.9827505174843;586.3403670870271;21454.356369308905;22047.559048819036;22101.447463813372;22189.667154992647;22374.664380034294;23052;24806.379840503996;25076.87461562694;25086;25411.491770164634;6396.808095757135;6539.08452816606;6542.542022058457;6560.015997600351;6566.1464009678675;6452.838679033015;6537.673116344187;6596.571222870522;6601.66991650418;6603.339666033382;6246.469050130744;6531.314212007742;6535.869282614369;6547.3125321841235;6555.0495178199135;6433.8713225735455;6477.319881412431;6493.31820158886;6509.6419696916655;6510.08858759774;5951.732172052268;6061.878762424727;6067.089936509515;6072.119542666289;6073.0283154695035;27615;27852.30369240785;28119.43761124766;28134.2966425841;28255.858720706266;2074.1392322186275;2113.080809847706;2117.6717608770664;2120.1943261560664;2131.211451762842;18760.24959001638;19288.61422771551;19459.708104378446;19560.43516518675;19620.80379196204;2281.977180228193;2320.338703469503;2324.3840382298704;2331.4521087544413;2332.825038122148;121246;125187;131910.3404482981;138468.30765846206;139221.3038934809;14169.362378692984;14361.425542978373;14460.713143194791;14723.337449814784;14823.332950017275;22398.216062437736;22454.32637020892;22476;22497.325080247618;22544.436389090075;9788.706338809847;10093;10251.38491690501;10288.948555257175;10328.638497652546;9358.989069538793;9436.339456237998;9480.33637645372;9614.615415383307;9614.855777163348;8590.797288379632;8678.783030424163;8932.240759535382;8939;9142.085791420937;2541.834780739283;2610.190840839346;2657.3489495073445;2682.329417645589;2686.3881670997635;944.8866136063716;959.4866746290841;966.1594412860856;972.5720682899502;975.2198241406846;18466.722999155023;18653.533661658297;18654.44036678902;19013.904930475535;19250.422487325402;1014.8021135878433;1018.0803904965823;1027.9897201027893;1030.7886883188928;1032.0608246495653;10319.329243599143;10441;10508.894911050791;10534.420606866695;10594.442700626298;428440;436771;439519;448007;452943;107174;108666.45666771615;110336;112117.43941280241;112468.43765781118;1163.2148299897535;1173.6479056283251;1205.421397729095;1207.4988879615037;1207.9758404831855;16731.862203509398;16889.32442702278;16890.24786286346;17028.48914532566;17382.652346953244;52859;54162;54520.45479545154;54739.63150921259;55314.170287446526;67459.66270168814;67951.3204867945;68304.31695682979;69273;69293.30706692868;13055.804162937753;13989.580312590639;14051.508197213048;14097.788533172215;14228.715425691635;21742;21839.672404914258;22105.115795368005;22246.555068898855;22340.553188935806;17089.91455042717;17709;17812.91093544524;17814.91092544529;18071.186796593924;16182.757258640895;16211;16401.17994100314;16650.833491665413;16675.833241667915;17954.910225448788;17972.10139493046;17979.370722024665;18051;18286.359977400727;13621.114627549177;13760.793588095987;13885.166889986633;13889.930550347588;13896.305184740924;17714.114294285493;17761.289548418434;17768;17826.46520604384;17931.551711207325 15:43:17 INFO - PID 21751 | |3;mootools.html;1298.2340419152697;1346.5219846954326;1359.6464919121026;1362.3052243355892;1391.6729568551389;14699.706005879876;15266.313015914282;15327.923360383182;15362.692746145085;15387.23063846806;14884.330205140768;15033.248337583105;15059.77410338843;15071.62320941977;15077.472288469906;2677.6519052523195;2778.402643431662;2779.1662501249643;2779.791515636325;2782.526970415024;2633.2100369889054;2712.6609173853267;2732.330579008146;2737.7536021758037;2744.5745909384077;2635.367511797174;2669.452762183748;2750.917472475829;2751.876165572554;2763.2401089700293;2720.319920019995;2720.5375086235385;2737.9178624641295;2759.3377589378506;2762.2818067302446;2590.831595946276;2611.490759301937;2615.5684312088483;2632.289281893878;2633.0389407866182;14756.48352307664;14768;14854.405823767036;14943.925280373529;15039.172845493493;7776.805579860492;8025.157358477334;8127.75616731499;8131.942847429856;8141.348692104618;5464.863378415532;5581.302337207849;5585.497305242548;5631.690257035862;5652.576056795757;1906.4376009077355;1932.0822609260629;1933.2556965568217;1966.4690533556002;1980.2771988224338;25856.224313270443;25875.353116172057;26073.608895866386;26095.217143485726;26116.085936992113;6460.676966151767;6547.8363040923405;6865.725370985105;6889.552179108342;7060.082189315356;17049.7442538362;17159.571010724583;17160.570985725208;17165.485035448957;17170.484885453458;7671.884921726179;7938.285554300141;7964.123946365895;7975.72084977023;7977.960110199528;7115.6086415247655;7261.164966028869;7261.2012678605315;7308.6345682715655;7349.669264883093;5106.080905437057;5157.742112894341;5254.211868219798;5263.23683065961;5274.1034024215205;1404.4803422733653;1470.117929242446;1544.691061787647;1553.883458740599;1582.6834633073431;850.9319254459629;880.1770344727701;891.4651209274513;893.9508327041945;910.8360495110944;8165.428420010542;8176.323853609995;8310.085890552034;8325;8372.246497815226;703.5743375257895;714.9356557909813;716.8064622551882;720.4020662849822;804.6901942751965;5026.421961474404;5138.563222126161;5150.665206761549;5313.282706834605;5371.57027437804;20871.686924696143;21576.244831431137;21739.456513587287;22033.77966220317;22075.889620552116;21328.680069798964;21413.46466338354;21683.024263908163;21717.13131474755;21743;10886.61896833607;11321.150913681671;11354;11371;11592.594259200887;7853.921460785319;8058.919410805817;8071.152528984607;8075.273225409741;8075.515469071875;18136.18387172554;18379.264829406675;18629.627407451502;18828.52928676794;19030.143643535797;18799.718004229675;19296;19312.90343548273;19363.90318048401;19744.210231590576;10906.727331816768;11059.889401105886;11093.667189983991;11101.5559377624;11102.389368584805;12793.296368699439;12959.35203239853;13080.672983175496;13106.541271055466;13263;10941.83587246208;11042.116630669367;11316.321020738782;11407.828882566933;11493.080553555863;11320.943395282971;11337.149713771665;11375.886241137483;11589.130815189063;11614.245074070159;9167.358284919992;9359.438433694;9403.059694030542;9428.57571409302;9461.195798357217;5975.940240597538;6093;6126.111713801563;6264.404881536247;6300.621962682254;6806.897896531655;6850.623215723183;6903.689333979883;6912.066870972555;7002.2647622000995 15:43:17 INFO - PID 21751 | |4;prototype.html;498.4995164554692;504.82835835815814;512.4158459356337;527.6385675812069;530.1226470191833;6259.655718935457;6336.714847831847;6340.809775706731;6389.584676995992;6393.808185754429;6240.3759624037575;6263.498920086394;6288.685565721718;6305.464035556972;6343.302236753953;5131.230315452674;5151.639385243035;5160.406553246368;5164.612654050942;5170.819021334254;5053.180854892235;5127.2052831811125;5131.461196574343;5164.870878228036;5167.054778776099;4733.928991065137;4870.245112007645;4909.140900342426;4911.729854857981;4918.532739389752;4893.706377617319;4929.8028078876805;4937.382827146606;4945.826896058638;4960.578350840201;4298.806553705091;4406.801693923781;4455.688101832873;4457.175422546839;4466.709663871838;6023.789167379121;6055.455009049163;6060.727267272983;6068;6134.601250918676;5603.523700485463;5610.438956104357;5623.8594035149035;5642.4075472075665;5651.180578816049;6509.381608747161;6562.409383155539;6571.080048793173;6572;6580.835479113012;4545.840895568639;4766.4995175506765;4772.880677983078;4808.230683090689;4838.927416088762;6698.263191048981;6792.422644075259;6967.651617419108;7029.648517574101;7036.155661320623;5428.647137936022;5440.945590544123;5444.265024221759;5459.727013649302;5494.670319780826;5493.972530137324;5502.752376143083;5504.972475137599;5505.642133261325;5507.421720719347;5913.674747888821;5933.3473317934995;5984.970075149684;5985.2491024123865;5993.250843644544;6668.966655166693;6677.53257271996;6740.561863478858;6756.628385438749;6767.221769496472;1918.5491409518752;1932.990335048344;1935.335611374217;1939.2921583621876;1944.572194117292;1359.429039803285;1398.189050350794;1408.5070225421225;1416.5821082780606;1419.1626940105386;5673.773049078073;5683.26117604717;5706.572007099484;5715;5732.140178973104;6559.44244739193;6657.368944608505;6753.3921947025;6776.15298087739;6786.898196527056;5568.633330834379;5625.206037781092;5668.489835914787;5724.599278050497;5760.0783874579865;3494;3520.6303338149637;3543.4684797280615;3570.589382221078;3580.964190358115;6270.435660790551;6312.936870631235;6365.172527571386;6384.7126879290545;6408.327125651833;6660.733570657119;6670.763450691281;6727.62998035103;6754.542002278571;6777.627230502271;6279.686015699197;6315.400036996478;6324.3043265240785;6386;6389.242958186443;6386.9361306386345;6566.815094678981;6567.408933196035;6615.213892249162;6633.668316584055;6572.474202063919;6575.671216439063;6594.736210551524;6608.240052394036;6616.636085015178;6406.967965160145;6482.865498537832;6510.609363438209;6526.151600292122;6542.869142617026;5289.18017707256;5301.708406037705;5360.748485635964;5362.410134885082;5364.5515710758655;6420.935790642034;6616.470682345497;6699.53103282785;6704.195496540447;6734.427573656294;6284.465820405317;6444.4844412445955;6543.149390579194;6556.442702370161;6580.341965803382;6451.3550243824375;6458.903116453163;6460.806175814733;6530.412262896172;6551.296662867784;6311.368863113652;6370.968145159244;6378.330275321025;6415.454686351713;6418.261899881573;6302.920036388073;6398.424141827071;6504.804855854142;6511.883637817634;6573.3098024706715;6177.907331390123;6265.937340626535;6359.459445947146;6381.266154392304;6395.93604063972 15:43:17 INFO - PID 21751 | |5;yui.html;902.1519771414874;906.3157316226249;927.5547737086198;931.483026920059;936.190195480909;18866.90566547167;19797.802021979795;20008.299709510153;20033.298834540794;20157;18258.634827303445;18698.813011869875;18834.71747923782;19128.713069303973;19351.225950961943;948.0519480519481;966.9226461883032;970.8883478400004;971.3977334052897;972.2416515118219;973.304087577382;975.790205105902;976.2043934193609;983.9163671087966;989.3816364772017;988.4711679251602;1021.2493817044466;1029.7888932768801;1030.4744580264082;1030.7474668706177;1011.701548043329;1020.1328870460123;1021.5403068619077;1022.4632068164199;1026.1021606094666;720.8630360231591;744.0959234530072;749.4266885832343;756.0964647246543;756.2475337039626;17040.40358587456;17075.743863842054;17078.914605427017;17085.316587336492;17312;18801.15394807237;19243.807561924343;19314.32399865998;19432.319868804523;19627;16943.237554309962;17356.39252626152;17408.82591174085;17436.12819359027;17499.650006999917;3721.4045752679713;3722.7952462614544;3746.3256613809504;3753.6621704046493;3757.2861156380472;138295;144148;144489.27755361155;146559;147869;15065.623359416102;17400.47798566045;17571.824281757017;17660.763746537876;17723.911380443016;31093.378132437225;32079;32096.197595060312;32114.19714507156;32258.677413226036;8436.957815210884;8458.069612342637;8469.618867150994;8499.937507811523;8593.269572086443;4091.3453847384276;4182.749035057906;4197.601227883346;4225.133847561243;4227.281362168439;5139.563137133311;5379.058664733734;5383.919241211385;5414.133738601805;5439.836804895859;983.7491439682835;1006.627547807316;1013.4274135113637;1016.044917777287;1022.6983040003217;685.3420716112588;685.3797313431353;703.6692754405422;712.6329940080863;722.4184531452127;10177.236707246839;10475.42385168823;10573.894261057445;10746;12195.634130976085;691.1222747111141;693.3447891742255;695.2456584605759;704.8907419350008;712.1098626716604;5429.728513574384;5452.318460192476;5518.978988887069;5572.4706152915405;5585.692786896679;121614;123666;124712;125171;128027.3598632001;107452.92547074586;108046.45976770222;108456.20403285847;108673.4566327179;109571.45214274037;88312;88729;89715.55142224378;90827.99999999868;94095;9873.851892221766;9902.059304366361;10077.748056298651;10083.344582602107;10093.69718908434;43399.78300108479;44294.557054429046;44529.55470445254;44767.776161118985;45492;54823;57258.713706431205;57401.425985741276;57674;57874;14374.3531541083;14883.925580372463;15014;15033.473828415952;15196.772048419503;15288.388464461297;15322;15402.84597154059;15493.225338732793;15581.844181558039;15200.239988000776;15262;15294.694106118039;15313.310901009258;15350.769738454155;14772.852271477148;14900.329485172977;14934.701305973602;15002.174880381684;15015.924920375328;14430.927845360706;14576.489822856149;14652.487162949672;14694.853051469348;14768.556943291718;10215.795684086424;10258.230632702727;10505.68482945513;10637.361758294526;10691.625793097204;10085.899141008496;10179.185665146622;10208.744781380525;10311.845322320321;10475.266731328733 15:43:17 INFO - PID 21751 | __end_tp_report 15:43:17 INFO - PID 21751 | __start_cc_report 15:43:17 INFO - PID 21751 | _x_x_mozilla_cycle_collect,279 15:43:17 INFO - PID 21751 | __end_cc_report 15:43:17 INFO - PID 21751 | __startTimestamp1505688197156__endTimestamp 15:43:17 INFO - PID 21751 | 15:43:17 INFO - PID 21751 | ------- Summary: start ------- 15:43:17 INFO - PID 21751 | Number of tests: 6 15:43:17 INFO - PID 21751 | 15:43:17 INFO - PID 21751 | [#0] dojo.html Cycles:165 Average:6162.16 Median:6414.97 stddev:744.07 (11.6%) stddev-sans-first:706.84 15:43:17 INFO - PID 21751 | Values: 3112.3 3112.5 3112.9 3143.5 3168.3 6106.5 6268.3 6307.1 6322.1 6378.9 6189.6 6207.4 6342.0 6371.1 6372.2 5627.2 5777.0 5816.9 5834.3 5848.5 5665.4 5733.5 5810.1 5815.3 5837.8 5558.4 5649.7 5706.1 5775.1 5790.9 5647.4 5667.7 5672.9 5692.0 5698.2 5655.7 5706.2 5718.7 5721.2 5728.8 6191.8 6203.9 6233.7 6251.5 6297.3 6638.3 6680.0 6716.8 6737.4 6765.4 6444.9 6622.4 6679.9 6735.9 6740.6 6173.4 6243.5 6255.6 6286.1 6301.2 6825.7 6872.2 6885.0 6971.2 6988.9 6399.2 6577.3 6592.2 6671.1 6692.1 6613.3 6649.6 6657.2 6660.2 6669.9 6643.0 6645.0 6661.0 6704.3 6728.5 6736.2 6780.1 6816.2 6816.3 6817.0 5267.1 5295.6 5320.6 5333.1 5363.2 4569.0 4574.5 4630.7 4632.5 4640.9 5670.5 5694.1 5760.1 5790.8 5806.6 6736.5 6762.5 6842.8 6844.0 6844.7 5777.4 5778.8 5829.4 5857.0 5884.1 5567.4 5728.9 5760.6 5819.4 5855.9 6415.0 6493.3 6498.0 6501.8 6511.1 6723.3 6733.3 6772.2 6811.8 6821.4 6444.9 6475.9 6536.3 6538.1 6567.6 6456.1 6474.6 6504.6 6627.5 6692.2 6731.1 6745.7 6769.1 6802.3 6836.7 6459.1 6470.9 6510.1 6513.7 6536.6 6507.3 6519.7 6541.0 6564.9 6586.4 6311.4 6363.8 6413.3 6496.8 6503.0 6532.4 6574.6 6607.4 6607.9 6620.2 6300.7 6326.9 6352.7 6431.7 6439.3 15:43:17 INFO - PID 21751 | 15:43:17 INFO - PID 21751 | [#1] ext.html Cycles:180 Average:36697.84 Median:3581.88 stddev:51021.14 (1424.4%) stddev-sans-first:51093.23 15:43:17 INFO - PID 21751 | Values: 839.7 860.7 869.8 871.7 872.3 38388.4 41655.8 41852.6 41950.2 42071.6 38110.2 38481.2 38502.6 38717.6 38750.5 6875.3 6899.8 6955.5 6970.9 7729.6 7675.2 7685.9 7688.5 7693.6 7707.1 7731.8 7762.5 7767.5 7783.5 7812.5 7649.8 7693.6 7709.9 7758.0 7768.2 7778.8 7816.1 7829.5 7835.4 7857.1 37785.6 37933.6 38136.0 38262.8 38275.8 3570.7 3572.1 3578.6 3585.2 3607.1 31553.7 31581.2 31733.4 31757.2 31876.5 5002.4 5255.9 5292.4 5319.1 5362.9 177062.0 178884.1 179216.0 179364.0 182882.0 43229.4 49531.8 49612.8 50009.7 50055.0 46141.8 51199.5 51331.2 51703.5 51968.7 16169.7 16190.2 16381.3 16440.0 16473.7 13347.9 13414.6 13463.8 13567.6 13645.4 13474.7 13489.1 13547.4 13693.0 13751.7 5522.0 5558.3 5627.6 5726.1 5729.0 986.4 987.3 992.2 1000.2 1010.4 22774.4 23084.2 23112.3 23166.4 23223.3 1107.2 1109.9 1113.4 1117.6 1125.8 11901.6 11936.4 12029.4 12111.4 12244.1 217719.0 219944.0 220570.0 220752.0 221215.0 53570.5 53797.5 53923.7 54467.2 54605.5 1397.6 1429.3 1439.5 1455.1 1455.6 22131.7 22450.4 22971.4 23009.8 23038.2 37902.6 38028.6 38102.6 38272.4 38365.6 188024.0 189508.2 189824.0 190063.0 190264.0 30199.5 31056.5 33724.2 34947.5 35590.3 43619.8 43726.0 44028.0 44475.0 44819.6 32336.5 32558.0 32573.8 32735.5 32876.8 31978.0 32089.8 32201.7 32283.5 32414.2 33913.8 35894.6 36140.3 36318.8 36522.3 31320.0 31431.2 31513.8 31731.5 32234.4 23210.7 23557.3 23775.8 24025.0 24277.3 15:43:17 INFO - PID 21751 | 15:43:17 INFO - PID 21751 | [#2] jquery.html Cycles:180 Average:32603.25 Median:22218.11 stddev:74699.61 (336.2%) stddev-sans-first:74870.42 15:43:17 INFO - PID 21751 | Values: 560.8 563.5 570.4 575.0 586.3 21454.4 22047.6 22101.4 22189.7 22374.7 23052.0 24806.4 25076.9 25086.0 25411.5 6396.8 6539.1 6542.5 6560.0 6566.1 6452.8 6537.7 6596.6 6601.7 6603.3 6246.5 6531.3 6535.9 6547.3 6555.0 6433.9 6477.3 6493.3 6509.6 6510.1 5951.7 6061.9 6067.1 6072.1 6073.0 27615.0 27852.3 28119.4 28134.3 28255.9 2074.1 2113.1 2117.7 2120.2 2131.2 18760.2 19288.6 19459.7 19560.4 19620.8 2282.0 2320.3 2324.4 2331.5 2332.8 121246.0 125187.0 131910.3 138468.3 139221.3 14169.4 14361.4 14460.7 14723.3 14823.3 22398.2 22454.3 22476.0 22497.3 22544.4 9788.7 10093.0 10251.4 10288.9 10328.6 9359.0 9436.3 9480.3 9614.6 9614.9 8590.8 8678.8 8932.2 8939.0 9142.1 2541.8 2610.2 2657.3 2682.3 2686.4 944.9 959.5 966.2 972.6 975.2 18466.7 18653.5 18654.4 19013.9 19250.4 1014.8 1018.1 1028.0 1030.8 1032.1 10319.3 10441.0 10508.9 10534.4 10594.4 428440.0 436771.0 439519.0 448007.0 452943.0 107174.0 108666.5 110336.0 112117.4 112468.4 1163.2 1173.6 1205.4 1207.5 1208.0 16731.9 16889.3 16890.2 17028.5 17382.7 52859.0 54162.0 54520.5 54739.6 55314.2 67459.7 67951.3 68304.3 69273.0 69293.3 13055.8 13989.6 14051.5 14097.8 14228.7 21742.0 21839.7 22105.1 22246.6 22340.6 17089.9 17709.0 17812.9 17814.9 18071.2 16182.8 16211.0 16401.2 16650.8 16675.8 17954.9 17972.1 17979.4 18051.0 18286.4 13621.1 13760.8 13885.2 13889.9 13896.3 17714.1 17761.3 17768.0 17826.5 17931.6 15:43:17 INFO - PID 21751 | 15:43:17 INFO - PID 21751 | [#3] mootools.html Cycles:180 Average:9225.46 Median:2634.29 stddev:6640.47 (252.1%) stddev-sans-first:6632.39 15:43:17 INFO - PID 21751 | Values: 1298.2 1346.5 1359.6 1362.3 1391.7 14699.7 15266.3 15327.9 15362.7 15387.2 14884.3 15033.2 15059.8 15071.6 15077.5 2677.7 2778.4 2779.2 2779.8 2782.5 2633.2 2712.7 2732.3 2737.8 2744.6 2635.4 2669.5 2750.9 2751.9 2763.2 2720.3 2720.5 2737.9 2759.3 2762.3 2590.8 2611.5 2615.6 2632.3 2633.0 14756.5 14768.0 14854.4 14943.9 15039.2 7776.8 8025.2 8127.8 8131.9 8141.3 5464.9 5581.3 5585.5 5631.7 5652.6 1906.4 1932.1 1933.3 1966.5 1980.3 25856.2 25875.4 26073.6 26095.2 26116.1 6460.7 6547.8 6865.7 6889.6 7060.1 17049.7 17159.6 17160.6 17165.5 17170.5 7671.9 7938.3 7964.1 7975.7 7978.0 7115.6 7261.2 7261.2 7308.6 7349.7 5106.1 5157.7 5254.2 5263.2 5274.1 1404.5 1470.1 1544.7 1553.9 1582.7 850.9 880.2 891.5 894.0 910.8 8165.4 8176.3 8310.1 8325.0 8372.2 703.6 714.9 716.8 720.4 804.7 5026.4 5138.6 5150.7 5313.3 5371.6 20871.7 21576.2 21739.5 22033.8 22075.9 21328.7 21413.5 21683.0 21717.1 21743.0 10886.6 11321.2 11354.0 11371.0 11592.6 7853.9 8058.9 8071.2 8075.3 8075.5 18136.2 18379.3 18629.6 18828.5 19030.1 18799.7 19296.0 19312.9 19363.9 19744.2 10906.7 11059.9 11093.7 11101.6 11102.4 12793.3 12959.4 13080.7 13106.5 13263.0 10941.8 11042.1 11316.3 11407.8 11493.1 11320.9 11337.1 11375.9 11589.1 11614.2 9167.4 9359.4 9403.1 9428.6 9461.2 5975.9 6093.0 6126.1 6264.4 6300.6 6806.9 6850.6 6903.7 6912.1 7002.3 15:43:17 INFO - PID 21751 | 15:43:17 INFO - PID 21751 | [#4] prototype.html Cycles:180 Average:5535.97 Median:6209.14 stddev:1502.59 (24.2%) stddev-sans-first:1458.45 15:43:17 INFO - PID 21751 | Values: 498.5 504.8 512.4 527.6 530.1 6259.7 6336.7 6340.8 6389.6 6393.8 6240.4 6263.5 6288.7 6305.5 6343.3 5131.2 5151.6 5160.4 5164.6 5170.8 5053.2 5127.2 5131.5 5164.9 5167.1 4733.9 4870.2 4909.1 4911.7 4918.5 4893.7 4929.8 4937.4 4945.8 4960.6 4298.8 4406.8 4455.7 4457.2 4466.7 6023.8 6055.5 6060.7 6068.0 6134.6 5603.5 5610.4 5623.9 5642.4 5651.2 6509.4 6562.4 6571.1 6572.0 6580.8 4545.8 4766.5 4772.9 4808.2 4838.9 6698.3 6792.4 6967.7 7029.6 7036.2 5428.6 5440.9 5444.3 5459.7 5494.7 5494.0 5502.8 5505.0 5505.6 5507.4 5913.7 5933.3 5985.0 5985.2 5993.3 6669.0 6677.5 6740.6 6756.6 6767.2 1918.5 1933.0 1935.3 1939.3 1944.6 1359.4 1398.2 1408.5 1416.6 1419.2 5673.8 5683.3 5706.6 5715.0 5732.1 6559.4 6657.4 6753.4 6776.2 6786.9 5568.6 5625.2 5668.5 5724.6 5760.1 3494.0 3520.6 3543.5 3570.6 3581.0 6270.4 6312.9 6365.2 6384.7 6408.3 6660.7 6670.8 6727.6 6754.5 6777.6 6279.7 6315.4 6324.3 6386.0 6389.2 6386.9 6566.8 6567.4 6615.2 6633.7 6572.5 6575.7 6594.7 6608.2 6616.6 6407.0 6482.9 6510.6 6526.2 6542.9 5289.2 5301.7 5360.7 5362.4 5364.6 6420.9 6616.5 6699.5 6704.2 6734.4 6284.5 6444.5 6543.1 6556.4 6580.3 6451.4 6458.9 6460.8 6530.4 6551.3 6311.4 6371.0 6378.3 6415.5 6418.3 6302.9 6398.4 6504.8 6511.9 6573.3 6177.9 6265.9 6359.5 6381.3 6395.9 15:43:17 INFO - PID 21751 | 15:43:17 INFO - PID 21751 | [#5] yui.html Cycles:180 Average:23961.33 Median:18997.81 stddev:35692.80 (187.9%) stddev-sans-first:35750.94 15:43:17 INFO - PID 21751 | Values: 902.2 906.3 927.6 931.5 936.2 18866.9 19797.8 20008.3 20033.3 20157.0 18258.6 18698.8 18834.7 19128.7 19351.2 948.1 966.9 970.9 971.4 972.2 973.3 975.8 976.2 983.9 989.4 988.5 1021.2 1029.8 1030.5 1030.7 1011.7 1020.1 1021.5 1022.5 1026.1 720.9 744.1 749.4 756.1 756.2 17040.4 17075.7 17078.9 17085.3 17312.0 18801.2 19243.8 19314.3 19432.3 19627.0 16943.2 17356.4 17408.8 17436.1 17499.7 3721.4 3722.8 3746.3 3753.7 3757.3 138295.0 144148.0 144489.3 146559.0 147869.0 15065.6 17400.5 17571.8 17660.8 17723.9 31093.4 32079.0 32096.2 32114.2 32258.7 8437.0 8458.1 8469.6 8499.9 8593.3 4091.3 4182.7 4197.6 4225.1 4227.3 5139.6 5379.1 5383.9 5414.1 5439.8 983.7 1006.6 1013.4 1016.0 1022.7 685.3 685.4 703.7 712.6 722.4 10177.2 10475.4 10573.9 10746.0 12195.6 691.1 693.3 695.2 704.9 712.1 5429.7 5452.3 5519.0 5572.5 5585.7 121614.0 123666.0 124712.0 125171.0 128027.4 107452.9 108046.5 108456.2 108673.5 109571.5 88312.0 88729.0 89715.6 90828.0 94095.0 9873.9 9902.1 10077.7 10083.3 10093.7 43399.8 44294.6 44529.6 44767.8 45492.0 54823.0 57258.7 57401.4 57674.0 57874.0 14374.4 14883.9 15014.0 15033.5 15196.8 15288.4 15322.0 15402.8 15493.2 15581.8 15200.2 15262.0 15294.7 15313.3 15350.8 14772.9 14900.3 14934.7 15002.2 15015.9 14430.9 14576.5 14652.5 14694.9 14768.6 10215.8 10258.2 10505.7 10637.4 10691.6 10085.9 10179.2 10208.7 10311.8 10475.3 15:43:17 INFO - PID 21751 | -------- Summary: end -------- 15:43:17 INFO - PID 21751 | 15:43:18 INFO - TEST-INFO | 21751: exit 0 15:43:18 INFO - TEST-OK | dromaeo_css | took 1113187ms 15:43:18 INFO - TEST-START | kraken 15:43:18 INFO - Initialising browser for kraken test... 15:43:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50570/getInfo.html -profile /tmp/tmpzylIvS/profile 15:43:18 INFO - TEST-INFO | started process 22128 (/builds/slave/test/build/application/firefox/firefox http://localhost:50570/getInfo.html) 15:43:23 INFO - TEST-INFO | 22128: exit 0 15:43:24 INFO - Browser initialized. 15:43:24 INFO - Running cycle 1/1 for kraken test... 15:43:24 INFO - Using env: {'DISPLAY': ':0', 15:43:24 INFO - 'HOME': '/home/cltbld', 15:43:24 INFO - 'JSGC_DISABLE_POISONING': '1', 15:43:24 INFO - 'LANG': 'en_US.UTF-8', 15:43:24 INFO - 'LANGUAGE': 'en_US:en', 15:43:24 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:43:24 INFO - 'LOGNAME': 'cltbld', 15:43:24 INFO - 'MAIL': '/var/mail/cltbld', 15:43:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:43:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:43:24 INFO - 'MOZ_ACCELERATED': '1', 15:43:24 INFO - 'MOZ_CRASHREPORTER': '1', 15:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:24 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:43:24 INFO - 'MOZ_NO_REMOTE': '1', 15:43:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:43:24 INFO - 'MOZ_WEBRENDER': '1', 15:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:24 INFO - 'NO_EM_RESTART': '1', 15:43:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:24 INFO - 'PWD': '/builds/slave/test', 15:43:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:43:24 INFO - 'RUST_BACKTRACE': 'full', 15:43:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:43:24 INFO - 'SHELL': '/bin/bash', 15:43:24 INFO - 'SHLVL': '1', 15:43:24 INFO - 'TERM': 'linux', 15:43:24 INFO - 'TMOUT': '86400', 15:43:24 INFO - 'USER': 'cltbld', 15:43:24 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310', 15:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:24 INFO - '_': '/tools/buildbot/bin/python'} 15:43:24 INFO - TEST-INFO | started process 22374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzylIvS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:43:24 INFO - PID 22374 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:43:25 INFO - PID 22374 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:43:25 INFO - PID 22374 | 15:43:25 INFO - PID 22374 | (/builds/slave/test/build/application/firefox/firefox:22433): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:43:25 INFO - PID 22374 | 15:43:35 INFO - PID 22374 | RSS: Main: 189386752 15:43:35 INFO - PID 22374 | 15:43:38 INFO - PID 22374 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50570/tests/kraken/driver.html?testName=audio-beat-detection) 15:43:39 INFO - PID 22374 | RSS: Main: 187518976 15:43:39 INFO - PID 22374 | 15:43:41 INFO - PID 22374 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50570/tests/kraken/driver.html?testName=audio-dft) 15:43:42 INFO - PID 22374 | RSS: Main: 186859520 15:43:42 INFO - PID 22374 | 15:43:45 INFO - PID 22374 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50570/tests/kraken/driver.html?testName=audio-fft) 15:43:46 INFO - PID 22374 | RSS: Main: 183541760 15:43:46 INFO - PID 22374 | 15:43:48 INFO - PID 22374 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50570/tests/kraken/driver.html?testName=audio-oscillator) 15:43:49 INFO - PID 22374 | RSS: Main: 184770560 15:43:49 INFO - PID 22374 | 15:43:51 INFO - PID 22374 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50570/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:43:51 INFO - PID 22374 | RSS: Main: 184451072 15:43:51 INFO - PID 22374 | 15:43:55 INFO - PID 22374 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50570/tests/kraken/driver.html?testName=imaging-darkroom) 15:43:55 INFO - PID 22374 | RSS: Main: 187666432 15:43:55 INFO - PID 22374 | 15:43:59 INFO - PID 22374 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50570/tests/kraken/driver.html?testName=imaging-desaturate) 15:43:59 INFO - PID 22374 | RSS: Main: 186720256 15:43:59 INFO - PID 22374 | 15:44:03 INFO - PID 22374 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50570/tests/kraken/driver.html?testName=json-parse-financial) 15:44:03 INFO - PID 22374 | RSS: Main: 186810368 15:44:03 INFO - PID 22374 | 15:44:05 INFO - PID 22374 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50570/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:44:05 INFO - PID 22374 | RSS: Main: 187650048 15:44:05 INFO - PID 22374 | 15:44:07 INFO - PID 22374 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50570/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:44:08 INFO - PID 22374 | RSS: Main: 183885824 15:44:08 INFO - PID 22374 | 15:44:10 INFO - PID 22374 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50570/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:44:11 INFO - PID 22374 | RSS: Main: 183775232 15:44:11 INFO - PID 22374 | 15:44:13 INFO - PID 22374 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50570/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:44:14 INFO - PID 22374 | RSS: Main: 184692736 15:44:14 INFO - PID 22374 | 15:44:17 INFO - PID 22374 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50570/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:44:17 INFO - PID 22374 | RSS: Main: 185028608 15:44:17 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50570/tests/kraken/driver.html?testName=ai-astar) 15:44:19 INFO - PID 22374 | RSS: Main: 186081280 15:44:19 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | __start_tp_report 15:44:19 INFO - PID 22374 | _x_x_mozilla_page_load 15:44:19 INFO - PID 22374 | _x_x_mozilla_page_load_details 15:44:19 INFO - PID 22374 | |i|pagename|runs| 15:44:19 INFO - PID 22374 | |0;ai-astar;114;111;107;112;121;118;113;111;108;112 15:44:19 INFO - PID 22374 | |1;audio-beat-detection;116;122;125;116;119;122;147;125;122;123 15:44:19 INFO - PID 22374 | |2;audio-dft;170;164;164;166;163;172;172;163;163;167 15:44:19 INFO - PID 22374 | |3;audio-fft;82;75;74;81;80;80;76;80;85;85 15:44:19 INFO - PID 22374 | |4;audio-oscillator;79;85;84;81;80;78;81;81;89;78 15:44:19 INFO - PID 22374 | |5;imaging-gaussian-blur;111;115;114;117;111;116;118;112;115;119 15:44:19 INFO - PID 22374 | |6;imaging-darkroom;150;153;151;153;154;150;148;149;149;149 15:44:19 INFO - PID 22374 | |7;imaging-desaturate;95;94;96;102;98;96;95;94;94;94 15:44:19 INFO - PID 22374 | |8;json-parse-financial;52;54;52;53;55;52;54;58;53;53 15:44:19 INFO - PID 22374 | |9;json-stringify-tinderbox;39;38;39;38;46;42;38;39;47;50 15:44:19 INFO - PID 22374 | |10;stanford-crypto-aes;77;80;77;77;83;77;77;83;81;80 15:44:19 INFO - PID 22374 | |11;stanford-crypto-ccm;118;122;117;124;114;117;121;117;117;113 15:44:19 INFO - PID 22374 | |12;stanford-crypto-pbkdf2;170;170;166;169;171;164;163;167;175;168 15:44:19 INFO - PID 22374 | |13;stanford-crypto-sha256-iterative;67;66;66;71;66;65;69;66;70;68 15:44:19 INFO - PID 22374 | __end_tp_report 15:44:19 INFO - PID 22374 | __start_cc_report 15:44:19 INFO - PID 22374 | _x_x_mozilla_cycle_collect,742 15:44:19 INFO - PID 22374 | __end_cc_report 15:44:19 INFO - PID 22374 | __startTimestamp1505688259892__endTimestamp 15:44:19 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | ------- Summary: start ------- 15:44:19 INFO - PID 22374 | Number of tests: 14 15:44:19 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | [#0] ai-astar Cycles:10 Average:112.70 Median:112.50 stddev:4.22 (3.7%) stddev-sans-first:4.45 15:44:19 INFO - PID 22374 | Values: 114.0 111.0 107.0 112.0 121.0 118.0 113.0 111.0 108.0 112.0 15:44:19 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | [#1] audio-beat-detection Cycles:10 Average:123.70 Median:122.50 stddev:8.79 (7.2%) stddev-sans-first:8.88 15:44:19 INFO - PID 22374 | Values: 116.0 122.0 125.0 116.0 119.0 122.0 147.0 125.0 122.0 123.0 15:44:19 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | [#2] audio-dft Cycles:10 Average:166.40 Median:166.50 stddev:3.69 (2.2%) stddev-sans-first:3.67 15:44:19 INFO - PID 22374 | Values: 170.0 164.0 164.0 166.0 163.0 172.0 172.0 163.0 163.0 167.0 15:44:19 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | [#3] audio-fft Cycles:10 Average:79.80 Median:80.50 stddev:3.82 (4.8%) stddev-sans-first:3.97 15:44:19 INFO - PID 22374 | Values: 82.0 75.0 74.0 81.0 80.0 80.0 76.0 80.0 85.0 85.0 15:44:19 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | [#4] audio-oscillator Cycles:10 Average:81.60 Median:81.00 stddev:3.47 (4.3%) stddev-sans-first:3.55 15:44:19 INFO - PID 22374 | Values: 79.0 85.0 84.0 81.0 80.0 78.0 81.0 81.0 89.0 78.0 15:44:19 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:115.50 stddev:2.82 (2.4%) stddev-sans-first:2.64 15:44:19 INFO - PID 22374 | Values: 111.0 115.0 114.0 117.0 111.0 116.0 118.0 112.0 115.0 119.0 15:44:19 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:150.50 stddev:2.07 (1.4%) stddev-sans-first:2.18 15:44:19 INFO - PID 22374 | Values: 150.0 153.0 151.0 153.0 154.0 150.0 148.0 149.0 149.0 149.0 15:44:19 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:2.53 (2.7%) stddev-sans-first:2.67 15:44:19 INFO - PID 22374 | Values: 95.0 94.0 96.0 102.0 98.0 96.0 95.0 94.0 94.0 94.0 15:44:19 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.50 stddev:1.84 (3.4%) stddev-sans-first:1.86 15:44:19 INFO - PID 22374 | Values: 52.0 54.0 52.0 53.0 55.0 52.0 54.0 58.0 53.0 53.0 15:44:19 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | [#9] json-stringify-tinderbox Cycles:10 Average:41.60 Median:40.50 stddev:4.45 (11.0%) stddev-sans-first:4.62 15:44:19 INFO - PID 22374 | Values: 39.0 38.0 39.0 38.0 46.0 42.0 38.0 39.0 47.0 50.0 15:44:19 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:80.00 stddev:2.53 (3.2%) stddev-sans-first:2.55 15:44:19 INFO - PID 22374 | Values: 77.0 80.0 77.0 77.0 83.0 77.0 77.0 83.0 81.0 80.0 15:44:19 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | [#11] stanford-crypto-ccm Cycles:10 Average:118.00 Median:117.50 stddev:3.43 (2.9%) stddev-sans-first:3.64 15:44:19 INFO - PID 22374 | Values: 118.0 122.0 117.0 124.0 114.0 117.0 121.0 117.0 117.0 113.0 15:44:19 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:169.50 stddev:3.53 (2.1%) stddev-sans-first:3.69 15:44:19 INFO - PID 22374 | Values: 170.0 170.0 166.0 169.0 171.0 164.0 163.0 167.0 175.0 168.0 15:44:19 INFO - PID 22374 | 15:44:19 INFO - PID 22374 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:2.01 (3.0%) stddev-sans-first:2.13 15:44:19 INFO - PID 22374 | Values: 67.0 66.0 66.0 71.0 66.0 65.0 69.0 66.0 70.0 68.0 15:44:19 INFO - PID 22374 | -------- Summary: end -------- 15:44:19 INFO - PID 22374 | 15:44:20 INFO - PID 22374 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:44:20 INFO - TEST-INFO | 22374: exit 0 15:44:20 INFO - TEST-OK | kraken | took 62870ms 15:44:20 INFO - SUITE-END | took 1176s 15:44:21 INFO - Completed test suite (00:19:36) 15:44:21 INFO - javascript benchmark 15:44:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8402.625017174223, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.3152906360606, 3112.4708799504083, 3112.891048813292, 3143.481325581279, 3168.2554599669074, 6106.511479081674, 6268.341824108471, 6307.148534947781, 6322.051692246166, 6378.872422551558, 6189.597676151047, 6207.37926207379, 6342.0486926960975, 6371.139896114023, 6372.203474565679, 5627.184058311543, 5777.046787280094, 5816.941830581683, 5834.2998840139135, 5848.502877255439, 5665.433456654322, 5733.512651424634, 5810.070388737803, 5815.273090863642, 5837.824865254049, 5558.416366281523, 5649.661020338752, 5706.1440783882335, 5775.10485874688, 5790.942090579082, 5647.43525647436, 5667.744951477193, 5672.858178545528, 5692.0, 5698.202251684767, 5655.745491452894, 5706.172604972297, 5718.685472299064, 5721.170430287585, 5728.79949201776, 6191.81424557264, 6203.906941395882, 6233.688315584202, 6251.499880009634, 6297.275813281485, 6638.336166383323, 6679.9980002999455, 6716.764913228014, 6737.3599508046655, 6765.357291057391, 6444.935550644481, 6622.4370928471135, 6679.866402671968, 6735.93264067358, 6740.595564266159, 6173.444390004921, 6243.500519958392, 6255.624662520263, 6286.057091436275, 6301.180846489973, 6825.658717064127, 6872.209695884937, 6884.965575172092, 6971.198312194163, 6988.93011069893, 6399.232092148972, 6577.287616730395, 6592.17597800275, 6671.132752742113, 6692.130023097064, 6613.338666133348, 6649.601023938482, 6657.23441804189, 6660.234073081658, 6669.866602668017, 6643.0, 6644.966775166094, 6660.967550029656, 6704.329567043256, 6728.461723062143, 6736.157980252468, 6780.050792888999, 6816.182058153054, 6816.284290149562, 6816.965915170393, 5267.078261304257, 5295.602829787781, 5320.600954928396, 5333.066713325153, 5363.222332761728, 4569.017661202791, 4574.4968053514085, 4630.652701047435, 4632.467266264355, 4640.930386044212, 5670.489655930986, 5694.08894576874, 5760.135979603093, 5790.826275211751, 5806.564507661942, 6736.46108311334, 6762.526623136333, 6842.828929276709, 6844.0, 6844.691988860513, 5777.422257774189, 5778.8266352009505, 5829.358770535237, 5857.0, 5884.146798714162, 5567.387587365387, 5728.942710572925, 5760.567957403127, 5819.359870414251, 5855.882882342329, 6414.967925160345, 6493.31820158886, 6498.025296205513, 6501.772437964649, 6511.088447617338, 6723.327667233433, 6733.2593414725325, 6772.2211945625895, 6811.795646130624, 6821.3519715626935, 6444.9355506444335, 6475.902861457176, 6536.281009089092, 6538.117354157128, 6567.573107747981, 6456.063870738811, 6474.5791523550815, 6504.577202481823, 6627.502937279627, 6692.196936367667, 6731.091302674076, 6745.730170793114, 6769.120014398097, 6802.285759995327, 6836.658167091725, 6459.095726598186, 6470.935290647033, 6510.0885875976455, 6513.706883190173, 6536.607803531803, 6507.349265073455, 6519.674016299071, 6540.9861471471995, 6564.901526477202, 6586.407223349922, 6311.400416960381, 6363.809085727436, 6413.262474815269, 6496.805095847132, 6503.0, 6532.444742196966, 6574.572652777554, 6607.372299631527, 6607.933920660732, 6620.2386725527185, 6300.653464059521, 6326.873462530815, 6352.6506042166275, 6431.678416079084, 6439.323870993666], "value": 6105.061368040357, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.6767244610825, 860.672944281173, 869.8390797702424, 871.7123349294733, 872.276010910944, 38388.42417363738, 41655.79172104135, 41852.58147418525, 41950.16099678005, 42071.579284207146, 38110.23779524408, 38481.230375392544, 38502.61497385025, 38717.61282387182, 38750.481218720764, 6875.346842050009, 6899.827504312382, 6955.547889387173, 6970.860582788341, 7729.574873381962, 7675.194104619019, 7685.923140768605, 7688.538687678757, 7693.615319234043, 7707.07515098189, 7731.7680469586, 7762.495437796525, 7767.533947963112, 7783.4940728852725, 7812.53124812513, 7649.770506884803, 7693.615319234072, 7709.922900770976, 7758.0, 7768.184340644236, 7778.766637000899, 7816.101148367954, 7829.491083079582, 7835.4123440741605, 7857.0964339101165, 37785.62214377876, 37933.620663793285, 38136.0, 38262.80868595667, 38275.808620956996, 3570.696490798285, 3572.0534058474527, 3578.58846232684, 3585.175409655768, 3607.116256517144, 31553.684463155303, 31581.21046973821, 31733.365332693447, 31757.20606984821, 31876.521852172235, 5002.449730529639, 5255.921161182585, 5292.417834038291, 5319.0957537218765, 5362.946370536284, 177062.0, 178884.10557947258, 179216.0, 179364.0, 182881.99999999866, 43229.35155972663, 49531.75234123806, 49612.751936240085, 50009.749951250014, 50055.0, 46141.769291154, 51199.48800512022, 51331.23003154956, 51703.48296517062, 51968.74015629973, 16169.676606467805, 16190.190490475428, 16381.344746210018, 16440.0, 16473.6705265894, 13347.866521334856, 13414.597562073153, 13463.798043029363, 13567.59297221085, 13645.38595763193, 13474.663133421744, 13489.123206991515, 13547.390367433489, 13693.0, 13751.656208594864, 5522.0, 5558.305211848519, 5627.606067575231, 5726.055200891807, 5729.0, 986.3736527305069, 987.3116969981269, 992.1715367667933, 1000.214831357381, 1010.4493051286919, 22774.43063923382, 23084.192053278053, 23112.306630801104, 23166.37835351509, 23223.303300901, 1107.2304748199924, 1109.91120710343, 1113.4154568851418, 1117.6423544465692, 1125.8029844777132, 11901.631312399011, 11936.403179840972, 12029.398530073462, 12111.394430278451, 12244.142909996393, 217719.0, 219944.0, 220570.0, 220752.0, 221215.0, 53570.46429535655, 53797.46202538003, 53923.73038134863, 54467.18299225515, 54605.45394546004, 1397.6156556946921, 1429.328215738622, 1439.5465428390023, 1455.097839339595, 1455.6288146522782, 22131.66802497996, 22450.438739031, 22971.425714357276, 23009.769902301432, 23038.193663221708, 37902.62097378991, 38028.61971380251, 38102.618973809906, 38272.42591361188, 38365.61634383732, 188024.0, 189508.20983580526, 189824.0, 190063.0, 190264.0, 30199.547006794477, 31056.534151987285, 33724.156896077795, 34947.47578786269, 35590.28819423649, 43619.78190109029, 43726.0, 44028.0, 44475.0, 44819.55180448154, 32336.514952276204, 32558.0, 32573.837130814194, 32735.508967365986, 32876.835615821765, 31978.0, 32089.839550802095, 32201.677983220805, 32283.51574726334, 32414.189645259055, 33913.83043084868, 35894.641053590174, 36140.27719445544, 36318.818405907805, 36522.269554608225, 31320.0, 31431.21421964469, 31513.8424307877, 31731.52402713915, 32234.35531289314, 23210.65184022207, 23557.29328120159, 23775.762242377354, 24025.0, 24277.271681849572], "value": 17029.67354831724, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.763516446236, 563.4956713741202, 570.3811364669334, 574.9827505174843, 586.3403670870271, 21454.356369308905, 22047.559048819036, 22101.447463813372, 22189.667154992647, 22374.664380034294, 23052.0, 24806.379840503996, 25076.87461562694, 25086.0, 25411.491770164634, 6396.808095757135, 6539.08452816606, 6542.542022058457, 6560.015997600351, 6566.1464009678675, 6452.838679033015, 6537.673116344187, 6596.571222870522, 6601.66991650418, 6603.339666033382, 6246.469050130744, 6531.314212007742, 6535.869282614369, 6547.3125321841235, 6555.0495178199135, 6433.8713225735455, 6477.319881412431, 6493.31820158886, 6509.6419696916655, 6510.08858759774, 5951.732172052268, 6061.878762424727, 6067.089936509515, 6072.119542666289, 6073.0283154695035, 27615.0, 27852.30369240785, 28119.43761124766, 28134.2966425841, 28255.858720706266, 2074.1392322186275, 2113.080809847706, 2117.6717608770664, 2120.1943261560664, 2131.211451762842, 18760.24959001638, 19288.61422771551, 19459.708104378446, 19560.43516518675, 19620.80379196204, 2281.977180228193, 2320.338703469503, 2324.3840382298704, 2331.4521087544413, 2332.825038122148, 121246.0, 125187.0, 131910.3404482981, 138468.30765846206, 139221.3038934809, 14169.362378692984, 14361.425542978373, 14460.713143194791, 14723.337449814784, 14823.332950017275, 22398.216062437736, 22454.32637020892, 22476.0, 22497.325080247618, 22544.436389090075, 9788.706338809847, 10093.0, 10251.38491690501, 10288.948555257175, 10328.638497652546, 9358.989069538793, 9436.339456237998, 9480.33637645372, 9614.615415383307, 9614.855777163348, 8590.797288379632, 8678.783030424163, 8932.240759535382, 8939.0, 9142.085791420937, 2541.834780739283, 2610.190840839346, 2657.3489495073445, 2682.329417645589, 2686.3881670997635, 944.8866136063716, 959.4866746290841, 966.1594412860856, 972.5720682899502, 975.2198241406846, 18466.722999155023, 18653.533661658297, 18654.44036678902, 19013.904930475535, 19250.422487325402, 1014.8021135878433, 1018.0803904965823, 1027.9897201027893, 1030.7886883188928, 1032.0608246495653, 10319.329243599143, 10441.0, 10508.894911050791, 10534.420606866695, 10594.442700626298, 428440.0, 436771.0, 439519.0, 448007.0, 452943.0, 107174.0, 108666.45666771615, 110336.0, 112117.43941280241, 112468.43765781118, 1163.2148299897535, 1173.6479056283251, 1205.421397729095, 1207.4988879615037, 1207.9758404831855, 16731.862203509398, 16889.32442702278, 16890.24786286346, 17028.48914532566, 17382.652346953244, 52859.0, 54162.0, 54520.45479545154, 54739.63150921259, 55314.170287446526, 67459.66270168814, 67951.3204867945, 68304.31695682979, 69273.0, 69293.30706692868, 13055.804162937753, 13989.580312590639, 14051.508197213048, 14097.788533172215, 14228.715425691635, 21742.0, 21839.672404914258, 22105.115795368005, 22246.555068898855, 22340.553188935806, 17089.91455042717, 17709.0, 17812.91093544524, 17814.91092544529, 18071.186796593924, 16182.757258640895, 16211.0, 16401.17994100314, 16650.833491665413, 16675.833241667915, 17954.910225448788, 17972.10139493046, 17979.370722024665, 18051.0, 18286.359977400727, 13621.114627549177, 13760.793588095987, 13885.166889986633, 13889.930550347588, 13896.305184740924, 17714.114294285493, 17761.289548418434, 17768.0, 17826.46520604384, 17931.551711207325], "value": 11648.974362977924, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.2340419152697, 1346.5219846954326, 1359.6464919121026, 1362.3052243355892, 1391.6729568551389, 14699.706005879876, 15266.313015914282, 15327.923360383182, 15362.692746145085, 15387.23063846806, 14884.330205140768, 15033.248337583105, 15059.77410338843, 15071.62320941977, 15077.472288469906, 2677.6519052523195, 2778.402643431662, 2779.1662501249643, 2779.791515636325, 2782.526970415024, 2633.2100369889054, 2712.6609173853267, 2732.330579008146, 2737.7536021758037, 2744.5745909384077, 2635.367511797174, 2669.452762183748, 2750.917472475829, 2751.876165572554, 2763.2401089700293, 2720.319920019995, 2720.5375086235385, 2737.9178624641295, 2759.3377589378506, 2762.2818067302446, 2590.831595946276, 2611.490759301937, 2615.5684312088483, 2632.289281893878, 2633.0389407866182, 14756.48352307664, 14768.0, 14854.405823767036, 14943.925280373529, 15039.172845493493, 7776.805579860492, 8025.157358477334, 8127.75616731499, 8131.942847429856, 8141.348692104618, 5464.863378415532, 5581.302337207849, 5585.497305242548, 5631.690257035862, 5652.576056795757, 1906.4376009077355, 1932.0822609260629, 1933.2556965568217, 1966.4690533556002, 1980.2771988224338, 25856.224313270443, 25875.353116172057, 26073.608895866386, 26095.217143485726, 26116.085936992113, 6460.676966151767, 6547.8363040923405, 6865.725370985105, 6889.552179108342, 7060.082189315356, 17049.7442538362, 17159.571010724583, 17160.570985725208, 17165.485035448957, 17170.484885453458, 7671.884921726179, 7938.285554300141, 7964.123946365895, 7975.72084977023, 7977.960110199528, 7115.6086415247655, 7261.164966028869, 7261.2012678605315, 7308.6345682715655, 7349.669264883093, 5106.080905437057, 5157.742112894341, 5254.211868219798, 5263.23683065961, 5274.1034024215205, 1404.4803422733653, 1470.117929242446, 1544.691061787647, 1553.883458740599, 1582.6834633073431, 850.9319254459629, 880.1770344727701, 891.4651209274513, 893.9508327041945, 910.8360495110944, 8165.428420010542, 8176.323853609995, 8310.085890552034, 8325.0, 8372.246497815226, 703.5743375257895, 714.9356557909813, 716.8064622551882, 720.4020662849822, 804.6901942751965, 5026.421961474404, 5138.563222126161, 5150.665206761549, 5313.282706834605, 5371.57027437804, 20871.686924696143, 21576.244831431137, 21739.456513587287, 22033.77966220317, 22075.889620552116, 21328.680069798964, 21413.46466338354, 21683.024263908163, 21717.13131474755, 21743.0, 10886.61896833607, 11321.150913681671, 11354.0, 11371.0, 11592.594259200887, 7853.921460785319, 8058.919410805817, 8071.152528984607, 8075.273225409741, 8075.515469071875, 18136.18387172554, 18379.264829406675, 18629.627407451502, 18828.52928676794, 19030.143643535797, 18799.718004229675, 19296.0, 19312.90343548273, 19363.90318048401, 19744.210231590576, 10906.727331816768, 11059.889401105886, 11093.667189983991, 11101.5559377624, 11102.389368584805, 12793.296368699439, 12959.35203239853, 13080.672983175496, 13106.541271055466, 13263.0, 10941.83587246208, 11042.116630669367, 11316.321020738782, 11407.828882566933, 11493.080553555863, 11320.943395282971, 11337.149713771665, 11375.886241137483, 11589.130815189063, 11614.245074070159, 9167.358284919992, 9359.438433694, 9403.059694030542, 9428.57571409302, 9461.195798357217, 5975.940240597538, 6093.0, 6126.111713801563, 6264.404881536247, 6300.621962682254, 6806.897896531655, 6850.623215723183, 6903.689333979883, 6912.066870972555, 7002.2647622000995], "value": 6555.279456773608, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.4995164554692, 504.82835835815814, 512.4158459356337, 527.6385675812069, 530.1226470191833, 6259.655718935457, 6336.714847831847, 6340.809775706731, 6389.584676995992, 6393.808185754429, 6240.3759624037575, 6263.498920086394, 6288.685565721718, 6305.464035556972, 6343.302236753953, 5131.230315452674, 5151.639385243035, 5160.406553246368, 5164.612654050942, 5170.819021334254, 5053.180854892235, 5127.2052831811125, 5131.461196574343, 5164.870878228036, 5167.054778776099, 4733.928991065137, 4870.245112007645, 4909.140900342426, 4911.729854857981, 4918.532739389752, 4893.706377617319, 4929.8028078876805, 4937.382827146606, 4945.826896058638, 4960.578350840201, 4298.806553705091, 4406.801693923781, 4455.688101832873, 4457.175422546839, 4466.709663871838, 6023.789167379121, 6055.455009049163, 6060.727267272983, 6068.0, 6134.601250918676, 5603.523700485463, 5610.438956104357, 5623.8594035149035, 5642.4075472075665, 5651.180578816049, 6509.381608747161, 6562.409383155539, 6571.080048793173, 6572.0, 6580.835479113012, 4545.840895568639, 4766.4995175506765, 4772.880677983078, 4808.230683090689, 4838.927416088762, 6698.263191048981, 6792.422644075259, 6967.651617419108, 7029.648517574101, 7036.155661320623, 5428.647137936022, 5440.945590544123, 5444.265024221759, 5459.727013649302, 5494.670319780826, 5493.972530137324, 5502.752376143083, 5504.972475137599, 5505.642133261325, 5507.421720719347, 5913.674747888821, 5933.3473317934995, 5984.970075149684, 5985.2491024123865, 5993.250843644544, 6668.966655166693, 6677.53257271996, 6740.561863478858, 6756.628385438749, 6767.221769496472, 1918.5491409518752, 1932.990335048344, 1935.335611374217, 1939.2921583621876, 1944.572194117292, 1359.429039803285, 1398.189050350794, 1408.5070225421225, 1416.5821082780606, 1419.1626940105386, 5673.773049078073, 5683.26117604717, 5706.572007099484, 5715.0, 5732.140178973104, 6559.44244739193, 6657.368944608505, 6753.3921947025, 6776.15298087739, 6786.898196527056, 5568.633330834379, 5625.206037781092, 5668.489835914787, 5724.599278050497, 5760.0783874579865, 3494.0, 3520.6303338149637, 3543.4684797280615, 3570.589382221078, 3580.964190358115, 6270.435660790551, 6312.936870631235, 6365.172527571386, 6384.7126879290545, 6408.327125651833, 6660.733570657119, 6670.763450691281, 6727.62998035103, 6754.542002278571, 6777.627230502271, 6279.686015699197, 6315.400036996478, 6324.3043265240785, 6386.0, 6389.242958186443, 6386.9361306386345, 6566.815094678981, 6567.408933196035, 6615.213892249162, 6633.668316584055, 6572.474202063919, 6575.671216439063, 6594.736210551524, 6608.240052394036, 6616.636085015178, 6406.967965160145, 6482.865498537832, 6510.609363438209, 6526.151600292122, 6542.869142617026, 5289.18017707256, 5301.708406037705, 5360.748485635964, 5362.410134885082, 5364.5515710758655, 6420.935790642034, 6616.470682345497, 6699.53103282785, 6704.195496540447, 6734.427573656294, 6284.465820405317, 6444.4844412445955, 6543.149390579194, 6556.442702370161, 6580.341965803382, 6451.3550243824375, 6458.903116453163, 6460.806175814733, 6530.412262896172, 6551.296662867784, 6311.368863113652, 6370.968145159244, 6378.330275321025, 6415.454686351713, 6418.261899881573, 6302.920036388073, 6398.424141827071, 6504.804855854142, 6511.883637817634, 6573.3098024706715, 6177.907331390123, 6265.937340626535, 6359.459445947146, 6381.266154392304, 6395.93604063972], "value": 5106.865067906928, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [902.1519771414874, 906.3157316226249, 927.5547737086198, 931.483026920059, 936.190195480909, 18866.90566547167, 19797.802021979795, 20008.299709510153, 20033.298834540794, 20157.0, 18258.634827303445, 18698.813011869875, 18834.71747923782, 19128.713069303973, 19351.225950961943, 948.0519480519481, 966.9226461883032, 970.8883478400004, 971.3977334052897, 972.2416515118219, 973.304087577382, 975.790205105902, 976.2043934193609, 983.9163671087966, 989.3816364772017, 988.4711679251602, 1021.2493817044466, 1029.7888932768801, 1030.4744580264082, 1030.7474668706177, 1011.701548043329, 1020.1328870460123, 1021.5403068619077, 1022.4632068164199, 1026.1021606094666, 720.8630360231591, 744.0959234530072, 749.4266885832343, 756.0964647246543, 756.2475337039626, 17040.40358587456, 17075.743863842054, 17078.914605427017, 17085.316587336492, 17312.0, 18801.15394807237, 19243.807561924343, 19314.32399865998, 19432.319868804523, 19627.0, 16943.237554309962, 17356.39252626152, 17408.82591174085, 17436.12819359027, 17499.650006999917, 3721.4045752679713, 3722.7952462614544, 3746.3256613809504, 3753.6621704046493, 3757.2861156380472, 138295.0, 144148.0, 144489.27755361155, 146559.0, 147869.0, 15065.623359416102, 17400.47798566045, 17571.824281757017, 17660.763746537876, 17723.911380443016, 31093.378132437225, 32079.0, 32096.197595060312, 32114.19714507156, 32258.677413226036, 8436.957815210884, 8458.069612342637, 8469.618867150994, 8499.937507811523, 8593.269572086443, 4091.3453847384276, 4182.749035057906, 4197.601227883346, 4225.133847561243, 4227.281362168439, 5139.563137133311, 5379.058664733734, 5383.919241211385, 5414.133738601805, 5439.836804895859, 983.7491439682835, 1006.627547807316, 1013.4274135113637, 1016.044917777287, 1022.6983040003217, 685.3420716112588, 685.3797313431353, 703.6692754405422, 712.6329940080863, 722.4184531452127, 10177.236707246839, 10475.42385168823, 10573.894261057445, 10746.0, 12195.634130976085, 691.1222747111141, 693.3447891742255, 695.2456584605759, 704.8907419350008, 712.1098626716604, 5429.728513574384, 5452.318460192476, 5518.978988887069, 5572.4706152915405, 5585.692786896679, 121614.0, 123666.0, 124712.0, 125171.0, 128027.3598632001, 107452.92547074586, 108046.45976770222, 108456.20403285847, 108673.4566327179, 109571.45214274037, 88312.0, 88729.0, 89715.55142224378, 90827.99999999868, 94095.0, 9873.851892221766, 9902.059304366361, 10077.748056298651, 10083.344582602107, 10093.69718908434, 43399.78300108479, 44294.557054429046, 44529.55470445254, 44767.776161118985, 45492.0, 54823.0, 57258.713706431205, 57401.425985741276, 57674.0, 57874.0, 14374.3531541083, 14883.925580372463, 15014.0, 15033.473828415952, 15196.772048419503, 15288.388464461297, 15322.0, 15402.84597154059, 15493.225338732793, 15581.844181558039, 15200.239988000776, 15262.0, 15294.694106118039, 15313.310901009258, 15350.769738454155, 14772.852271477148, 14900.329485172977, 14934.701305973602, 15002.174880381684, 15015.924920375328, 14430.927845360706, 14576.489822856149, 14652.487162949672, 14694.853051469348, 14768.556943291718, 10215.795684086424, 10258.230632702727, 10505.68482945513, 10637.361758294526, 10691.625793097204, 10085.899141008496, 10179.185665146622, 10208.744781380525, 10311.845322320321, 10475.266731328733], "value": 8680.307906220252, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1453.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 107.0, 112.0, 121.0, 118.0, 113.0, 111.0, 108.0, 112.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 122.0, 125.0, 116.0, 119.0, 122.0, 147.0, 125.0, 122.0, 123.0], "value": 123.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 164.0, 164.0, 166.0, 163.0, 172.0, 172.0, 163.0, 163.0, 167.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 74.0, 81.0, 80.0, 80.0, 76.0, 80.0, 85.0, 85.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 84.0, 81.0, 80.0, 78.0, 81.0, 81.0, 89.0, 78.0], "value": 81.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 114.0, 117.0, 111.0, 116.0, 118.0, 112.0, 115.0, 119.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 153.0, 151.0, 153.0, 154.0, 150.0, 148.0, 149.0, 149.0, 149.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 102.0, 98.0, 96.0, 95.0, 94.0, 94.0, 94.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 52.0, 53.0, 55.0, 52.0, 54.0, 58.0, 53.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 39.0, 38.0, 46.0, 42.0, 38.0, 39.0, 47.0, 50.0], "value": 41.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 77.0, 77.0, 83.0, 77.0, 77.0, 83.0, 81.0, 80.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 122.0, 117.0, 124.0, 114.0, 117.0, 121.0, 117.0, 117.0, 113.0], "value": 118.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 166.0, 169.0, 171.0, 164.0, 163.0, 167.0, 175.0, 168.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 71.0, 66.0, 65.0, 69.0, 66.0, 70.0, 68.0], "value": 67.4, "unit": "score"}]}]} 15:44:21 INFO - Return code: 0 15:44:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:44:21 INFO - # TBPL SUCCESS # 15:44:21 INFO - Running post-action listener: _package_coverage_data 15:44:21 INFO - Running post-action listener: _resource_record_post_action 15:44:21 INFO - [mozharness: 2017-09-17 22:44:21.172380Z] Finished run-tests step (success) 15:44:21 INFO - Running post-run listener: _resource_record_post_run 15:44:21 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 151552; Write bytes: 344354816; Read time: 148; Write time: 267408 15:44:21 INFO - TinderboxPrint: CPU usage
13.3% 15:44:21 INFO - TinderboxPrint: I/O read bytes / time
151,552 / 148 15:44:21 INFO - TinderboxPrint: I/O write bytes / time
344,354,816 / 267,408 15:44:21 INFO - TinderboxPrint: CPU idle
8,251.1 (86.7%) 15:44:21 INFO - TinderboxPrint: CPU user
1,199.7 (12.6%) 15:44:21 INFO - TinderboxPrint: Swap in / out
0 / 0 15:44:21 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13189120; Read time: 0; Write time: 2276 15:44:21 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:44:21 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 147456; Write bytes: 331165696; Read time: 140; Write time: 265132 15:44:21 INFO - Running post-run listener: _upload_blobber_files 15:44:21 INFO - Blob upload gear active. 15:44:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:44:21 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 15:44:21 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'] 15:44:21 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 15:44:22 INFO - (blobuploader) - INFO - Open directory for files ... 15:44:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:44:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:44:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:23 INFO - (blobuploader) - INFO - Done attempting. 15:44:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:44:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:44:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:31 INFO - (blobuploader) - INFO - Done attempting. 15:44:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:44:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:44:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:31 INFO - (blobuploader) - INFO - Done attempting. 15:44:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:44:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:44:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:32 INFO - (blobuploader) - INFO - Done attempting. 15:44:32 INFO - (blobuploader) - INFO - Iteration through files over. 15:44:32 INFO - Return code: 0 15:44:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:44:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:44:32 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6c977e7db7bbcf6ba2da9ff051dfc3eb1441f0a76f8aeb0a8f6a26ab9302dcbf3feaa996fe07c8b08c4c7e221c8dae60ac9eaeab0eba234b7c69b5e918baf00", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585fb8bdd7cfe0808c5bb560b2bf3160fa46854c90c2f6df4a3f4d871d2d028a5ea77bc31f5b38226e1ae2242544451948a521623e212b4513c53c4b3eb8b2fd", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b10cff1cccfbb9e9158a8403c3e7ae630dc8ee90a1768ebfa93471d21198dd01363ebd44b347ee39046092734767057cc45f7fc2f06a5ad371ccae91ad6e591", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f211309402a95700d1b4992cf99970bb2bcfc35dc1c17e05d0626851cbf8fc154590c6f3ed1d0ead18297b31a0269dafff79058db47f38a66c07be80a25e318"} 15:44:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:44:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:44:32 INFO - Contents: 15:44:32 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6c977e7db7bbcf6ba2da9ff051dfc3eb1441f0a76f8aeb0a8f6a26ab9302dcbf3feaa996fe07c8b08c4c7e221c8dae60ac9eaeab0eba234b7c69b5e918baf00", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585fb8bdd7cfe0808c5bb560b2bf3160fa46854c90c2f6df4a3f4d871d2d028a5ea77bc31f5b38226e1ae2242544451948a521623e212b4513c53c4b3eb8b2fd", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b10cff1cccfbb9e9158a8403c3e7ae630dc8ee90a1768ebfa93471d21198dd01363ebd44b347ee39046092734767057cc45f7fc2f06a5ad371ccae91ad6e591", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f211309402a95700d1b4992cf99970bb2bcfc35dc1c17e05d0626851cbf8fc154590c6f3ed1d0ead18297b31a0269dafff79058db47f38a66c07be80a25e318"} 15:44:32 INFO - Running post-run listener: copy_logs_to_upload_dir 15:44:32 INFO - Copying logs to upload dir... 15:44:32 INFO - mkdir: /builds/slave/test/build/upload/logs 15:44:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.996527 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-17 15:44:33.075716) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 15:44:33.080664) ========= 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=9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310 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/e6c977e7db7bbcf6ba2da9ff051dfc3eb1441f0a76f8aeb0a8f6a26ab9302dcbf3feaa996fe07c8b08c4c7e221c8dae60ac9eaeab0eba234b7c69b5e918baf00", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585fb8bdd7cfe0808c5bb560b2bf3160fa46854c90c2f6df4a3f4d871d2d028a5ea77bc31f5b38226e1ae2242544451948a521623e212b4513c53c4b3eb8b2fd", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b10cff1cccfbb9e9158a8403c3e7ae630dc8ee90a1768ebfa93471d21198dd01363ebd44b347ee39046092734767057cc45f7fc2f06a5ad371ccae91ad6e591", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f211309402a95700d1b4992cf99970bb2bcfc35dc1c17e05d0626851cbf8fc154590c6f3ed1d0ead18297b31a0269dafff79058db47f38a66c07be80a25e318"} build_url:https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011499 build_url: 'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6c977e7db7bbcf6ba2da9ff051dfc3eb1441f0a76f8aeb0a8f6a26ab9302dcbf3feaa996fe07c8b08c4c7e221c8dae60ac9eaeab0eba234b7c69b5e918baf00", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585fb8bdd7cfe0808c5bb560b2bf3160fa46854c90c2f6df4a3f4d871d2d028a5ea77bc31f5b38226e1ae2242544451948a521623e212b4513c53c4b3eb8b2fd", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b10cff1cccfbb9e9158a8403c3e7ae630dc8ee90a1768ebfa93471d21198dd01363ebd44b347ee39046092734767057cc45f7fc2f06a5ad371ccae91ad6e591", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f211309402a95700d1b4992cf99970bb2bcfc35dc1c17e05d0626851cbf8fc154590c6f3ed1d0ead18297b31a0269dafff79058db47f38a66c07be80a25e318"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 15:44:33.112182) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:44:33.112536) ========= 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=9bfb7e13875ed353a705960e000001c0-1505681305.494254-1512008310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:44:33.196252) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 15:44:33.196567) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 15:44:33.196878) ========= ========= Total master_lag: 0.93 =========