builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-040 starttime: 1506536084.59 results: success (0) revision: 6100472d3aa833dff22a4edb0934fe600f43ddb8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:44.593615) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:44.594057) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:44.594338) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:44.611998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:44.612268) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 11:14:44-- 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% 224M=0s 2017-09-27 11:14:44 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118396 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:44.758656) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:44.758991) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016207 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:44.814028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:44.814393) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6100472d3aa833dff22a4edb0934fe600f43ddb8 --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 6100472d3aa833dff22a4edb0934fe600f43ddb8 --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=9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 11:14:44,868 truncating revision to first 12 chars 2017-09-27 11:14:44,868 Setting DEBUG logging. 2017-09-27 11:14:44,868 attempt 1/10 2017-09-27 11:14:44,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6100472d3aa8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 11:14:45,479 unpacking tar archive at: mozilla-central-6100472d3aa8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.900932 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:45.742973) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:45.743289) ========= script_repo_revision: 6100472d3aa833dff22a4edb0934fe600f43ddb8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:45.743689) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:45.743979) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:45.763204) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-27 11:14:45.763477) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:14:45 INFO - MultiFileLogger online at 20170927 11:14:45 in /builds/slave/test 11:14: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 11:14:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:14:45 INFO - {'append_to_log': False, 11:14:45 INFO - 'base_work_dir': '/builds/slave/test', 11:14:45 INFO - 'blob_upload_branch': 'Firefox', 11:14:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:14:45 INFO - 'branch': 'Firefox', 11:14:45 INFO - 'buildbot_json_path': 'buildprops.json', 11:14:45 INFO - 'code_coverage': False, 11:14:45 INFO - 'config_files': ('talos/linux_config.py',), 11:14:45 INFO - 'default_actions': ('clobber', 11:14:45 INFO - 'read-buildbot-config', 11:14:45 INFO - 'download-and-extract', 11:14:45 INFO - 'populate-webroot', 11:14:45 INFO - 'create-virtualenv', 11:14:45 INFO - 'install', 11:14:45 INFO - 'setup-mitmproxy', 11:14:45 INFO - 'run-tests'), 11:14:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:14:45 INFO - 'disable_ccov_upload': False, 11:14:45 INFO - 'disable_stylo': False, 11:14:45 INFO - 'download_minidump_stackwalk': True, 11:14:45 INFO - 'download_symbols': 'ondemand', 11:14:45 INFO - 'enable_stylo': False, 11:14:45 INFO - 'enable_webrender': False, 11:14:45 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:14:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:14:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:14:45 INFO - 'gecko_profile': False, 11:14:45 INFO - 'gecko_profile_interval': 0, 11:14:45 INFO - 'installer_path': 'installer.exe', 11:14:45 INFO - 'log_level': 'info', 11:14:45 INFO - 'log_name': 'talos', 11:14:45 INFO - 'log_to_console': True, 11:14:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:14:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:14:45 INFO - 'opt_config_files': (), 11:14:45 INFO - 'pip_index': False, 11:14:45 INFO - 'suite': 'dromaeojs-e10s', 11:14:45 INFO - 'system_bits': '32', 11:14:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:14:45 INFO - 'title': 'talos-linux64-ix-040', 11:14:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:14:45 INFO - 'use_talos_json': True, 11:14:45 INFO - 'verify': 'False', 11:14:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:14:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:14:45 INFO - 'work_dir': 'build'} 11:14:45 INFO - [mozharness: 2017-09-27 18:14:45.955307Z] Running clobber step. 11:14:45 INFO - Running pre-action listener: _resource_record_pre_action 11:14:45 INFO - Running main action method: clobber 11:14:45 INFO - rmtree: /builds/slave/test/build 11:14:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:14:46 INFO - Running post-action listener: _resource_record_post_action 11:14:46 INFO - [mozharness: 2017-09-27 18:14:46.950008Z] Finished clobber step (success) 11:14:46 INFO - [mozharness: 2017-09-27 18:14:46.950107Z] Running read-buildbot-config step. 11:14:46 INFO - Running pre-action listener: _resource_record_pre_action 11:14:46 INFO - Running main action method: read_buildbot_config 11:14:46 INFO - Using buildbot properties: 11:14:46 INFO - { 11:14:46 INFO - "project": "", 11:14:46 INFO - "product": "firefox", 11:14:46 INFO - "who": "ryanvm@gmail.com", 11:14:46 INFO - "installer_path": "public/build/target.tar.bz2", 11:14:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:14:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:14:46 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:14:46 INFO - "stage_platform": "linux64-qr", 11:14:46 INFO - "basedir": "/builds/slave/test", 11:14:46 INFO - "buildnumber": 102, 11:14:46 INFO - "platform": "ubuntu64_hw_qr", 11:14:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:14:46 INFO - "slavebuilddir": "test", 11:14:46 INFO - "taskId": "TCx3j-_cSpm53_ofjiWc0g", 11:14:46 INFO - "branch": "mozilla-central", 11:14:46 INFO - "script_repo_revision": "production", 11:14:46 INFO - "revision": "6100472d3aa833dff22a4edb0934fe600f43ddb8", 11:14:46 INFO - "slavename": "talos-linux64-ix-040", 11:14:46 INFO - "repo_path": "mozilla-central" 11:14:46 INFO - } 11:14:46 INFO - Finding installer, test and symbols from parent task. 11:14:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TCx3j-_cSpm53_ofjiWc0g'}, attempt #1 11:14:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TCx3j-_cSpm53_ofjiWc0g'}, attempt #1 11:14:47 INFO - Task dependencies: bGmhYXXHRU6bnifb1xql2Q 11:14:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q'}, attempt #1 11:14:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.tar.bz2 11:14:48 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.test_packages.json 11:14:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.crashreporter-symbols.zip 11:14:48 INFO - Running post-action listener: _resource_record_post_action 11:14:48 INFO - [mozharness: 2017-09-27 18:14:48.335334Z] Finished read-buildbot-config step (success) 11:14:48 INFO - [mozharness: 2017-09-27 18:14:48.335550Z] Running download-and-extract step. 11:14:48 INFO - Running pre-action listener: _resource_record_pre_action 11:14:48 INFO - Running main action method: download_and_extract 11:14:48 INFO - mkdir: /builds/slave/test/build/tests 11:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:48 INFO - trying https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.test_packages.json 11:14:48 INFO - Downloading https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:14:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:14:48 INFO - Downloaded 989 bytes. 11:14:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:14:48 INFO - Using the following test package requirements: 11:14:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:14:48 INFO - u'common': [u'target.common.tests.zip'], 11:14:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:14:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:14:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:14:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:14:48 INFO - u'mozbase': [u'target.common.tests.zip'], 11:14:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:14:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:14:48 INFO - u'web-platform': [u'target.common.tests.zip', 11:14:48 INFO - u'target.web-platform.tests.tar.gz'], 11:14:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:14:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:14:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.common.tests.zip 11:14:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:14:48 INFO - Fetch https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.common.tests.zip into memory 11:14:49 INFO - Content-Length response header: 54946033 11:14:49 INFO - Bytes received: 54946033 11:15:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.talos.tests.zip 11:15:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:15:00 INFO - Fetch https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.talos.tests.zip into memory 11:15:01 INFO - Content-Length response header: 14513665 11:15:01 INFO - Bytes received: 14513665 11:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:01 INFO - trying https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.tar.bz2 11:15:01 INFO - Downloading https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:15:03 INFO - Downloaded 61680180 bytes. 11:15:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.tar.bz2 11:15:03 INFO - mkdir: /builds/slave/test/properties 11:15:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:15:03 INFO - Writing to file /builds/slave/test/properties/build_url 11:15:03 INFO - Contents: 11:15:03 INFO - build_url:https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.tar.bz2 11:15:03 INFO - Running post-action listener: _resource_record_post_action 11:15:03 INFO - Running post-action listener: find_tests_for_verification 11:15:03 INFO - Running post-action listener: set_extra_try_arguments 11:15:03 INFO - [mozharness: 2017-09-27 18:15:03.385175Z] Finished download-and-extract step (success) 11:15:03 INFO - [mozharness: 2017-09-27 18:15:03.385273Z] Running populate-webroot step. 11:15:03 INFO - Running pre-action listener: _resource_record_pre_action 11:15:03 INFO - Running main action method: populate_webroot 11:15:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:15:03 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:03 INFO - 'tests': ['tresize', 11:15:03 INFO - 'tcanvasmark']}, 11:15:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:15:03 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:03 INFO - 'tests': ['dromaeo_css', 11:15:03 INFO - 'kraken']}, 11:15:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:15:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:03 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:15:03 INFO - 'talos_options': ['--disable-stylo'], 11:15:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:15:03 INFO - 'tests': ['damp', 'tps']}, 11:15:03 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:15:03 INFO - 'talos_options': ['--disable-stylo'], 11:15:03 INFO - 'tests': ['damp', 'tps']}, 11:15:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:15:03 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:03 INFO - 'tests': ['dromaeo_dom']}, 11:15:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:15:03 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:03 INFO - 'tests': ['basic_compositor_video', 11:15:03 INFO - 'glvideo']}, 11:15:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:15:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:15:03 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:15:03 INFO - 'talos_options': ['--disable-stylo'], 11:15:03 INFO - 'tests': ['ts_paint_webext', 11:15:03 INFO - 'tp5o_webext']}, 11:15:03 INFO - 'other-e10s': {'tests': ['a11yr', 11:15:03 INFO - 'ts_paint', 11:15:03 INFO - 'tpaint', 11:15:03 INFO - 'sessionrestore', 11:15:03 INFO - 'sessionrestore_many_windows', 11:15:03 INFO - 'sessionrestore_no_auto_restore', 11:15:03 INFO - 'tabpaint']}, 11:15:03 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:03 INFO - 'tests': ['a11yr', 11:15:03 INFO - 'ts_paint', 11:15:03 INFO - 'tpaint', 11:15:03 INFO - 'sessionrestore', 11:15:03 INFO - 'sessionrestore_many_windows', 11:15:03 INFO - 'sessionrestore_no_auto_restore', 11:15:03 INFO - 'tabpaint']}, 11:15:03 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:15:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:15:03 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:03 INFO - 'tests': ['perf_reftest_singletons']}, 11:15:03 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:03 INFO - 'tests': ['perf_reftest']}, 11:15:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:15:03 INFO - 'tsvgr_opacity', 11:15:03 INFO - 'tart', 11:15:03 INFO - 'tscrollx', 11:15:03 INFO - 'tsvg_static']}, 11:15:03 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:03 INFO - 'tests': ['tsvgx', 11:15:03 INFO - 'tsvgr_opacity', 11:15:03 INFO - 'tart', 11:15:03 INFO - 'tscrollx', 11:15:03 INFO - 'tsvg_static']}, 11:15:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:15:03 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:15:03 INFO - 'talos_options': ['--disable-stylo'], 11:15:03 INFO - 'tests': ['tp5o']}, 11:15:03 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:15:03 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:15:03 INFO - 'talos_options': ['--mitmproxy', 11:15:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:15:03 INFO - '--firstNonBlankPaint'], 11:15:03 INFO - 'tests': ['tp6_google', 11:15:03 INFO - 'tp6_youtube', 11:15:03 INFO - 'tp6_amazon', 11:15:03 INFO - 'tp6_facebook']}, 11:15:03 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:15:03 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:15:03 INFO - 'talos_options': ['--disable-stylo', 11:15:03 INFO - '--mitmproxy', 11:15:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:15:03 INFO - '--firstNonBlankPaint'], 11:15:03 INFO - 'tests': ['tp6_google', 11:15:03 INFO - 'tp6_youtube', 11:15:03 INFO - 'tp6_amazon', 11:15:03 INFO - 'tp6_facebook']}, 11:15:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:15:03 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:15:03 INFO - 'talos_options': ['--stylo-threads=1', 11:15:03 INFO - '--mitmproxy', 11:15:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:15:03 INFO - '--firstNonBlankPaint'], 11:15:03 INFO - 'tests': ['tp6_google', 11:15:03 INFO - 'tp6_youtube', 11:15:03 INFO - 'tp6_amazon', 11:15:03 INFO - 'tp6_facebook']}, 11:15:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:15:03 INFO - 'talos_options': ['--xperf_path', 11:15:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:03 INFO - 'tests': ['tp5n']}, 11:15:03 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:15:03 INFO - 'talos_options': ['--disable-stylo', 11:15:03 INFO - '--xperf_path', 11:15:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:03 INFO - 'tests': ['tp5n']}}} 11:15:03 INFO - Running post-action listener: _resource_record_post_action 11:15:03 INFO - [mozharness: 2017-09-27 18:15:03.400631Z] Finished populate-webroot step (success) 11:15:03 INFO - [mozharness: 2017-09-27 18:15:03.400719Z] Running create-virtualenv step. 11:15:03 INFO - Running pre-action listener: _resource_record_pre_action 11:15:03 INFO - Running main action method: create_virtualenv 11:15:03 INFO - Creating virtualenv /builds/slave/test/build/venv 11:15:03 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:15:03 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:15:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:15:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:15:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:15:04 INFO - Installing distribute.............................................................................................................................................................................................done. 11:15:04 INFO - Installing pip...............done. 11:15:04 INFO - Return code: 0 11:15:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:15:04 INFO - Reading from file tmpfile_stdout 11:15:04 INFO - Output received: 11:15:04 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:15:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc77b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe19d60>, '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 0xe1aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1aef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:15:04 INFO - Using env: {'DISPLAY': ':0', 11:15:04 INFO - 'HOME': '/home/cltbld', 11:15:04 INFO - 'LANG': 'en_US.UTF-8', 11:15:04 INFO - 'LANGUAGE': 'en_US:en', 11:15:04 INFO - 'LOGNAME': 'cltbld', 11:15:04 INFO - 'MAIL': '/var/mail/cltbld', 11:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:04 INFO - 'MOZ_NO_REMOTE': '1', 11:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:04 INFO - 'NO_EM_RESTART': '1', 11:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:04 INFO - 'PWD': '/builds/slave/test', 11:15:04 INFO - 'SHELL': '/bin/bash', 11:15:04 INFO - 'SHLVL': '1', 11:15:04 INFO - 'TERM': 'linux', 11:15:04 INFO - 'TMOUT': '86400', 11:15:04 INFO - 'USER': 'cltbld', 11:15:04 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 11:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:04 INFO - '_': '/tools/buildbot/bin/python'} 11:15:05 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:15:05 INFO - Downloading/unpacking pip>=1.5 11:15:05 INFO - Running setup.py egg_info for package pip 11:15:05 INFO - warning: no files found matching 'pip/cacert.pem' 11:15:05 INFO - warning: no files found matching '*.html' under directory 'docs' 11:15:05 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:15:05 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:15:05 INFO - Installing collected packages: pip 11:15:05 INFO - Found existing installation: pip 1.1 11:15:05 INFO - Uninstalling pip: 11:15:05 INFO - Successfully uninstalled pip 11:15:05 INFO - Running setup.py install for pip 11:15:05 INFO - warning: no files found matching 'pip/cacert.pem' 11:15:05 INFO - warning: no files found matching '*.html' under directory 'docs' 11:15:05 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:15:05 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:15:05 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:15:05 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:15:05 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:15:05 INFO - Successfully installed pip 11:15:05 INFO - Cleaning up... 11:15:05 INFO - Return code: 0 11:15:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:05 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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc77b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe19d60>, '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 0xe1aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1aef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:15:05 INFO - Using env: {'DISPLAY': ':0', 11:15:05 INFO - 'HOME': '/home/cltbld', 11:15:05 INFO - 'LANG': 'en_US.UTF-8', 11:15:05 INFO - 'LANGUAGE': 'en_US:en', 11:15:05 INFO - 'LOGNAME': 'cltbld', 11:15:05 INFO - 'MAIL': '/var/mail/cltbld', 11:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:05 INFO - 'MOZ_NO_REMOTE': '1', 11:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:05 INFO - 'NO_EM_RESTART': '1', 11:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:05 INFO - 'PWD': '/builds/slave/test', 11:15:05 INFO - 'SHELL': '/bin/bash', 11:15:05 INFO - 'SHLVL': '1', 11:15:05 INFO - 'TERM': 'linux', 11:15:05 INFO - 'TMOUT': '86400', 11:15:05 INFO - 'USER': 'cltbld', 11:15:05 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 11:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:05 INFO - '_': '/tools/buildbot/bin/python'} 11:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:05 INFO - Downloading/unpacking psutil>=3.1.1 11:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:15:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:08 INFO - Installing collected packages: psutil 11:15:08 INFO - Running setup.py install for psutil 11:15:08 INFO - building 'psutil._psutil_linux' extension 11:15:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:15:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:15:08 INFO - building 'psutil._psutil_posix' extension 11:15:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:15:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:15:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:08 INFO - Successfully installed psutil 11:15:08 INFO - Cleaning up... 11:15:08 INFO - Return code: 0 11:15:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:15: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')]} 11:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15: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')]} 11:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc77b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe19d60>, '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 0xe1aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1aef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:15: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 mozsystemmonitor==0.3 11:15:08 INFO - Using env: {'DISPLAY': ':0', 11:15:08 INFO - 'HOME': '/home/cltbld', 11:15:08 INFO - 'LANG': 'en_US.UTF-8', 11:15:08 INFO - 'LANGUAGE': 'en_US:en', 11:15:08 INFO - 'LOGNAME': 'cltbld', 11:15:08 INFO - 'MAIL': '/var/mail/cltbld', 11:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:08 INFO - 'MOZ_NO_REMOTE': '1', 11:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:08 INFO - 'NO_EM_RESTART': '1', 11:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:08 INFO - 'PWD': '/builds/slave/test', 11:15:08 INFO - 'SHELL': '/bin/bash', 11:15:08 INFO - 'SHLVL': '1', 11:15:08 INFO - 'TERM': 'linux', 11:15:08 INFO - 'TMOUT': '86400', 11:15:08 INFO - 'USER': 'cltbld', 11:15:08 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 11:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:08 INFO - '_': '/tools/buildbot/bin/python'} 11:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:15: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 11:15: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 11:15: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 11:15: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 11:15:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:15:11 INFO - Installing collected packages: mozsystemmonitor 11:15:11 INFO - Running setup.py install for mozsystemmonitor 11:15:11 INFO - Successfully installed mozsystemmonitor 11:15:11 INFO - Cleaning up... 11:15:12 INFO - Return code: 0 11:15:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:15: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')]} 11:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15: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')]} 11:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15: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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc77b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe19d60>, '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 0xe1aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1aef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15: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 11:15: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 11:15:12 INFO - Using env: {'DISPLAY': ':0', 11:15:12 INFO - 'HOME': '/home/cltbld', 11:15:12 INFO - 'LANG': 'en_US.UTF-8', 11:15:12 INFO - 'LANGUAGE': 'en_US:en', 11:15:12 INFO - 'LOGNAME': 'cltbld', 11:15:12 INFO - 'MAIL': '/var/mail/cltbld', 11:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:12 INFO - 'MOZ_NO_REMOTE': '1', 11:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:12 INFO - 'NO_EM_RESTART': '1', 11:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:12 INFO - 'PWD': '/builds/slave/test', 11:15:12 INFO - 'SHELL': '/bin/bash', 11:15:12 INFO - 'SHLVL': '1', 11:15:12 INFO - 'TERM': 'linux', 11:15:12 INFO - 'TMOUT': '86400', 11:15:12 INFO - 'USER': 'cltbld', 11:15:12 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 11:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:12 INFO - '_': '/tools/buildbot/bin/python'} 11:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:13 INFO - Downloading/unpacking jsonschema==2.5.1 11:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:15:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:15 INFO - Downloading functools32-3.2.3-2.tar.gz 11:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:15:15 INFO - warning: no files found matching '*.txt' 11:15:15 INFO - no previously-included directories found matching 'build' 11:15:15 INFO - no previously-included directories found matching 'dist' 11:15:15 INFO - no previously-included directories found matching '.git*' 11:15:15 INFO - Installing collected packages: jsonschema, functools32 11:15:15 INFO - Running setup.py install for functools32 11:15:15 INFO - warning: no files found matching '*.txt' 11:15:15 INFO - no previously-included directories found matching 'build' 11:15:15 INFO - no previously-included directories found matching 'dist' 11:15:15 INFO - no previously-included directories found matching '.git*' 11:15:15 INFO - Successfully installed jsonschema functools32 11:15:15 INFO - Cleaning up... 11:15:15 INFO - Return code: 0 11:15:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc77b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe19d60>, '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 0xe1aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1aef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:15:15 INFO - Using env: {'DISPLAY': ':0', 11:15:15 INFO - 'HOME': '/home/cltbld', 11:15:15 INFO - 'LANG': 'en_US.UTF-8', 11:15:15 INFO - 'LANGUAGE': 'en_US:en', 11:15:15 INFO - 'LOGNAME': 'cltbld', 11:15:15 INFO - 'MAIL': '/var/mail/cltbld', 11:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:15 INFO - 'MOZ_NO_REMOTE': '1', 11:15:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:15 INFO - 'NO_EM_RESTART': '1', 11:15:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:15 INFO - 'PWD': '/builds/slave/test', 11:15:15 INFO - 'SHELL': '/bin/bash', 11:15:15 INFO - 'SHLVL': '1', 11:15:15 INFO - 'TERM': 'linux', 11:15:15 INFO - 'TMOUT': '86400', 11:15:15 INFO - 'USER': 'cltbld', 11:15:15 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 11:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:15 INFO - '_': '/tools/buildbot/bin/python'} 11:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:15:16 INFO - Cleaning up... 11:15:16 INFO - Return code: 0 11:15:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:16 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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc77b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe19d60>, '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 0xe1aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1aef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:15:16 INFO - Using env: {'DISPLAY': ':0', 11:15:16 INFO - 'HOME': '/home/cltbld', 11:15:16 INFO - 'LANG': 'en_US.UTF-8', 11:15:16 INFO - 'LANGUAGE': 'en_US:en', 11:15:16 INFO - 'LOGNAME': 'cltbld', 11:15:16 INFO - 'MAIL': '/var/mail/cltbld', 11:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:16 INFO - 'MOZ_NO_REMOTE': '1', 11:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:16 INFO - 'NO_EM_RESTART': '1', 11:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:16 INFO - 'PWD': '/builds/slave/test', 11:15:16 INFO - 'SHELL': '/bin/bash', 11:15:16 INFO - 'SHLVL': '1', 11:15:16 INFO - 'TERM': 'linux', 11:15:16 INFO - 'TMOUT': '86400', 11:15:16 INFO - 'USER': 'cltbld', 11:15:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 11:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:16 INFO - '_': '/tools/buildbot/bin/python'} 11:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:16 INFO - Downloading/unpacking blobuploader==1.2.4 11:15: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 11:15: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 11:15: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 11:15: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 11:15:17 INFO - Downloading blobuploader-1.2.4.tar.gz 11:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:15:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:15:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:17 INFO - Downloading docopt-0.6.1.tar.gz 11:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:15:18 INFO - Installing collected packages: blobuploader, requests, docopt 11:15:18 INFO - Running setup.py install for blobuploader 11:15:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:15:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:15:18 INFO - Running setup.py install for requests 11:15:18 INFO - Running setup.py install for docopt 11:15:18 INFO - Successfully installed blobuploader requests docopt 11:15:18 INFO - Cleaning up... 11:15:18 INFO - Return code: 0 11:15:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:18 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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc77b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe19d60>, '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 0xe1aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1aef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:15:18 INFO - Using env: {'DISPLAY': ':0', 11:15:18 INFO - 'HOME': '/home/cltbld', 11:15:18 INFO - 'LANG': 'en_US.UTF-8', 11:15:18 INFO - 'LANGUAGE': 'en_US:en', 11:15:18 INFO - 'LOGNAME': 'cltbld', 11:15:18 INFO - 'MAIL': '/var/mail/cltbld', 11:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:18 INFO - 'MOZ_NO_REMOTE': '1', 11:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:18 INFO - 'NO_EM_RESTART': '1', 11:15:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:18 INFO - 'PWD': '/builds/slave/test', 11:15:18 INFO - 'SHELL': '/bin/bash', 11:15:18 INFO - 'SHLVL': '1', 11:15:18 INFO - 'TERM': 'linux', 11:15:18 INFO - 'TMOUT': '86400', 11:15:18 INFO - 'USER': 'cltbld', 11:15:18 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 11:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:18 INFO - '_': '/tools/buildbot/bin/python'} 11:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:15:18 INFO - Running setup.py (path:/tmp/pip-_KWo6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:15:18 INFO - Running setup.py (path:/tmp/pip-o0r8b5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:15:18 INFO - Running setup.py (path:/tmp/pip-63B4Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:15:19 INFO - Running setup.py (path:/tmp/pip-mBMiG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:15:19 INFO - Running setup.py (path:/tmp/pip-lZ_SLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:15:19 INFO - Running setup.py (path:/tmp/pip-BDXXOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:15:19 INFO - Running setup.py (path:/tmp/pip-2wFJLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:15:19 INFO - Running setup.py (path:/tmp/pip-lePOxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:15:19 INFO - Running setup.py (path:/tmp/pip-Jg5Cwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:15:19 INFO - Running setup.py (path:/tmp/pip-LIdZa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:15:19 INFO - Running setup.py (path:/tmp/pip-mTybVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:15:19 INFO - Running setup.py (path:/tmp/pip-mxnSQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:15:19 INFO - Running setup.py (path:/tmp/pip-68ZoWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:15:19 INFO - Running setup.py (path:/tmp/pip-HJpg6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:19 INFO - Running setup.py (path:/tmp/pip-tVL1ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:15:19 INFO - Running setup.py (path:/tmp/pip-VF76iY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:15:19 INFO - Running setup.py (path:/tmp/pip-r67BmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:15:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:15:20 INFO - Running setup.py install for manifestparser 11:15:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:15:20 INFO - Running setup.py install for mozcrash 11:15:20 INFO - Running setup.py install for mozdebug 11:15:20 INFO - Running setup.py install for mozdevice 11:15:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:15:20 INFO - Running setup.py install for mozfile 11:15:20 INFO - Running setup.py install for mozhttpd 11:15:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:15:20 INFO - Running setup.py install for mozinfo 11:15:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:15:20 INFO - Running setup.py install for mozInstall 11:15:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:15:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:15:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:15:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:15:20 INFO - Running setup.py install for mozleak 11:15:20 INFO - Running setup.py install for mozlog 11:15:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:15:21 INFO - Running setup.py install for moznetwork 11:15:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:15:21 INFO - Running setup.py install for mozprocess 11:15:21 INFO - Running setup.py install for mozprofile 11:15:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:15:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:15:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:15:21 INFO - Running setup.py install for mozrunner 11:15:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:15:21 INFO - Running setup.py install for mozscreenshot 11:15:21 INFO - Running setup.py install for moztest 11:15:21 INFO - Running setup.py install for mozversion 11:15:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:15:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:15:21 INFO - Cleaning up... 11:15:21 INFO - Return code: 0 11:15:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:21 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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc77b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe19d60>, '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 0xe1aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1aef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:15:21 INFO - Using env: {'DISPLAY': ':0', 11:15:21 INFO - 'HOME': '/home/cltbld', 11:15:21 INFO - 'LANG': 'en_US.UTF-8', 11:15:21 INFO - 'LANGUAGE': 'en_US:en', 11:15:21 INFO - 'LOGNAME': 'cltbld', 11:15:21 INFO - 'MAIL': '/var/mail/cltbld', 11:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:21 INFO - 'MOZ_NO_REMOTE': '1', 11:15:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:21 INFO - 'NO_EM_RESTART': '1', 11:15:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:21 INFO - 'PWD': '/builds/slave/test', 11:15:21 INFO - 'SHELL': '/bin/bash', 11:15:21 INFO - 'SHLVL': '1', 11:15:21 INFO - 'TERM': 'linux', 11:15:21 INFO - 'TMOUT': '86400', 11:15:21 INFO - 'USER': 'cltbld', 11:15:21 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 11:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:21 INFO - '_': '/tools/buildbot/bin/python'} 11:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:15:22 INFO - Running setup.py (path:/tmp/pip-jOCEzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:15:22 INFO - Running setup.py (path:/tmp/pip-keAMRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:15:22 INFO - Running setup.py (path:/tmp/pip-2eyMEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:15:22 INFO - Running setup.py (path:/tmp/pip-I0yuOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:15:22 INFO - Running setup.py (path:/tmp/pip-deqbr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:15:22 INFO - Running setup.py (path:/tmp/pip-Mz_aCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:15:22 INFO - Running setup.py (path:/tmp/pip-XoEpBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:15:22 INFO - Running setup.py (path:/tmp/pip-wkZllg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:15:22 INFO - Running setup.py (path:/tmp/pip-eX2eG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:15:22 INFO - Running setup.py (path:/tmp/pip-QcQhR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:15:22 INFO - Running setup.py (path:/tmp/pip-8xq0jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:15:22 INFO - Running setup.py (path:/tmp/pip-p3mqPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:15:22 INFO - Running setup.py (path:/tmp/pip-yjg9_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:15:22 INFO - Running setup.py (path:/tmp/pip-STrvvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:23 INFO - Running setup.py (path:/tmp/pip-Yi9lhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:15:23 INFO - Running setup.py (path:/tmp/pip-znwc5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:15:23 INFO - Running setup.py (path:/tmp/pip-9kwbPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:15:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:15: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 11:15: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 11:15: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 11:15: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 11:15:24 INFO - Downloading blessings-1.6.tar.gz 11:15:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:15:24 INFO - Installing collected packages: blessings 11:15:24 INFO - Running setup.py install for blessings 11:15:24 INFO - Successfully installed blessings 11:15:24 INFO - Cleaning up... 11:15:24 INFO - Return code: 0 11:15:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:15:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:15:24 INFO - Reading from file tmpfile_stdout 11:15:24 INFO - Current package versions: 11:15:24 INFO - argparse == 1.2.1 11:15:24 INFO - blessings == 1.6 11:15:24 INFO - blobuploader == 1.2.4 11:15:24 INFO - docopt == 0.6.1 11:15:24 INFO - functools32 == 3.2.3-2 11:15:24 INFO - jsonschema == 2.5.1 11:15:24 INFO - manifestparser == 1.1 11:15:24 INFO - mozInstall == 1.13 11:15:24 INFO - mozcrash == 1.0 11:15:24 INFO - mozdebug == 0.1 11:15:24 INFO - mozdevice == 0.51 11:15:24 INFO - mozfile == 1.2 11:15:24 INFO - mozhttpd == 0.7 11:15:24 INFO - mozinfo == 0.10 11:15:24 INFO - mozleak == 0.1 11:15:24 INFO - mozlog == 3.5 11:15:24 INFO - moznetwork == 0.27 11:15:24 INFO - mozprocess == 0.25 11:15:24 INFO - mozprofile == 0.28 11:15:24 INFO - mozrunner == 6.13 11:15:24 INFO - mozscreenshot == 0.1 11:15:24 INFO - mozsystemmonitor == 0.3 11:15:24 INFO - moztest == 0.8 11:15:24 INFO - mozversion == 1.4 11:15:24 INFO - psutil == 3.1.1 11:15:24 INFO - requests == 1.2.3 11:15:24 INFO - wsgiref == 0.1.2 11:15:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:24 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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc77b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe19d60>, '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 0xe1aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1aef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:15:24 INFO - Using env: {'DISPLAY': ':0', 11:15:24 INFO - 'HOME': '/home/cltbld', 11:15:24 INFO - 'LANG': 'en_US.UTF-8', 11:15:24 INFO - 'LANGUAGE': 'en_US:en', 11:15:24 INFO - 'LOGNAME': 'cltbld', 11:15:24 INFO - 'MAIL': '/var/mail/cltbld', 11:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:24 INFO - 'MOZ_NO_REMOTE': '1', 11:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:24 INFO - 'NO_EM_RESTART': '1', 11:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:24 INFO - 'PWD': '/builds/slave/test', 11:15:24 INFO - 'SHELL': '/bin/bash', 11:15:24 INFO - 'SHLVL': '1', 11:15:24 INFO - 'TERM': 'linux', 11:15:24 INFO - 'TMOUT': '86400', 11:15:24 INFO - 'USER': 'cltbld', 11:15:24 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 11:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:24 INFO - '_': '/tools/buildbot/bin/python'} 11:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:15:24 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:15:26 INFO - Installing collected packages: simplejson 11:15:26 INFO - Running setup.py install for simplejson 11:15:26 INFO - building 'simplejson._speedups' extension 11:15:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:15:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:15:27 INFO - Successfully installed simplejson 11:15:27 INFO - Cleaning up... 11:15:27 INFO - Return code: 0 11:15:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:27 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 0xaaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc77b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1c9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe19d60>, '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 0xe1aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1aef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:15:27 INFO - Using env: {'DISPLAY': ':0', 11:15:27 INFO - 'HOME': '/home/cltbld', 11:15:27 INFO - 'LANG': 'en_US.UTF-8', 11:15:27 INFO - 'LANGUAGE': 'en_US:en', 11:15:27 INFO - 'LOGNAME': 'cltbld', 11:15:27 INFO - 'MAIL': '/var/mail/cltbld', 11:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:27 INFO - 'MOZ_NO_REMOTE': '1', 11:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:27 INFO - 'NO_EM_RESTART': '1', 11:15:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:27 INFO - 'PWD': '/builds/slave/test', 11:15:27 INFO - 'SHELL': '/bin/bash', 11:15:27 INFO - 'SHLVL': '1', 11:15:27 INFO - 'TERM': 'linux', 11:15:27 INFO - 'TMOUT': '86400', 11:15:27 INFO - 'USER': 'cltbld', 11:15:27 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 11:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:27 INFO - '_': '/tools/buildbot/bin/python'} 11:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:15:27 INFO - Cleaning up... 11:15:27 INFO - Return code: 0 11:15:27 INFO - Running post-action listener: _resource_record_post_action 11:15:27 INFO - Running post-action listener: _start_resource_monitoring 11:15:27 INFO - Starting resource monitoring. 11:15:27 INFO - [mozharness: 2017-09-27 18:15:27.481883Z] Finished create-virtualenv step (success) 11:15:27 INFO - [mozharness: 2017-09-27 18:15:27.482355Z] Running install step. 11:15:27 INFO - Running pre-action listener: _resource_record_pre_action 11:15:27 INFO - Running main action method: install 11:15:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:15:27 INFO - Reading from file tmpfile_stdout 11:15:27 INFO - Detecting whether we're running mozinstall >=1.0... 11:15:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:15:27 INFO - Reading from file tmpfile_stdout 11:15:27 INFO - Output received: 11:15:27 INFO - Usage: mozinstall [options] installer 11:15:27 INFO - Options: 11:15:27 INFO - -h, --help show this help message and exit 11:15:27 INFO - -d DEST, --destination=DEST 11:15:27 INFO - Directory to install application into. [default: 11:15:27 INFO - "/builds/slave/test"] 11:15:27 INFO - --app=APP Application being installed. [default: firefox] 11:15:27 INFO - mkdir: /builds/slave/test/build/application 11:15:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:15:45 INFO - Reading from file tmpfile_stdout 11:15:45 INFO - Output received: 11:15:45 INFO - /builds/slave/test/build/application/firefox/firefox 11:15:45 INFO - Running post-action listener: _resource_record_post_action 11:15:45 INFO - [mozharness: 2017-09-27 18:15:45.678919Z] Finished install step (success) 11:15:45 INFO - [mozharness: 2017-09-27 18:15:45.679174Z] Running setup-mitmproxy step. 11:15:45 INFO - Running pre-action listener: _resource_record_pre_action 11:15:45 INFO - Running main action method: setup_mitmproxy 11:15:45 INFO - Skipping: mitmproxy is not required 11:15:45 INFO - Running post-action listener: _resource_record_post_action 11:15:45 INFO - [mozharness: 2017-09-27 18:15:45.680308Z] Finished setup-mitmproxy step (success) 11:15:45 INFO - [mozharness: 2017-09-27 18:15:45.680526Z] Running run-tests step. 11:15:45 INFO - Running pre-action listener: _resource_record_pre_action 11:15:45 INFO - Running pre-action listener: _set_gcov_prefix 11:15:45 INFO - Running main action method: run_tests 11:15:45 WARNING - Try message not found. 11:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:15:45 INFO - Python 2.7.3 11:15:45 INFO - Return code: 0 11:15:45 INFO - grabbing minidump binary from tooltool 11:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:45 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 0xe19d60>, '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 0xe1aa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1aef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:15:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:15:45 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:15:45 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:15:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:15:45 INFO - Return code: 0 11:15:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:15:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:15:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:15:45 INFO - ENV: RUST_BACKTRACE is now full 11:15:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:15:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:15:45 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/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:15:45 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/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:15:45 INFO - Using env: {'DISPLAY': ':0', 11:15:45 INFO - 'HOME': '/home/cltbld', 11:15:45 INFO - 'LANG': 'en_US.UTF-8', 11:15:45 INFO - 'LANGUAGE': 'en_US:en', 11:15:45 INFO - 'LOGNAME': 'cltbld', 11:15:45 INFO - 'MAIL': '/var/mail/cltbld', 11:15:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:15:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:15:45 INFO - 'MOZ_ACCELERATED': '1', 11:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:45 INFO - 'MOZ_NO_REMOTE': '1', 11:15:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:15:45 INFO - 'MOZ_WEBRENDER': '1', 11:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:45 INFO - 'NO_EM_RESTART': '1', 11:15:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:45 INFO - 'PWD': '/builds/slave/test', 11:15:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:15:45 INFO - 'RUST_BACKTRACE': 'full', 11:15:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:15:45 INFO - 'SHELL': '/bin/bash', 11:15:45 INFO - 'SHLVL': '1', 11:15:45 INFO - 'TERM': 'linux', 11:15:45 INFO - 'TMOUT': '86400', 11:15:45 INFO - 'USER': 'cltbld', 11:15:45 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 11:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:45 INFO - '_': '/tools/buildbot/bin/python'} 11:15:45 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/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:15:46 INFO - mozversion application_buildid: 20170927172229 11:15:46 INFO - mozversion application_changeset: 6100472d3aa833dff22a4edb0934fe600f43ddb8 11:15:46 INFO - mozversion application_display_name: Nightly 11:15:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:15:46 INFO - mozversion application_name: Firefox 11:15:46 INFO - mozversion application_remotingname: firefox 11:15:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:15:46 INFO - mozversion application_vendor: Mozilla 11:15:46 INFO - mozversion application_version: 58.0a1 11:15:46 INFO - mozversion platform_buildid: 20170927172229 11:15:46 INFO - mozversion platform_changeset: 6100472d3aa833dff22a4edb0934fe600f43ddb8 11:15:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:15:46 INFO - mozversion platform_version: 58.0a1 11:15:46 INFO - using testdate: 1506536146 11:15:46 INFO - actual date: 1506536146 11:15:46 INFO - starting webserver on 'localhost:38377' 11:15:46 INFO - SUITE-START | Running 2 tests 11:15:46 INFO - TEST-START | dromaeo_css 11:15:46 INFO - Initialising browser for dromaeo_css test... 11:15:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38377/getInfo.html -profile /tmp/tmpgvBdk5/profile 11:15:46 INFO - TEST-INFO | started process 15044 (/builds/slave/test/build/application/firefox/firefox http://localhost:38377/getInfo.html) 11:15:52 INFO - TEST-INFO | 15044: exit 0 11:15:52 INFO - Browser initialized. 11:15:52 INFO - Running cycle 1/1 for dromaeo_css test... 11:15:52 INFO - Using env: {'DISPLAY': ':0', 11:15:52 INFO - 'HOME': '/home/cltbld', 11:15:52 INFO - 'JSGC_DISABLE_POISONING': '1', 11:15:52 INFO - 'LANG': 'en_US.UTF-8', 11:15:52 INFO - 'LANGUAGE': 'en_US:en', 11:15:52 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:15:52 INFO - 'LOGNAME': 'cltbld', 11:15:52 INFO - 'MAIL': '/var/mail/cltbld', 11:15:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:15:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:15:52 INFO - 'MOZ_ACCELERATED': '1', 11:15:52 INFO - 'MOZ_CRASHREPORTER': '1', 11:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:52 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:15:52 INFO - 'MOZ_NO_REMOTE': '1', 11:15:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:15:52 INFO - 'MOZ_WEBRENDER': '1', 11:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:52 INFO - 'NO_EM_RESTART': '1', 11:15:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:52 INFO - 'PWD': '/builds/slave/test', 11:15:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:15:52 INFO - 'RUST_BACKTRACE': 'full', 11:15:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:15:52 INFO - 'SHELL': '/bin/bash', 11:15:52 INFO - 'SHLVL': '1', 11:15:52 INFO - 'TERM': 'linux', 11:15:52 INFO - 'TMOUT': '86400', 11:15:52 INFO - 'USER': 'cltbld', 11:15:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 11:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:52 INFO - '_': '/tools/buildbot/bin/python'} 11:15:52 INFO - TEST-INFO | started process 15287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgvBdk5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:15:53 INFO - PID 15287 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:15:53 INFO - PID 15287 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:15:54 INFO - PID 15287 | 11:15:54 INFO - PID 15287 | (/builds/slave/test/build/application/firefox/firefox:15346): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:15:54 INFO - PID 15287 | 11:16:04 INFO - PID 15287 | RSS: Main: 191934464 11:16:04 INFO - PID 15287 | 11:19:01 INFO - PID 15287 | Cycle 1(1): loaded http://localhost:38377/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38377/tests/dromaeo/cssquery-ext.html) 11:19:03 INFO - PID 15287 | RSS: Main: 194744320 11:19:03 INFO - PID 15287 | 11:22:05 INFO - PID 15287 | Cycle 1(1): loaded http://localhost:38377/tests/dromaeo/cssquery-ext.html (next: http://localhost:38377/tests/dromaeo/cssquery-jquery.html) 11:22:05 INFO - PID 15287 | RSS: Main: 192393216 11:22:05 INFO - PID 15287 | 11:25:08 INFO - PID 15287 | Cycle 1(1): loaded http://localhost:38377/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38377/tests/dromaeo/cssquery-mootools.html) 11:25:08 INFO - PID 15287 | RSS: Main: 195399680 11:25:08 INFO - PID 15287 | 11:28:10 INFO - PID 15287 | Cycle 1(1): loaded http://localhost:38377/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38377/tests/dromaeo/cssquery-prototype.html) 11:28:11 INFO - PID 15287 | RSS: Main: 193220608 11:28:11 INFO - PID 15287 | 11:31:14 INFO - PID 15287 | Cycle 1(1): loaded http://localhost:38377/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38377/tests/dromaeo/cssquery-yui.html) 11:31:15 INFO - PID 15287 | RSS: Main: 193953792 11:31:15 INFO - PID 15287 | 11:34:17 INFO - PID 15287 | Cycle 1(1): loaded http://localhost:38377/tests/dromaeo/cssquery-yui.html (next: http://localhost:38377/tests/dromaeo/cssquery-dojo.html) 11:34:17 INFO - PID 15287 | RSS: Main: 196423680 11:34:17 INFO - PID 15287 | 11:34:17 INFO - PID 15287 | __start_tp_report 11:34:17 INFO - PID 15287 | _x_x_mozilla_page_load 11:34:17 INFO - PID 15287 | _x_x_mozilla_page_load_details 11:34:17 INFO - PID 15287 | |i|pagename|runs| 11:34:17 INFO - PID 15287 | |0;dojo.html;3146.307812281297;3147.2761264909072;3180.8568614412357;3196.9040928772115;3197.6482586915436;6244.718987645556;6332.746690132395;6397.168368112145;6402.231732192132;6421.77523786667;6169.2288463942;6307.526935479835;6309.305976342599;6320.74717011319;6327.398897104779;5776.624519406236;5805.24531810864;5935.198748169007;5950.642961422329;5959.910601340962;5833.329167145769;5845.871650596155;5894.88210235795;5910.290765108193;5911.172435858984;5675.148727690838;5756.971914066768;5757;5846.970765146169;5855.238818953551;5751.4536119068625;5819.359870414251;5872.412758724136;5878.470937615635;5884.617499862496;5667.234923285386;5751.913721294184;5765.827025189251;5829.621074630136;5844.44477774615;6216.937830621681;6229.6573688447115;6260.78087266948;6282;6287.685615719196;6638.634875081917;6675.933240667579;6679.86640267192;6726.293739157367;6797.932020679828;6726.058351830748;6771.322867713189;6814.046033555306;6816.7614133505585;6855.897161542581;6262.749490020394;6275.560710750249;6317.178766760338;6330.303666596625;6360.395762402564;6715.059891615178;6840.247572766992;6841.965790171117;6885.51801373899;6943.89584156238;6468.094466774655;6504.024396340492;6554.934450655433;6569.408753212138;6609.636469994197;6651.966740166268;6671.63306018164;6742.056112144303;6869.725210991604;6872.41584465326;6721.395074443323;6731.730730770714;6757.628330441775;6757.662116894136;6824.624645644537;6787.083743694637;6805.795826125224;6874.106366172466;6885.621290828953;6889.207741109836;5131.512506311894;5160.664556803796;5213.296205012351;5236.554892834076;5320.654157479828;4613.331066995334;4634.351190833286;4657.976710116428;4686.578207961232;4706.529347065266;5827.88344233113;5832.358440571534;5898.174255604219;5905.291365036223;5916.349201587822;6713.1944166700305;6785.42323902464;6847.21257055445;6852.5203235774015;6872.62200578973;5677.432256774289;5703.116017017369;5761.827145185651;5783;5825.300963884276;5717.914231286534;5762;5768.423157684198;5802.564807639359;5825.7087145642545;6434.903476447857;6449.161608990801;6476.773312934025;6588.143541339595;6611.140551728245;6641.50188735837;6655.733770649216;6713.1944166700305;6728.327167283331;6749.4600431964345;6400.51996100285;6523.739050437929;6563.638999855054;6572.178477690289;6580.243272023778;6575.178102737158;6633.2371777246235;6644.667766611554;6650.3682150195655;6666.966620173881;6596.736130554724;6610.471162306908;6689.632070236184;6715.261321254756;6774.627395493295;6443.291237963914;6451.548391612542;6470.352964703492;6538.803835884931;6546.149000629887;6252.5935814171935;6392.488600911823;6497.642629655415;6518.478521718156;6527.5757075789925;6293.653849038347;6348.841278968062;6352.364763523796;6352.9047064295;6425.293217746138;6390.13733146038;6409.455196308366;6447.677616119082;6457.289698133295;6475.611463312216;6259.718312676032;6270.341614130451;6275.6548389839;6315.778947736807;6392 11:34:17 INFO - PID 15287 | |1;ext.html;840.7183593496178;862.943908645938;868.2533021601422;868.4658934755123;878.0166213840499;38027.429588556195;38935.22129557407;41421.37867931976;41579.79210103953;41588.16823663525;38839.611603883954;39246;39577.20845583086;39721.20557588847;39815.800920995425;7079.929200707978;7249.492535522516;7279.308465695777;7282.453815963798;7283.344498995089;7152.676754800353;7188.640567971606;7245.347918687317;7298.051253337058;7304.634768261592;7212.134543854745;7235.927640723605;7265.273472652745;7286.417086633057;7332.853342933138;7462.440316976222;8016.118226995026;8038.437309388345;8056.234657707509;8093.190680931919;7874.763757087297;7934.642941067608;7936.722214722515;7940.086890007666;7941.602919854042;38028.429573556416;38452.230955380735;38627.420588691195;38786.80606596949;38905.221895562216;3118.8596513156735;3137.4352616529018;3148.8268145252;3157.857896394668;3164.303853152303;31771.84114079438;32184.517232241535;32253.51619725706;32308.838455807807;32396.352072958645;5143.8456846294675;5191.532762051434;5193.610479214074;5227.320448341729;5311.070562651521;184110;184476;184494;184570.07714961472;186434;42172.36741448881;42639;48248.75875620599;48347.27479087746;48438.27342589864;43376.566234337886;51381.743091285054;51446.742766286676;51649;51822.48177518252;15299.847001530065;15353.309101090477;15406.768898466533;15528.5341439757;15559.377624895104;12445.75108497825;12585;12592.685182870318;12624.74750505003;12657.367131643381;13867.722645547032;13965.162090274616;13994.580162595139;14049.508267210804;14212.786808197885;5867.413258674099;5877.265341832271;5908.4091590841435;5981.641101533922;6083.787067452707;1018.5263852308713;1024.139722632977;1032.1484775060605;1037.5590374090982;1054.335768465877;22652.773472265395;22738;23083.884580577327;23146.074157033865;23231;1121.0919155484085;1127.6729748373043;1134.4101067444883;1143.3140115930541;1144.9198556100994;12233.3271670059;12394;12415.255084694947;12444.75110497785;12515.186512876633;223655;225556;225941;225975;226473;51807.740961295705;52129.2180617291;52144.739276304135;52490.21264681033;52672.73663631657;1406.655369434495;1476.165761737488;1483.6587584855329;1490.992545037268;1498.9700205996037;22394.32817015492;22779.544409111393;22853.428664283525;22906.885465572566;22985.54028919379;37490.43764343482;37557;37559.248815023;37679.81160094182;37730.62269377271;182100;183289;183386;186142;186584;30950.69049309568;31309.686903130678;31531.369372612877;33410.66589334173;35024;42540.36189457223;43988.78005609952;44111;44524;44538.3319250218;31585.21036974094;32024.039278821674;32053.67946320507;32160.678393215767;32336.83831580827;31234.531482028244;31480.05559833209;31636.492651798035;31982;32147;35833.46249806203;36316.636833631324;36498;36576.45135323025;36652;31070.533941990438;31395;31711.36577268488;31713.365732685677;31869.8406507966;23058.049072412265;23293.18473853407;23505.70718610493;23791;23912.641310380706 11:34:17 INFO - PID 15287 | |2;jquery.html;572.8882867840773;574.336641179438;590.1116427432215;596.937321581234;613.9631622102675;21921;22859.199928002523;22877.885610571946;22897.54204915901;22900.427489312777;23414.180503682375;24373.878130609322;25344.239672809847;25698.229053128434;25754.227373178834;6625.0724898514245;6690.397864192221;6719.328067193291;6725.092112564815;6725.428338591226;6613;6748.730050797963;6764.966175169117;6771.4582833373215;6772.864542709168;6342.207224096988;6570.967145164292;6593.736250549972;6595.901061484082;6696;6537.64042977636;6565.146530950946;6566.179227596551;6569.93430065698;6585.506087043467;5959.22530071088;6132.509399248094;6147.077938309245;6155.661438620874;6156.7537298508005;29093.563596546068;29131.271718207;29230.853845730635;29349.70650293491;29850.10449686513;1932.5265309999;1976.6343226503143;1998.960020799576;2001.9299324523572;2002.469345623411;18697.906510467496;18985.145668444955;19253.133608987628;19318.903405482884;19326.130324135305;2205.63607004844;2259.604569200383;2261.5476904618977;2267.263139479659;2291.954160916789;121569;126576;133873.33063334718;136377;140483.59516404808;14943.40226390954;15029.699406011818;15141.697166056618;15156.696866062617;15161.09033457996;23466.882665586905;23544.64683029756;23595.174168904006;23641.40896477602;23645.408864778517;10147.289689721796;10191;10208.642697505551;10385.169186465064;10426.061654450985;9440.433573985583;9471.052894710612;9519.571619277149;9557.23542116629;9557.665481708107;8941.731748047569;9092.954535227414;9129;9153.633854645872;9214.35499515041;2684.4765270772014;2698.8785504652337;2774.805763596529;2828.7454129128478;2879.9280017999718;918.3296193778446;966.6278482784038;968.7045451137329;971.936824106445;973.956171972263;18714.625707485775;18910.621787564447;19385;19508.609827803364;19754.209831606862;985.9507024648882;990.7770751580837;1016.2378216337746;1020.5305559442739;1020.7244044108049;10560.260781745204;10704.036636702735;10831.2959657622;10856.728581785519;10936.453177341102;470556;476543;490002;492229;495754;114055.42972285251;116375;117221;117239;117249.41375293069;1013.3970287678819;1118.1334465788916;1133.5805751871696;1163.9709007274716;1179.9410029498663;20314.28899988493;20377.89811050935;20406.693899591814;20422.149395862107;20482.69275960832;56519.71740141273;57603.42396576148;58126.128108077566;58239;58794.7060264696;71190;71589.64205178941;72615.63692181505;72906.27093729207;73012.63493682498;14188;14522.49171279;14585.635359115682;14628.26858657084;14660.413583456542;22906.54186916219;22915.083396664613;22980.4254893629;22985;23106.653400198673;18078.186481608096;18127.36554220596;18466.81533184651;18566.907165464625;18684.626307473503;16468.341266349213;16541.917290413472;16677.916610417356;17114.05872677015;17203.65592688164;17845.37541186052;18598.721019184453;18797.90601046986;18825.717614236073;18839.811601884354;14418.13491190532;14578.416863325348;14632.926835365755;14654.63363415923;14657.193854338113;18075.638487230444;18076.276948921895;18178.181981811114;18328.725069123706;18376.173072211513 11:34:17 INFO - PID 15287 | |3;mootools.html;1328.4287756264805;1380.1994842991069;1388.402986715712;1393.595857201411;1394.052044609665;15060.774088388669;15661.295241714122;15714.135722535257;15728.606784830385;15754.684906301867;15189.4683686071;15213.771793423108;15218.391264349413;15374.769378459305;15441.382344706226;2638.379980704533;2748.9037883674077;2775.1813215101492;2783.220698204506;2784.49879021776;2399.9880000599974;2521.4578865543904;2521.936951576207;2541.6187571864184;2544.936376590591;2264.5697317509703;2341.051873991028;2370.158593699238;2481.6649752283483;2684.3557546188968;2715.579085241791;2716.239452953176;2732.8087033907636;2737.069396405222;2738.137486691696;2529.6458495810602;2591.805614578914;2601.4797040591957;2603.1799983005294;2609.06073813427;14967.775483367759;15083.849161508355;15143.924280378638;15217.543473695807;15251.23743812805;7932.762017139495;8225.300849427806;8225.588720563948;8230.465019773696;8233.8353232935;4806.519348065201;5197.29836472079;5448.237246785453;5476.91784623231;5494.478024587658;1887.5281179705073;1911.5603411215359;1919.2131226197191;1946.562023544691;1950.4831219726784;26110.34724131912;26830.865845670844;27051.594226086625;27160.864195678896;27187.1843844685;6637.336266373324;6686.3313668632745;6767.458603311723;6811.863762724817;6852.074969879002;16879.40922067722;16883.831161688227;16888.493345199662;16897.746533802;16923.661526769643;7603.0876294844975;7858.253465920729;7910.288074073361;7915.44591878563;7921;7260.092488438945;7297.124345078519;7298.306660867209;7303.867900475435;7364.153122390993;5073.8731531712;5106.948930510647;5175.353080864892;5205.869853253624;5221.973890130601;1445.3062529985455;1481.274175653922;1487.248939285654;1487.8512148785035;1493.4996776079918;823.197382552007;853.7524118005708;855.8416692911832;860.2172023458747;881;6882.311768823178;6906.551074180162;6941.305869413019;6990.335918087773;7115.501914866013;723.7286017743346;735.6836560279024;739.2275072549199;740.7592532426875;750.1373420566283;5102;5201.921971170435;5263.789448422097;5318.9202161967605;5373.570114390839;20688.689669654967;20973;21409.464763381042;21823.890880545812;21853.453663658216;20942.267020654202;21413.785862141493;21698.34904952854;21717;21823.454413639785;10332.605098311782;10480.895191048145;10661.147108231324;10984.395858227714;11134.49894754738;8309.127541608286;8350;8400.705975290835;8562.529060901461;8642.913570864212;18283.908580457544;19034.904825475784;19042;19113;19213.423597291545;17482.650346993243;17880.105994699952;17895.642087158445;19183.80816191876;19886.70169947423;9880.802383952425;11029.338239705643;11071.944640276746;11087.44562771842;11096.056835169102;13810.65473363174;13826.86173138296;13926.93036534811;13971.371288292254;13973.301334933416;10655.89344106549;11125.721856953318;11455.312681239153;11518.654440366467;11522.53909843597;11212.27120237182;11270.605528806453;11458.312501249951;11478.82781758291;11590.188686791844;9632.807343853225;9796.706098817047;9912.553935073083;9940.602375904882;9985.700428986851;6985.091938048021;7083.150021997187;7117.074780278531;7138.250483699137;7176.7846964591145;6878.518503704692;6964.512484126062;6974.965125174342;7024.964875175591;7084.972678961419 11:34:17 INFO - PID 15287 | |4;prototype.html;500.7858867628903;530.3291336459378;536.8939983633715;539.2881396556545;544.9373322067963;6084.817455476337;6163.106349579309;6198.194234749488;6200.069989501577;6288.654124023177;6007.369226231237;6027.879442411149;6032.728527216274;6059.54553408495;6082.969585152079;5088.313077734505;5100.413452452978;5108.335916330871;5112.335396398482;5126.564242039412;5078.21287700407;5078.31442755227;5087;5121.052605268037;5135.1526998045465;4695.694779839317;4853.466118726938;4866.635002374818;5072.26452164436;5087.898242035157;4884.845095180063;4915.778789954461;4922.778474968599;4936.160852655022;4941.752912354368;4391.3193455014525;4408.272635015219;4425.557444255581;4427.749360613815;4437.134758722051;5840.182374467578;5874.588778785486;5934.525237980951;5954.404559544054;5966.343702192756;5614.578906582023;5616.831495055114;5619.157126431068;5631.380548139701;5658.151277308396;6355.809325720235;6376.585521941059;6384.7126879290545;6431.163948686641;6453.515986301046;4841.394825646794;4858.951410485921;4863.951360486385;4867.172580661296;4868.902621947576;6399.36006399361;6560.835979100513;6630.204375474974;6659.800205993828;6669.199696036459;4958.851234462972;4978.228374601942;4986.252062190628;4995.225740010304;5007.198848184273;5044.747762611854;5044.9495505045215;5059.569936555434;5076.162433198555;5101.540861322499;5458.263134476795;5479.342478902558;5589.608727389043;5624.493795558419;5632.352279487829;6412.9679351602945;6473.935260647333;6493.870122597522;6501.414872661483;6505.024246362988;1730.230047628793;1735.2972046321008;1746.9081823860088;1748.9737653934947;1768.7700598922058;1171.753931674358;1215.8601760797621;1223.159145486038;1223.3332833605707;1254.5985284708806;5532.114861622121;5563.860903477445;5592.748326325325;5597.272354593877;5620.325560932714;6502.959526475741;6524.347565243533;6584;6602.7689030883685;6636.170478690164;5472.945270547243;5480.780768769284;5540.667559946416;5571.721413929287;5599.300087489064;3414.9317013660084;3423.4936627883653;3437.9484307735406;3445.3815100523784;3471.600765911902;6275.3724627536885;6311.980166346817;6343.238811342669;6350.157854773619;6355.523335749837;6461;6627.879078694771;6657.367550082734;6705.865882682319;6760.695768690421;5899.380565040695;6214.533909956771;6268.555263447259;6358.364163583605;6366.745330186834;6403.775867844603;6495.415412612888;6521.771737989147;6538.803835884931;6554.606723596599;6375.6174629522375;6378.266499352449;6383.904241436289;6468.188907106018;6487.675616219264;6121.47967422774;6154.737699267062;6236.906446403217;6253.218347706536;6253.435541741163;4909.5090490950615;4912.7543622818;4921.4832442593015;4933.55597996182;4970.502949705001;6162.599431037148;6366;6400.23197216337;6445.613263204223;6478.622743123102;5978.222831032112;6164.291106522628;6214.564980451506;6268.686565671607;6354.364563543609;6075.301340345917;6207.255129384503;6225;6237.220347456568;6293.968530157503;6125.754969801158;6130.570860039755;6183.721732521957;6214.720337584729;6238.344973777688;6257.529480572153;6294.8111556653375;6305.635386729976;6334.1765570475545;6336.398042185985;6083.931463302499;6105.206323177958;6179.598326108789;6221.4089661482085;6230.669684569181 11:34:17 INFO - PID 15287 | |5;yui.html;888.924441422479;903.5843511984486;918.7657147427406;925.6575067225124;926.7822061815474;19515.70726439103;20437.693434598492;20582.89708551457;20602.278920237775;20650;17903.64192716145;18732.344367947124;18808.43574692758;18908.338208162717;19138.71291930622;907.9909200907989;922.5018490015384;926.3191554207652;927.188709878856;933.1182032978837;957.5403806173007;959.3476436023501;959.4099628728317;961.5865177973469;964.6334392930677;991.5339790298548;1026.5175367577226;1030.953607087683;1036.1296510930817;1038.974025649361;1021.0963297481708;1025.2669341420883;1025.3386565665105;1027.3322340478674;1028.9794204115876;708.3164746020116;727.0911360799001;731.9268073192692;749.0150452155398;750.1410884537174;20368.69446958297;20378.898105509525;20532.794672053238;20629.793702062936;20670.896645516677;21092.472688182766;21288.36134915955;22057.22799702019;22102.22642207515;22142.88928555363;16865.747013794804;17056.573585660335;17130.143492825307;17191.742123868153;17220.311187552485;3694.3165514379657;3698.3527882620433;3723.0320116769562;3723.3298006358846;3724.9068773280615;135176;141095;142122;143262;144363;16812.57968550796;16933.49199524016;17144.39994600183;17239.3966211182;17245.137743112795;31013.224669382995;31197.8440107798;31551.84224078865;31771;31977.52033719496;8425.95787021061;8466.492010479391;8483.278921291636;8497.617607207567;8515.616797244014;3932.646061854447;3973.4834471518516;4027.154297597479;4088.2232375848494;4102.548719640837;5060.569851562658;5130.7947682093045;5199.584033277329;5231.29377534028;5245.10833158364;961.1829944547219;961.403929563675;975.4683697384942;989.094978095035;989.5893204320271;609.6037575575823;613.929398119213;619.916311297969;620.2990620598695;639.6162302618392;12053.939730301292;12173.634790956285;12201.450934707782;12994.155379900276;13202.801957970638;574.130192757972;581.8138195777395;592.3070008090544;601.3295175878951;609.871926895357;5456.727163641802;5491.148871924858;5515.503604675599;5516.779328826882;5620.241267428926;113045.43477282561;113683.43158284322;118444;123382.38308808398;125165;108600;110294;111887;114138.42930785293;114872;95632;99532;101886.49056754669;101941;101966.99999999852;10329.586816527255;10554.10290125348;10642.467876605984;10654.467276635982;10668.413237272025;41589.79205103955;41724.79137604292;43027.35458968055;43443.56556434395;43780.56219437765;53718.73140634272;53775.193372100235;53823.73088134534;54136.729316354744;55368.16947745868;15739;15871.603209919382;15879.920600396925;15984;16116.67766644684;17350;17533.298668053645;17546.298148073933;17588.82411175872;17865.821341786417;16092.953957992693;16099.436519722221;16127.67744645077;16165.110918899574;16234.350625974828;15087.396504139711;15208.771868422204;15344.309506072477;15366.154861482279;15390.384384624938;14706.852931470548;14914.850851491346;14974.026688265229;15137.848621513644;15200.847991520386;10959.287646302964;11126.388048657402;11354.943225283821;11738.706532336419;11761;11611.954924056876;11738.765224695288;11749.471273792871;11770.411479426166;12030.15788894769 11:34:17 INFO - PID 15287 | __end_tp_report 11:34:17 INFO - PID 15287 | __start_cc_report 11:34:17 INFO - PID 15287 | _x_x_mozilla_cycle_collect,276 11:34:17 INFO - PID 15287 | __end_cc_report 11:34:17 INFO - PID 15287 | __startTimestamp1506537257761__endTimestamp 11:34:17 INFO - PID 15287 | 11:34:17 INFO - PID 15287 | ------- Summary: start ------- 11:34:17 INFO - PID 15287 | Number of tests: 6 11:34:17 INFO - PID 15287 | 11:34:17 INFO - PID 15287 | [#0] dojo.html Cycles:165 Average:6180.45 Median:6392.00 stddev:730.24 (11.4%) stddev-sans-first:692.61 11:34:17 INFO - PID 15287 | Values: 3146.3 3147.3 3180.9 3196.9 3197.6 6244.7 6332.7 6397.2 6402.2 6421.8 6169.2 6307.5 6309.3 6320.7 6327.4 5776.6 5805.2 5935.2 5950.6 5959.9 5833.3 5845.9 5894.9 5910.3 5911.2 5675.1 5757.0 5757.0 5847.0 5855.2 5751.5 5819.4 5872.4 5878.5 5884.6 5667.2 5751.9 5765.8 5829.6 5844.4 6216.9 6229.7 6260.8 6282.0 6287.7 6638.6 6675.9 6679.9 6726.3 6797.9 6726.1 6771.3 6814.0 6816.8 6855.9 6262.7 6275.6 6317.2 6330.3 6360.4 6715.1 6840.2 6842.0 6885.5 6943.9 6468.1 6504.0 6554.9 6569.4 6609.6 6652.0 6671.6 6742.1 6869.7 6872.4 6721.4 6731.7 6757.6 6757.7 6824.6 6787.1 6805.8 6874.1 6885.6 6889.2 5131.5 5160.7 5213.3 5236.6 5320.7 4613.3 4634.4 4658.0 4686.6 4706.5 5827.9 5832.4 5898.2 5905.3 5916.3 6713.2 6785.4 6847.2 6852.5 6872.6 5677.4 5703.1 5761.8 5783.0 5825.3 5717.9 5762.0 5768.4 5802.6 5825.7 6434.9 6449.2 6476.8 6588.1 6611.1 6641.5 6655.7 6713.2 6728.3 6749.5 6400.5 6523.7 6563.6 6572.2 6580.2 6575.2 6633.2 6644.7 6650.4 6667.0 6596.7 6610.5 6689.6 6715.3 6774.6 6443.3 6451.5 6470.4 6538.8 6546.1 6252.6 6392.5 6497.6 6518.5 6527.6 6293.7 6348.8 6352.4 6352.9 6425.3 6390.1 6409.5 6447.7 6457.3 6475.6 6259.7 6270.3 6275.7 6315.8 6392.0 11:34:17 INFO - PID 15287 | 11:34:17 INFO - PID 15287 | [#1] ext.html Cycles:180 Average:36639.65 Median:32322.84 stddev:51561.74 (159.5%) stddev-sans-first:51636.31 11:34:17 INFO - PID 15287 | Values: 840.7 862.9 868.3 868.5 878.0 38027.4 38935.2 41421.4 41579.8 41588.2 38839.6 39246.0 39577.2 39721.2 39815.8 7079.9 7249.5 7279.3 7282.5 7283.3 7152.7 7188.6 7245.3 7298.1 7304.6 7212.1 7235.9 7265.3 7286.4 7332.9 7462.4 8016.1 8038.4 8056.2 8093.2 7874.8 7934.6 7936.7 7940.1 7941.6 38028.4 38452.2 38627.4 38786.8 38905.2 3118.9 3137.4 3148.8 3157.9 3164.3 31771.8 32184.5 32253.5 32308.8 32396.4 5143.8 5191.5 5193.6 5227.3 5311.1 184110.0 184476.0 184494.0 184570.1 186434.0 42172.4 42639.0 48248.8 48347.3 48438.3 43376.6 51381.7 51446.7 51649.0 51822.5 15299.8 15353.3 15406.8 15528.5 15559.4 12445.8 12585.0 12592.7 12624.7 12657.4 13867.7 13965.2 13994.6 14049.5 14212.8 5867.4 5877.3 5908.4 5981.6 6083.8 1018.5 1024.1 1032.1 1037.6 1054.3 22652.8 22738.0 23083.9 23146.1 23231.0 1121.1 1127.7 1134.4 1143.3 1144.9 12233.3 12394.0 12415.3 12444.8 12515.2 223655.0 225556.0 225941.0 225975.0 226473.0 51807.7 52129.2 52144.7 52490.2 52672.7 1406.7 1476.2 1483.7 1491.0 1499.0 22394.3 22779.5 22853.4 22906.9 22985.5 37490.4 37557.0 37559.2 37679.8 37730.6 182100.0 183289.0 183386.0 186142.0 186584.0 30950.7 31309.7 31531.4 33410.7 35024.0 42540.4 43988.8 44111.0 44524.0 44538.3 31585.2 32024.0 32053.7 32160.7 32336.8 31234.5 31480.1 31636.5 31982.0 32147.0 35833.5 36316.6 36498.0 36576.5 36652.0 31070.5 31395.0 31711.4 31713.4 31869.8 23058.0 23293.2 23505.7 23791.0 23912.6 11:34:17 INFO - PID 15287 | 11:34:17 INFO - PID 15287 | [#2] jquery.html Cycles:180 Average:34577.69 Median:22898.98 stddev:81645.74 (356.5%) stddev-sans-first:81834.85 11:34:17 INFO - PID 15287 | Values: 572.9 574.3 590.1 596.9 614.0 21921.0 22859.2 22877.9 22897.5 22900.4 23414.2 24373.9 25344.2 25698.2 25754.2 6625.1 6690.4 6719.3 6725.1 6725.4 6613.0 6748.7 6765.0 6771.5 6772.9 6342.2 6571.0 6593.7 6595.9 6696.0 6537.6 6565.1 6566.2 6569.9 6585.5 5959.2 6132.5 6147.1 6155.7 6156.8 29093.6 29131.3 29230.9 29349.7 29850.1 1932.5 1976.6 1999.0 2001.9 2002.5 18697.9 18985.1 19253.1 19318.9 19326.1 2205.6 2259.6 2261.5 2267.3 2292.0 121569.0 126576.0 133873.3 136377.0 140483.6 14943.4 15029.7 15141.7 15156.7 15161.1 23466.9 23544.6 23595.2 23641.4 23645.4 10147.3 10191.0 10208.6 10385.2 10426.1 9440.4 9471.1 9519.6 9557.2 9557.7 8941.7 9093.0 9129.0 9153.6 9214.4 2684.5 2698.9 2774.8 2828.7 2879.9 918.3 966.6 968.7 971.9 974.0 18714.6 18910.6 19385.0 19508.6 19754.2 986.0 990.8 1016.2 1020.5 1020.7 10560.3 10704.0 10831.3 10856.7 10936.5 470556.0 476543.0 490002.0 492229.0 495754.0 114055.4 116375.0 117221.0 117239.0 117249.4 1013.4 1118.1 1133.6 1164.0 1179.9 20314.3 20377.9 20406.7 20422.1 20482.7 56519.7 57603.4 58126.1 58239.0 58794.7 71190.0 71589.6 72615.6 72906.3 73012.6 14188.0 14522.5 14585.6 14628.3 14660.4 22906.5 22915.1 22980.4 22985.0 23106.7 18078.2 18127.4 18466.8 18566.9 18684.6 16468.3 16541.9 16677.9 17114.1 17203.7 17845.4 18598.7 18797.9 18825.7 18839.8 14418.1 14578.4 14632.9 14654.6 14657.2 18075.6 18076.3 18178.2 18328.7 18376.2 11:34:17 INFO - PID 15287 | 11:34:17 INFO - PID 15287 | [#3] mootools.html Cycles:180 Average:9239.93 Median:2602.33 stddev:6707.54 (257.8%) stddev-sans-first:6700.02 11:34:17 INFO - PID 15287 | Values: 1328.4 1380.2 1388.4 1393.6 1394.1 15060.8 15661.3 15714.1 15728.6 15754.7 15189.5 15213.8 15218.4 15374.8 15441.4 2638.4 2748.9 2775.2 2783.2 2784.5 2400.0 2521.5 2521.9 2541.6 2544.9 2264.6 2341.1 2370.2 2481.7 2684.4 2715.6 2716.2 2732.8 2737.1 2738.1 2529.6 2591.8 2601.5 2603.2 2609.1 14967.8 15083.8 15143.9 15217.5 15251.2 7932.8 8225.3 8225.6 8230.5 8233.8 4806.5 5197.3 5448.2 5476.9 5494.5 1887.5 1911.6 1919.2 1946.6 1950.5 26110.3 26830.9 27051.6 27160.9 27187.2 6637.3 6686.3 6767.5 6811.9 6852.1 16879.4 16883.8 16888.5 16897.7 16923.7 7603.1 7858.3 7910.3 7915.4 7921.0 7260.1 7297.1 7298.3 7303.9 7364.2 5073.9 5106.9 5175.4 5205.9 5222.0 1445.3 1481.3 1487.2 1487.9 1493.5 823.2 853.8 855.8 860.2 881.0 6882.3 6906.6 6941.3 6990.3 7115.5 723.7 735.7 739.2 740.8 750.1 5102.0 5201.9 5263.8 5318.9 5373.6 20688.7 20973.0 21409.5 21823.9 21853.5 20942.3 21413.8 21698.3 21717.0 21823.5 10332.6 10480.9 10661.1 10984.4 11134.5 8309.1 8350.0 8400.7 8562.5 8642.9 18283.9 19034.9 19042.0 19113.0 19213.4 17482.7 17880.1 17895.6 19183.8 19886.7 9880.8 11029.3 11071.9 11087.4 11096.1 13810.7 13826.9 13926.9 13971.4 13973.3 10655.9 11125.7 11455.3 11518.7 11522.5 11212.3 11270.6 11458.3 11478.8 11590.2 9632.8 9796.7 9912.6 9940.6 9985.7 6985.1 7083.2 7117.1 7138.3 7176.8 6878.5 6964.5 6975.0 7025.0 7085.0 11:34:17 INFO - PID 15287 | 11:34:17 INFO - PID 15287 | [#4] prototype.html Cycles:180 Average:5373.54 Median:5972.28 stddev:1471.31 (24.6%) stddev-sans-first:1429.25 11:34:17 INFO - PID 15287 | Values: 500.8 530.3 536.9 539.3 544.9 6084.8 6163.1 6198.2 6200.1 6288.7 6007.4 6027.9 6032.7 6059.5 6083.0 5088.3 5100.4 5108.3 5112.3 5126.6 5078.2 5078.3 5087.0 5121.1 5135.2 4695.7 4853.5 4866.6 5072.3 5087.9 4884.8 4915.8 4922.8 4936.2 4941.8 4391.3 4408.3 4425.6 4427.7 4437.1 5840.2 5874.6 5934.5 5954.4 5966.3 5614.6 5616.8 5619.2 5631.4 5658.2 6355.8 6376.6 6384.7 6431.2 6453.5 4841.4 4859.0 4864.0 4867.2 4868.9 6399.4 6560.8 6630.2 6659.8 6669.2 4958.9 4978.2 4986.3 4995.2 5007.2 5044.7 5044.9 5059.6 5076.2 5101.5 5458.3 5479.3 5589.6 5624.5 5632.4 6413.0 6473.9 6493.9 6501.4 6505.0 1730.2 1735.3 1746.9 1749.0 1768.8 1171.8 1215.9 1223.2 1223.3 1254.6 5532.1 5563.9 5592.7 5597.3 5620.3 6503.0 6524.3 6584.0 6602.8 6636.2 5472.9 5480.8 5540.7 5571.7 5599.3 3414.9 3423.5 3437.9 3445.4 3471.6 6275.4 6312.0 6343.2 6350.2 6355.5 6461.0 6627.9 6657.4 6705.9 6760.7 5899.4 6214.5 6268.6 6358.4 6366.7 6403.8 6495.4 6521.8 6538.8 6554.6 6375.6 6378.3 6383.9 6468.2 6487.7 6121.5 6154.7 6236.9 6253.2 6253.4 4909.5 4912.8 4921.5 4933.6 4970.5 6162.6 6366.0 6400.2 6445.6 6478.6 5978.2 6164.3 6214.6 6268.7 6354.4 6075.3 6207.3 6225.0 6237.2 6294.0 6125.8 6130.6 6183.7 6214.7 6238.3 6257.5 6294.8 6305.6 6334.2 6336.4 6083.9 6105.2 6179.6 6221.4 6230.7 11:34:17 INFO - PID 15287 | 11:34:17 INFO - PID 15287 | [#5] yui.html Cycles:180 Average:24355.56 Median:20485.24 stddev:35564.47 (173.6%) stddev-sans-first:35620.59 11:34:17 INFO - PID 15287 | Values: 888.9 903.6 918.8 925.7 926.8 19515.7 20437.7 20582.9 20602.3 20650.0 17903.6 18732.3 18808.4 18908.3 19138.7 908.0 922.5 926.3 927.2 933.1 957.5 959.3 959.4 961.6 964.6 991.5 1026.5 1031.0 1036.1 1039.0 1021.1 1025.3 1025.3 1027.3 1029.0 708.3 727.1 731.9 749.0 750.1 20368.7 20378.9 20532.8 20629.8 20670.9 21092.5 21288.4 22057.2 22102.2 22142.9 16865.7 17056.6 17130.1 17191.7 17220.3 3694.3 3698.4 3723.0 3723.3 3724.9 135176.0 141095.0 142122.0 143262.0 144363.0 16812.6 16933.5 17144.4 17239.4 17245.1 31013.2 31197.8 31551.8 31771.0 31977.5 8426.0 8466.5 8483.3 8497.6 8515.6 3932.6 3973.5 4027.2 4088.2 4102.5 5060.6 5130.8 5199.6 5231.3 5245.1 961.2 961.4 975.5 989.1 989.6 609.6 613.9 619.9 620.3 639.6 12053.9 12173.6 12201.5 12994.2 13202.8 574.1 581.8 592.3 601.3 609.9 5456.7 5491.1 5515.5 5516.8 5620.2 113045.4 113683.4 118444.0 123382.4 125165.0 108600.0 110294.0 111887.0 114138.4 114872.0 95632.0 99532.0 101886.5 101941.0 101967.0 10329.6 10554.1 10642.5 10654.5 10668.4 41589.8 41724.8 43027.4 43443.6 43780.6 53718.7 53775.2 53823.7 54136.7 55368.2 15739.0 15871.6 15879.9 15984.0 16116.7 17350.0 17533.3 17546.3 17588.8 17865.8 16093.0 16099.4 16127.7 16165.1 16234.4 15087.4 15208.8 15344.3 15366.2 15390.4 14706.9 14914.9 14974.0 15137.8 15200.8 10959.3 11126.4 11354.9 11738.7 11761.0 11612.0 11738.8 11749.5 11770.4 12030.2 11:34:17 INFO - PID 15287 | -------- Summary: end -------- 11:34:17 INFO - PID 15287 | 11:34:18 INFO - TEST-INFO | 15287: exit 0 11:34:18 INFO - TEST-OK | dromaeo_css | took 1112569ms 11:34:18 INFO - TEST-START | kraken 11:34:18 INFO - Initialising browser for kraken test... 11:34:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38377/getInfo.html -profile /tmp/tmpiEhjh_/profile 11:34:18 INFO - TEST-INFO | started process 15673 (/builds/slave/test/build/application/firefox/firefox http://localhost:38377/getInfo.html) 11:34:24 INFO - TEST-INFO | 15673: exit 0 11:34:24 INFO - Browser initialized. 11:34:24 INFO - Running cycle 1/1 for kraken test... 11:34:24 INFO - Using env: {'DISPLAY': ':0', 11:34:24 INFO - 'HOME': '/home/cltbld', 11:34:24 INFO - 'JSGC_DISABLE_POISONING': '1', 11:34:24 INFO - 'LANG': 'en_US.UTF-8', 11:34:24 INFO - 'LANGUAGE': 'en_US:en', 11:34:24 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:34:24 INFO - 'LOGNAME': 'cltbld', 11:34:24 INFO - 'MAIL': '/var/mail/cltbld', 11:34:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:34:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:34:24 INFO - 'MOZ_ACCELERATED': '1', 11:34:24 INFO - 'MOZ_CRASHREPORTER': '1', 11:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:24 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:34:24 INFO - 'MOZ_NO_REMOTE': '1', 11:34:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:34:24 INFO - 'MOZ_WEBRENDER': '1', 11:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:24 INFO - 'NO_EM_RESTART': '1', 11:34:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:24 INFO - 'PWD': '/builds/slave/test', 11:34:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:34:24 INFO - 'RUST_BACKTRACE': 'full', 11:34:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:34:24 INFO - 'SHELL': '/bin/bash', 11:34:24 INFO - 'SHLVL': '1', 11:34:24 INFO - 'TERM': 'linux', 11:34:24 INFO - 'TMOUT': '86400', 11:34:24 INFO - 'USER': 'cltbld', 11:34:24 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271', 11:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:24 INFO - '_': '/tools/buildbot/bin/python'} 11:34:24 INFO - TEST-INFO | started process 15921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiEhjh_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:34:25 INFO - PID 15921 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:34:25 INFO - PID 15921 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:34:25 INFO - PID 15921 | 11:34:25 INFO - PID 15921 | (/builds/slave/test/build/application/firefox/firefox:15980): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:34:25 INFO - PID 15921 | 11:34:35 INFO - PID 15921 | RSS: Main: 195555328 11:34:35 INFO - PID 15921 | 11:34:38 INFO - PID 15921 | Cycle 1(1): loaded http://localhost:38377/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38377/tests/kraken/driver.html?testName=audio-beat-detection) 11:34:39 INFO - PID 15921 | RSS: Main: 192110592 11:34:39 INFO - PID 15921 | 11:34:42 INFO - PID 15921 | Cycle 1(1): loaded http://localhost:38377/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38377/tests/kraken/driver.html?testName=audio-dft) 11:34:42 INFO - PID 15921 | RSS: Main: 192442368 11:34:42 INFO - PID 15921 | 11:34:45 INFO - PID 15921 | Cycle 1(1): loaded http://localhost:38377/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38377/tests/kraken/driver.html?testName=audio-fft) 11:34:46 INFO - PID 15921 | RSS: Main: 189603840 11:34:46 INFO - PID 15921 | 11:34:48 INFO - PID 15921 | Cycle 1(1): loaded http://localhost:38377/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38377/tests/kraken/driver.html?testName=audio-oscillator) 11:34:49 INFO - PID 15921 | RSS: Main: 189509632 11:34:49 INFO - PID 15921 | 11:34:51 INFO - PID 15921 | Cycle 1(1): loaded http://localhost:38377/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38377/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:34:52 INFO - PID 15921 | RSS: Main: 189493248 11:34:52 INFO - PID 15921 | 11:34:55 INFO - PID 15921 | Cycle 1(1): loaded http://localhost:38377/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38377/tests/kraken/driver.html?testName=imaging-darkroom) 11:34:55 INFO - PID 15921 | RSS: Main: 191995904 11:34:55 INFO - PID 15921 | 11:34:59 INFO - PID 15921 | Cycle 1(1): loaded http://localhost:38377/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38377/tests/kraken/driver.html?testName=imaging-desaturate) 11:35:00 INFO - PID 15921 | RSS: Main: 191320064 11:35:00 INFO - PID 15921 | 11:35:03 INFO - PID 15921 | Cycle 1(1): loaded http://localhost:38377/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38377/tests/kraken/driver.html?testName=json-parse-financial) 11:35:03 INFO - PID 15921 | RSS: Main: 192081920 11:35:03 INFO - PID 15921 | 11:35:05 INFO - PID 15921 | Cycle 1(1): loaded http://localhost:38377/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38377/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:35:06 INFO - PID 15921 | RSS: Main: 192802816 11:35:06 INFO - PID 15921 | 11:35:07 INFO - PID 15921 | Cycle 1(1): loaded http://localhost:38377/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38377/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:35:08 INFO - PID 15921 | RSS: Main: 189825024 11:35:08 INFO - PID 15921 | 11:35:10 INFO - PID 15921 | Cycle 1(1): loaded http://localhost:38377/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38377/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:35:11 INFO - PID 15921 | RSS: Main: 189493248 11:35:11 INFO - PID 15921 | 11:35:14 INFO - PID 15921 | Cycle 1(1): loaded http://localhost:38377/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:35:14 INFO - PID 15921 | RSS: Main: 190025728 11:35:14 INFO - PID 15921 | 11:35:17 INFO - PID 15921 | Cycle 1(1): loaded http://localhost:38377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:35:18 INFO - PID 15921 | RSS: Main: 189931520 11:35:18 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | Cycle 1(1): loaded http://localhost:38377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38377/tests/kraken/driver.html?testName=ai-astar) 11:35:20 INFO - PID 15921 | RSS: Main: 190996480 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | __start_tp_report 11:35:20 INFO - PID 15921 | _x_x_mozilla_page_load 11:35:20 INFO - PID 15921 | _x_x_mozilla_page_load_details 11:35:20 INFO - PID 15921 | |i|pagename|runs| 11:35:20 INFO - PID 15921 | |0;ai-astar;108;109;110;113;109;117;110;109;114;109 11:35:20 INFO - PID 15921 | |1;audio-beat-detection;125;123;120;119;152;125;123;117;123;131 11:35:20 INFO - PID 15921 | |2;audio-dft;171;162;163;164;178;168;166;163;164;167 11:35:20 INFO - PID 15921 | |3;audio-fft;89;80;83;79;77;75;77;78;75;80 11:35:20 INFO - PID 15921 | |4;audio-oscillator;79;80;81;82;86;80;88;79;79;83 11:35:20 INFO - PID 15921 | |5;imaging-gaussian-blur;114;114;114;111;115;124;120;116;119;112 11:35:20 INFO - PID 15921 | |6;imaging-darkroom;156;158;150;149;147;159;148;148;148;148 11:35:20 INFO - PID 15921 | |7;imaging-desaturate;94;94;94;95;95;99;99;96;94;94 11:35:20 INFO - PID 15921 | |8;json-parse-financial;56;54;54;52;60;54;66;54;53;61 11:35:20 INFO - PID 15921 | |9;json-stringify-tinderbox;41;45;39;47;39;40;41;46;46;38 11:35:20 INFO - PID 15921 | |10;stanford-crypto-aes;78;74;74;78;78;80;78;79;76;73 11:35:20 INFO - PID 15921 | |11;stanford-crypto-ccm;120;119;119;117;111;124;127;121;115;117 11:35:20 INFO - PID 15921 | |12;stanford-crypto-pbkdf2;173;177;172;170;172;167;172;174;170;171 11:35:20 INFO - PID 15921 | |13;stanford-crypto-sha256-iterative;67;66;62;64;67;65;63;63;68;65 11:35:20 INFO - PID 15921 | __end_tp_report 11:35:20 INFO - PID 15921 | __start_cc_report 11:35:20 INFO - PID 15921 | _x_x_mozilla_cycle_collect,771 11:35:20 INFO - PID 15921 | __end_cc_report 11:35:20 INFO - PID 15921 | __startTimestamp1506537320330__endTimestamp 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | ------- Summary: start ------- 11:35:20 INFO - PID 15921 | Number of tests: 14 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | [#0] ai-astar Cycles:10 Average:110.80 Median:110.00 stddev:2.90 (2.6%) stddev-sans-first:2.89 11:35:20 INFO - PID 15921 | Values: 108.0 109.0 110.0 113.0 109.0 117.0 110.0 109.0 114.0 109.0 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | [#1] audio-beat-detection Cycles:10 Average:125.80 Median:124.00 stddev:9.98 (8.0%) stddev-sans-first:10.58 11:35:20 INFO - PID 15921 | Values: 125.0 123.0 120.0 119.0 152.0 125.0 123.0 117.0 123.0 131.0 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | [#2] audio-dft Cycles:10 Average:166.60 Median:166.50 stddev:4.86 (2.9%) stddev-sans-first:4.88 11:35:20 INFO - PID 15921 | Values: 171.0 162.0 163.0 164.0 178.0 168.0 166.0 163.0 164.0 167.0 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | [#3] audio-fft Cycles:10 Average:79.30 Median:79.50 stddev:4.19 (5.3%) stddev-sans-first:2.59 11:35:20 INFO - PID 15921 | Values: 89.0 80.0 83.0 79.0 77.0 75.0 77.0 78.0 75.0 80.0 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | [#4] audio-oscillator Cycles:10 Average:81.70 Median:81.50 stddev:3.13 (3.8%) stddev-sans-first:3.16 11:35:20 INFO - PID 15921 | Values: 79.0 80.0 81.0 82.0 86.0 80.0 88.0 79.0 79.0 83.0 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:115.50 stddev:3.98 (3.4%) stddev-sans-first:4.17 11:35:20 INFO - PID 15921 | Values: 114.0 114.0 114.0 111.0 115.0 124.0 120.0 116.0 119.0 112.0 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:149.50 stddev:4.65 (3.1%) stddev-sans-first:4.59 11:35:20 INFO - PID 15921 | Values: 156.0 158.0 150.0 149.0 147.0 159.0 148.0 148.0 148.0 148.0 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:2.01 (2.1%) stddev-sans-first:2.07 11:35:20 INFO - PID 15921 | Values: 94.0 94.0 94.0 95.0 95.0 99.0 99.0 96.0 94.0 94.0 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:55.00 stddev:4.48 (8.1%) stddev-sans-first:4.75 11:35:20 INFO - PID 15921 | Values: 56.0 54.0 54.0 52.0 60.0 54.0 66.0 54.0 53.0 61.0 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | [#9] json-stringify-tinderbox Cycles:10 Average:42.20 Median:43.00 stddev:3.43 (8.0%) stddev-sans-first:3.61 11:35:20 INFO - PID 15921 | Values: 41.0 45.0 39.0 47.0 39.0 40.0 41.0 46.0 46.0 38.0 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:78.00 stddev:2.39 (3.1%) stddev-sans-first:2.50 11:35:20 INFO - PID 15921 | Values: 78.0 74.0 74.0 78.0 78.0 80.0 78.0 79.0 76.0 73.0 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:119.50 stddev:4.50 (3.8%) stddev-sans-first:4.76 11:35:20 INFO - PID 15921 | Values: 120.0 119.0 119.0 117.0 111.0 124.0 127.0 121.0 115.0 117.0 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:172.00 stddev:2.66 (1.5%) stddev-sans-first:2.78 11:35:20 INFO - PID 15921 | Values: 173.0 177.0 172.0 170.0 172.0 167.0 172.0 174.0 170.0 171.0 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.50 stddev:2.00 (3.1%) stddev-sans-first:1.99 11:35:20 INFO - PID 15921 | Values: 67.0 66.0 62.0 64.0 67.0 65.0 63.0 63.0 68.0 65.0 11:35:20 INFO - PID 15921 | -------- Summary: end -------- 11:35:20 INFO - PID 15921 | 11:35:20 INFO - PID 15921 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:35:21 INFO - TEST-INFO | 15921: exit 0 11:35:21 INFO - TEST-OK | kraken | took 62603ms 11:35:21 INFO - SUITE-END | took 1175s 11:35:21 INFO - Completed test suite (00:19:35) 11:35:21 INFO - javascript benchmark 11:35:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8403.260112400993, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3146.307812281297, 3147.2761264909072, 3180.8568614412357, 3196.9040928772115, 3197.6482586915436, 6244.718987645556, 6332.746690132395, 6397.168368112145, 6402.231732192132, 6421.77523786667, 6169.2288463942, 6307.526935479835, 6309.305976342599, 6320.74717011319, 6327.398897104779, 5776.624519406236, 5805.24531810864, 5935.198748169007, 5950.642961422329, 5959.910601340962, 5833.329167145769, 5845.871650596155, 5894.88210235795, 5910.290765108193, 5911.172435858984, 5675.148727690838, 5756.971914066768, 5757.0, 5846.970765146169, 5855.238818953551, 5751.4536119068625, 5819.359870414251, 5872.412758724136, 5878.470937615635, 5884.617499862496, 5667.234923285386, 5751.913721294184, 5765.827025189251, 5829.621074630136, 5844.44477774615, 6216.937830621681, 6229.6573688447115, 6260.78087266948, 6282.0, 6287.685615719196, 6638.634875081917, 6675.933240667579, 6679.86640267192, 6726.293739157367, 6797.932020679828, 6726.058351830748, 6771.322867713189, 6814.046033555306, 6816.7614133505585, 6855.897161542581, 6262.749490020394, 6275.560710750249, 6317.178766760338, 6330.303666596625, 6360.395762402564, 6715.059891615178, 6840.247572766992, 6841.965790171117, 6885.51801373899, 6943.89584156238, 6468.094466774655, 6504.024396340492, 6554.934450655433, 6569.408753212138, 6609.636469994197, 6651.966740166268, 6671.63306018164, 6742.056112144303, 6869.725210991604, 6872.41584465326, 6721.395074443323, 6731.730730770714, 6757.628330441775, 6757.662116894136, 6824.624645644537, 6787.083743694637, 6805.795826125224, 6874.106366172466, 6885.621290828953, 6889.207741109836, 5131.512506311894, 5160.664556803796, 5213.296205012351, 5236.554892834076, 5320.654157479828, 4613.331066995334, 4634.351190833286, 4657.976710116428, 4686.578207961232, 4706.529347065266, 5827.88344233113, 5832.358440571534, 5898.174255604219, 5905.291365036223, 5916.349201587822, 6713.1944166700305, 6785.42323902464, 6847.21257055445, 6852.5203235774015, 6872.62200578973, 5677.432256774289, 5703.116017017369, 5761.827145185651, 5783.0, 5825.300963884276, 5717.914231286534, 5762.0, 5768.423157684198, 5802.564807639359, 5825.7087145642545, 6434.903476447857, 6449.161608990801, 6476.773312934025, 6588.143541339595, 6611.140551728245, 6641.50188735837, 6655.733770649216, 6713.1944166700305, 6728.327167283331, 6749.4600431964345, 6400.51996100285, 6523.739050437929, 6563.638999855054, 6572.178477690289, 6580.243272023778, 6575.178102737158, 6633.2371777246235, 6644.667766611554, 6650.3682150195655, 6666.966620173881, 6596.736130554724, 6610.471162306908, 6689.632070236184, 6715.261321254756, 6774.627395493295, 6443.291237963914, 6451.548391612542, 6470.352964703492, 6538.803835884931, 6546.149000629887, 6252.5935814171935, 6392.488600911823, 6497.642629655415, 6518.478521718156, 6527.5757075789925, 6293.653849038347, 6348.841278968062, 6352.364763523796, 6352.9047064295, 6425.293217746138, 6390.13733146038, 6409.455196308366, 6447.677616119082, 6457.289698133295, 6475.611463312216, 6259.718312676032, 6270.341614130451, 6275.6548389839, 6315.778947736807, 6392.0], "value": 6125.545253166166, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [840.7183593496178, 862.943908645938, 868.2533021601422, 868.4658934755123, 878.0166213840499, 38027.429588556195, 38935.22129557407, 41421.37867931976, 41579.79210103953, 41588.16823663525, 38839.611603883954, 39246.0, 39577.20845583086, 39721.20557588847, 39815.800920995425, 7079.929200707978, 7249.492535522516, 7279.308465695777, 7282.453815963798, 7283.344498995089, 7152.676754800353, 7188.640567971606, 7245.347918687317, 7298.051253337058, 7304.634768261592, 7212.134543854745, 7235.927640723605, 7265.273472652745, 7286.417086633057, 7332.853342933138, 7462.440316976222, 8016.118226995026, 8038.437309388345, 8056.234657707509, 8093.190680931919, 7874.763757087297, 7934.642941067608, 7936.722214722515, 7940.086890007666, 7941.602919854042, 38028.429573556416, 38452.230955380735, 38627.420588691195, 38786.80606596949, 38905.221895562216, 3118.8596513156735, 3137.4352616529018, 3148.8268145252, 3157.857896394668, 3164.303853152303, 31771.84114079438, 32184.517232241535, 32253.51619725706, 32308.838455807807, 32396.352072958645, 5143.8456846294675, 5191.532762051434, 5193.610479214074, 5227.320448341729, 5311.070562651521, 184110.0, 184476.0, 184494.0, 184570.07714961472, 186434.0, 42172.36741448881, 42639.0, 48248.75875620599, 48347.27479087746, 48438.27342589864, 43376.566234337886, 51381.743091285054, 51446.742766286676, 51649.0, 51822.48177518252, 15299.847001530065, 15353.309101090477, 15406.768898466533, 15528.5341439757, 15559.377624895104, 12445.75108497825, 12585.0, 12592.685182870318, 12624.74750505003, 12657.367131643381, 13867.722645547032, 13965.162090274616, 13994.580162595139, 14049.508267210804, 14212.786808197885, 5867.413258674099, 5877.265341832271, 5908.4091590841435, 5981.641101533922, 6083.787067452707, 1018.5263852308713, 1024.139722632977, 1032.1484775060605, 1037.5590374090982, 1054.335768465877, 22652.773472265395, 22738.0, 23083.884580577327, 23146.074157033865, 23231.0, 1121.0919155484085, 1127.6729748373043, 1134.4101067444883, 1143.3140115930541, 1144.9198556100994, 12233.3271670059, 12394.0, 12415.255084694947, 12444.75110497785, 12515.186512876633, 223655.0, 225556.0, 225941.0, 225975.0, 226473.0, 51807.740961295705, 52129.2180617291, 52144.739276304135, 52490.21264681033, 52672.73663631657, 1406.655369434495, 1476.165761737488, 1483.6587584855329, 1490.992545037268, 1498.9700205996037, 22394.32817015492, 22779.544409111393, 22853.428664283525, 22906.885465572566, 22985.54028919379, 37490.43764343482, 37557.0, 37559.248815023, 37679.81160094182, 37730.62269377271, 182100.0, 183289.0, 183386.0, 186142.0, 186584.0, 30950.69049309568, 31309.686903130678, 31531.369372612877, 33410.66589334173, 35024.0, 42540.36189457223, 43988.78005609952, 44111.0, 44524.0, 44538.3319250218, 31585.21036974094, 32024.039278821674, 32053.67946320507, 32160.678393215767, 32336.83831580827, 31234.531482028244, 31480.05559833209, 31636.492651798035, 31982.0, 32147.0, 35833.46249806203, 36316.636833631324, 36498.0, 36576.45135323025, 36652.0, 31070.533941990438, 31395.0, 31711.36577268488, 31713.365732685677, 31869.8406507966, 23058.049072412265, 23293.18473853407, 23505.70718610493, 23791.0, 23912.641310380706], "value": 16912.87010550952, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.8882867840773, 574.336641179438, 590.1116427432215, 596.937321581234, 613.9631622102675, 21921.0, 22859.199928002523, 22877.885610571946, 22897.54204915901, 22900.427489312777, 23414.180503682375, 24373.878130609322, 25344.239672809847, 25698.229053128434, 25754.227373178834, 6625.0724898514245, 6690.397864192221, 6719.328067193291, 6725.092112564815, 6725.428338591226, 6613.0, 6748.730050797963, 6764.966175169117, 6771.4582833373215, 6772.864542709168, 6342.207224096988, 6570.967145164292, 6593.736250549972, 6595.901061484082, 6696.0, 6537.64042977636, 6565.146530950946, 6566.179227596551, 6569.93430065698, 6585.506087043467, 5959.22530071088, 6132.509399248094, 6147.077938309245, 6155.661438620874, 6156.7537298508005, 29093.563596546068, 29131.271718207, 29230.853845730635, 29349.70650293491, 29850.10449686513, 1932.5265309999, 1976.6343226503143, 1998.960020799576, 2001.9299324523572, 2002.469345623411, 18697.906510467496, 18985.145668444955, 19253.133608987628, 19318.903405482884, 19326.130324135305, 2205.63607004844, 2259.604569200383, 2261.5476904618977, 2267.263139479659, 2291.954160916789, 121569.0, 126576.0, 133873.33063334718, 136377.0, 140483.59516404808, 14943.40226390954, 15029.699406011818, 15141.697166056618, 15156.696866062617, 15161.09033457996, 23466.882665586905, 23544.64683029756, 23595.174168904006, 23641.40896477602, 23645.408864778517, 10147.289689721796, 10191.0, 10208.642697505551, 10385.169186465064, 10426.061654450985, 9440.433573985583, 9471.052894710612, 9519.571619277149, 9557.23542116629, 9557.665481708107, 8941.731748047569, 9092.954535227414, 9129.0, 9153.633854645872, 9214.35499515041, 2684.4765270772014, 2698.8785504652337, 2774.805763596529, 2828.7454129128478, 2879.9280017999718, 918.3296193778446, 966.6278482784038, 968.7045451137329, 971.936824106445, 973.956171972263, 18714.625707485775, 18910.621787564447, 19385.0, 19508.609827803364, 19754.209831606862, 985.9507024648882, 990.7770751580837, 1016.2378216337746, 1020.5305559442739, 1020.7244044108049, 10560.260781745204, 10704.036636702735, 10831.2959657622, 10856.728581785519, 10936.453177341102, 470556.0, 476543.0, 490002.0, 492229.0, 495754.0, 114055.42972285251, 116375.0, 117221.0, 117239.0, 117249.41375293069, 1013.3970287678819, 1118.1334465788916, 1133.5805751871696, 1163.9709007274716, 1179.9410029498663, 20314.28899988493, 20377.89811050935, 20406.693899591814, 20422.149395862107, 20482.69275960832, 56519.71740141273, 57603.42396576148, 58126.128108077566, 58239.0, 58794.7060264696, 71190.0, 71589.64205178941, 72615.63692181505, 72906.27093729207, 73012.63493682498, 14188.0, 14522.49171279, 14585.635359115682, 14628.26858657084, 14660.413583456542, 22906.54186916219, 22915.083396664613, 22980.4254893629, 22985.0, 23106.653400198673, 18078.186481608096, 18127.36554220596, 18466.81533184651, 18566.907165464625, 18684.626307473503, 16468.341266349213, 16541.917290413472, 16677.916610417356, 17114.05872677015, 17203.65592688164, 17845.37541186052, 18598.721019184453, 18797.90601046986, 18825.717614236073, 18839.811601884354, 14418.13491190532, 14578.416863325348, 14632.926835365755, 14654.63363415923, 14657.193854338113, 18075.638487230444, 18076.276948921895, 18178.181981811114, 18328.725069123706, 18376.173072211513], "value": 11963.766574011148, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.4287756264805, 1380.1994842991069, 1388.402986715712, 1393.595857201411, 1394.052044609665, 15060.774088388669, 15661.295241714122, 15714.135722535257, 15728.606784830385, 15754.684906301867, 15189.4683686071, 15213.771793423108, 15218.391264349413, 15374.769378459305, 15441.382344706226, 2638.379980704533, 2748.9037883674077, 2775.1813215101492, 2783.220698204506, 2784.49879021776, 2399.9880000599974, 2521.4578865543904, 2521.936951576207, 2541.6187571864184, 2544.936376590591, 2264.5697317509703, 2341.051873991028, 2370.158593699238, 2481.6649752283483, 2684.3557546188968, 2715.579085241791, 2716.239452953176, 2732.8087033907636, 2737.069396405222, 2738.137486691696, 2529.6458495810602, 2591.805614578914, 2601.4797040591957, 2603.1799983005294, 2609.06073813427, 14967.775483367759, 15083.849161508355, 15143.924280378638, 15217.543473695807, 15251.23743812805, 7932.762017139495, 8225.300849427806, 8225.588720563948, 8230.465019773696, 8233.8353232935, 4806.519348065201, 5197.29836472079, 5448.237246785453, 5476.91784623231, 5494.478024587658, 1887.5281179705073, 1911.5603411215359, 1919.2131226197191, 1946.562023544691, 1950.4831219726784, 26110.34724131912, 26830.865845670844, 27051.594226086625, 27160.864195678896, 27187.1843844685, 6637.336266373324, 6686.3313668632745, 6767.458603311723, 6811.863762724817, 6852.074969879002, 16879.40922067722, 16883.831161688227, 16888.493345199662, 16897.746533802, 16923.661526769643, 7603.0876294844975, 7858.253465920729, 7910.288074073361, 7915.44591878563, 7921.0, 7260.092488438945, 7297.124345078519, 7298.306660867209, 7303.867900475435, 7364.153122390993, 5073.8731531712, 5106.948930510647, 5175.353080864892, 5205.869853253624, 5221.973890130601, 1445.3062529985455, 1481.274175653922, 1487.248939285654, 1487.8512148785035, 1493.4996776079918, 823.197382552007, 853.7524118005708, 855.8416692911832, 860.2172023458747, 881.0, 6882.311768823178, 6906.551074180162, 6941.305869413019, 6990.335918087773, 7115.501914866013, 723.7286017743346, 735.6836560279024, 739.2275072549199, 740.7592532426875, 750.1373420566283, 5102.0, 5201.921971170435, 5263.789448422097, 5318.9202161967605, 5373.570114390839, 20688.689669654967, 20973.0, 21409.464763381042, 21823.890880545812, 21853.453663658216, 20942.267020654202, 21413.785862141493, 21698.34904952854, 21717.0, 21823.454413639785, 10332.605098311782, 10480.895191048145, 10661.147108231324, 10984.395858227714, 11134.49894754738, 8309.127541608286, 8350.0, 8400.705975290835, 8562.529060901461, 8642.913570864212, 18283.908580457544, 19034.904825475784, 19042.0, 19113.0, 19213.423597291545, 17482.650346993243, 17880.105994699952, 17895.642087158445, 19183.80816191876, 19886.70169947423, 9880.802383952425, 11029.338239705643, 11071.944640276746, 11087.44562771842, 11096.056835169102, 13810.65473363174, 13826.86173138296, 13926.93036534811, 13971.371288292254, 13973.301334933416, 10655.89344106549, 11125.721856953318, 11455.312681239153, 11518.654440366467, 11522.53909843597, 11212.27120237182, 11270.605528806453, 11458.312501249951, 11478.82781758291, 11590.188686791844, 9632.807343853225, 9796.706098817047, 9912.553935073083, 9940.602375904882, 9985.700428986851, 6985.091938048021, 7083.150021997187, 7117.074780278531, 7138.250483699137, 7176.7846964591145, 6878.518503704692, 6964.512484126062, 6974.965125174342, 7024.964875175591, 7084.972678961419], "value": 6521.502397086267, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.7858867628903, 530.3291336459378, 536.8939983633715, 539.2881396556545, 544.9373322067963, 6084.817455476337, 6163.106349579309, 6198.194234749488, 6200.069989501577, 6288.654124023177, 6007.369226231237, 6027.879442411149, 6032.728527216274, 6059.54553408495, 6082.969585152079, 5088.313077734505, 5100.413452452978, 5108.335916330871, 5112.335396398482, 5126.564242039412, 5078.21287700407, 5078.31442755227, 5087.0, 5121.052605268037, 5135.1526998045465, 4695.694779839317, 4853.466118726938, 4866.635002374818, 5072.26452164436, 5087.898242035157, 4884.845095180063, 4915.778789954461, 4922.778474968599, 4936.160852655022, 4941.752912354368, 4391.3193455014525, 4408.272635015219, 4425.557444255581, 4427.749360613815, 4437.134758722051, 5840.182374467578, 5874.588778785486, 5934.525237980951, 5954.404559544054, 5966.343702192756, 5614.578906582023, 5616.831495055114, 5619.157126431068, 5631.380548139701, 5658.151277308396, 6355.809325720235, 6376.585521941059, 6384.7126879290545, 6431.163948686641, 6453.515986301046, 4841.394825646794, 4858.951410485921, 4863.951360486385, 4867.172580661296, 4868.902621947576, 6399.36006399361, 6560.835979100513, 6630.204375474974, 6659.800205993828, 6669.199696036459, 4958.851234462972, 4978.228374601942, 4986.252062190628, 4995.225740010304, 5007.198848184273, 5044.747762611854, 5044.9495505045215, 5059.569936555434, 5076.162433198555, 5101.540861322499, 5458.263134476795, 5479.342478902558, 5589.608727389043, 5624.493795558419, 5632.352279487829, 6412.9679351602945, 6473.935260647333, 6493.870122597522, 6501.414872661483, 6505.024246362988, 1730.230047628793, 1735.2972046321008, 1746.9081823860088, 1748.9737653934947, 1768.7700598922058, 1171.753931674358, 1215.8601760797621, 1223.159145486038, 1223.3332833605707, 1254.5985284708806, 5532.114861622121, 5563.860903477445, 5592.748326325325, 5597.272354593877, 5620.325560932714, 6502.959526475741, 6524.347565243533, 6584.0, 6602.7689030883685, 6636.170478690164, 5472.945270547243, 5480.780768769284, 5540.667559946416, 5571.721413929287, 5599.300087489064, 3414.9317013660084, 3423.4936627883653, 3437.9484307735406, 3445.3815100523784, 3471.600765911902, 6275.3724627536885, 6311.980166346817, 6343.238811342669, 6350.157854773619, 6355.523335749837, 6461.0, 6627.879078694771, 6657.367550082734, 6705.865882682319, 6760.695768690421, 5899.380565040695, 6214.533909956771, 6268.555263447259, 6358.364163583605, 6366.745330186834, 6403.775867844603, 6495.415412612888, 6521.771737989147, 6538.803835884931, 6554.606723596599, 6375.6174629522375, 6378.266499352449, 6383.904241436289, 6468.188907106018, 6487.675616219264, 6121.47967422774, 6154.737699267062, 6236.906446403217, 6253.218347706536, 6253.435541741163, 4909.5090490950615, 4912.7543622818, 4921.4832442593015, 4933.55597996182, 4970.502949705001, 6162.599431037148, 6366.0, 6400.23197216337, 6445.613263204223, 6478.622743123102, 5978.222831032112, 6164.291106522628, 6214.564980451506, 6268.686565671607, 6354.364563543609, 6075.301340345917, 6207.255129384503, 6225.0, 6237.220347456568, 6293.968530157503, 6125.754969801158, 6130.570860039755, 6183.721732521957, 6214.720337584729, 6238.344973777688, 6257.529480572153, 6294.8111556653375, 6305.635386729976, 6334.1765570475545, 6336.398042185985, 6083.931463302499, 6105.206323177958, 6179.598326108789, 6221.4089661482085, 6230.669684569181], "value": 4947.907824290568, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.924441422479, 903.5843511984486, 918.7657147427406, 925.6575067225124, 926.7822061815474, 19515.70726439103, 20437.693434598492, 20582.89708551457, 20602.278920237775, 20650.0, 17903.64192716145, 18732.344367947124, 18808.43574692758, 18908.338208162717, 19138.71291930622, 907.9909200907989, 922.5018490015384, 926.3191554207652, 927.188709878856, 933.1182032978837, 957.5403806173007, 959.3476436023501, 959.4099628728317, 961.5865177973469, 964.6334392930677, 991.5339790298548, 1026.5175367577226, 1030.953607087683, 1036.1296510930817, 1038.974025649361, 1021.0963297481708, 1025.2669341420883, 1025.3386565665105, 1027.3322340478674, 1028.9794204115876, 708.3164746020116, 727.0911360799001, 731.9268073192692, 749.0150452155398, 750.1410884537174, 20368.69446958297, 20378.898105509525, 20532.794672053238, 20629.793702062936, 20670.896645516677, 21092.472688182766, 21288.36134915955, 22057.22799702019, 22102.22642207515, 22142.88928555363, 16865.747013794804, 17056.573585660335, 17130.143492825307, 17191.742123868153, 17220.311187552485, 3694.3165514379657, 3698.3527882620433, 3723.0320116769562, 3723.3298006358846, 3724.9068773280615, 135176.0, 141095.0, 142122.0, 143262.0, 144363.0, 16812.57968550796, 16933.49199524016, 17144.39994600183, 17239.3966211182, 17245.137743112795, 31013.224669382995, 31197.8440107798, 31551.84224078865, 31771.0, 31977.52033719496, 8425.95787021061, 8466.492010479391, 8483.278921291636, 8497.617607207567, 8515.616797244014, 3932.646061854447, 3973.4834471518516, 4027.154297597479, 4088.2232375848494, 4102.548719640837, 5060.569851562658, 5130.7947682093045, 5199.584033277329, 5231.29377534028, 5245.10833158364, 961.1829944547219, 961.403929563675, 975.4683697384942, 989.094978095035, 989.5893204320271, 609.6037575575823, 613.929398119213, 619.916311297969, 620.2990620598695, 639.6162302618392, 12053.939730301292, 12173.634790956285, 12201.450934707782, 12994.155379900276, 13202.801957970638, 574.130192757972, 581.8138195777395, 592.3070008090544, 601.3295175878951, 609.871926895357, 5456.727163641802, 5491.148871924858, 5515.503604675599, 5516.779328826882, 5620.241267428926, 113045.43477282561, 113683.43158284322, 118444.0, 123382.38308808398, 125165.0, 108600.0, 110294.0, 111887.0, 114138.42930785293, 114872.0, 95632.0, 99532.0, 101886.49056754669, 101941.0, 101966.99999999852, 10329.586816527255, 10554.10290125348, 10642.467876605984, 10654.467276635982, 10668.413237272025, 41589.79205103955, 41724.79137604292, 43027.35458968055, 43443.56556434395, 43780.56219437765, 53718.73140634272, 53775.193372100235, 53823.73088134534, 54136.729316354744, 55368.16947745868, 15739.0, 15871.603209919382, 15879.920600396925, 15984.0, 16116.67766644684, 17350.0, 17533.298668053645, 17546.298148073933, 17588.82411175872, 17865.821341786417, 16092.953957992693, 16099.436519722221, 16127.67744645077, 16165.110918899574, 16234.350625974828, 15087.396504139711, 15208.771868422204, 15344.309506072477, 15366.154861482279, 15390.384384624938, 14706.852931470548, 14914.850851491346, 14974.026688265229, 15137.848621513644, 15200.847991520386, 10959.287646302964, 11126.388048657402, 11354.943225283821, 11738.706532336419, 11761.0, 11611.954924056876, 11738.765224695288, 11749.471273792871, 11770.411479426166, 12030.15788894769], "value": 8803.616272585019, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1457.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 110.0, 113.0, 109.0, 117.0, 110.0, 109.0, 114.0, 109.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 123.0, 120.0, 119.0, 152.0, 125.0, 123.0, 117.0, 123.0, 131.0], "value": 125.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 162.0, 163.0, 164.0, 178.0, 168.0, 166.0, 163.0, 164.0, 167.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 80.0, 83.0, 79.0, 77.0, 75.0, 77.0, 78.0, 75.0, 80.0], "value": 79.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 81.0, 82.0, 86.0, 80.0, 88.0, 79.0, 79.0, 83.0], "value": 81.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 111.0, 115.0, 124.0, 120.0, 116.0, 119.0, 112.0], "value": 115.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 158.0, 150.0, 149.0, 147.0, 159.0, 148.0, 148.0, 148.0, 148.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 99.0, 99.0, 96.0, 94.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 52.0, 60.0, 54.0, 66.0, 54.0, 53.0, 61.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [41.0, 45.0, 39.0, 47.0, 39.0, 40.0, 41.0, 46.0, 46.0, 38.0], "value": 42.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 74.0, 78.0, 78.0, 80.0, 78.0, 79.0, 76.0, 73.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 119.0, 117.0, 111.0, 124.0, 127.0, 121.0, 115.0, 117.0], "value": 119.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 177.0, 172.0, 170.0, 172.0, 167.0, 172.0, 174.0, 170.0, 171.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 62.0, 64.0, 67.0, 65.0, 63.0, 63.0, 68.0, 65.0], "value": 65.0, "unit": "score"}]}]} 11:35:21 INFO - Return code: 0 11:35:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:35:21 INFO - # TBPL SUCCESS # 11:35:21 INFO - Running post-action listener: _package_coverage_data 11:35:21 INFO - Running post-action listener: _resource_record_post_action 11:35:21 INFO - [mozharness: 2017-09-27 18:35:21.617957Z] Finished run-tests step (success) 11:35:21 INFO - Running post-run listener: _resource_record_post_run 11:35:21 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 397312; Write bytes: 338141184; Read time: 616; Write time: 220480 11:35:21 INFO - TinderboxPrint: CPU usage
13.2% 11:35:21 INFO - TinderboxPrint: I/O read bytes / time
397,312 / 616 11:35:21 INFO - TinderboxPrint: I/O write bytes / time
338,141,184 / 220,480 11:35:21 INFO - TinderboxPrint: CPU idle
8,256.1 (86.8%) 11:35:21 INFO - TinderboxPrint: CPU user
1,197.9 (12.6%) 11:35:21 INFO - TinderboxPrint: Swap in / out
0 / 0 11:35:21 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10149888; Read time: 0; Write time: 796 11:35:21 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:35:21 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 393216; Write bytes: 327991296; Read time: 608; Write time: 219684 11:35:22 INFO - Running post-run listener: _upload_blobber_files 11:35:22 INFO - Blob upload gear active. 11:35:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:35:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:35:22 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'] 11:35:22 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 11:35:22 INFO - (blobuploader) - INFO - Open directory for files ... 11:35:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:35:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:35:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:23 INFO - (blobuploader) - INFO - Done attempting. 11:35:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:35:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:35:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:24 INFO - (blobuploader) - INFO - Done attempting. 11:35:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:35:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:35:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:31 INFO - (blobuploader) - INFO - Done attempting. 11:35:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:35:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:35:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:32 INFO - (blobuploader) - INFO - Done attempting. 11:35:32 INFO - (blobuploader) - INFO - Iteration through files over. 11:35:32 INFO - Return code: 0 11:35:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:35:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:35:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/483e6bcb271709f2354fa680250af1420153a457a4ef91f044f8506f670729708040a532115a551fa1da23d049ed6917af6c8d1c9364ff589bf213019457efa0", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcd671c241b96f06f499a6104650808a61325200ab9976f7df685df9d3ea941cc68a87199591a58e98c63fa0efd7e88a3a464f5a7d6cf3ca5b740ed88da38c91", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3404dc161d12fd1568382c9d2ff8d1708b2e468b00d68f6a53409994e5d5b196a1c849936afd9fe048f77ad93fc06fa7e2b15403efababf2b265eec0ba8f394d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36671552970b0840ad85b962f937b3453e2206836de3133ba8240570ede264f226f568e620d8b2b801fa90ddf64cb7b737467a24d16e0a2d89f4f54b0f02ef5a"} 11:35:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:35:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:35:32 INFO - Contents: 11:35:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/483e6bcb271709f2354fa680250af1420153a457a4ef91f044f8506f670729708040a532115a551fa1da23d049ed6917af6c8d1c9364ff589bf213019457efa0", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcd671c241b96f06f499a6104650808a61325200ab9976f7df685df9d3ea941cc68a87199591a58e98c63fa0efd7e88a3a464f5a7d6cf3ca5b740ed88da38c91", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3404dc161d12fd1568382c9d2ff8d1708b2e468b00d68f6a53409994e5d5b196a1c849936afd9fe048f77ad93fc06fa7e2b15403efababf2b265eec0ba8f394d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36671552970b0840ad85b962f937b3453e2206836de3133ba8240570ede264f226f568e620d8b2b801fa90ddf64cb7b737467a24d16e0a2d89f4f54b0f02ef5a"} 11:35:32 INFO - Running post-run listener: copy_logs_to_upload_dir 11:35:32 INFO - Copying logs to upload dir... 11:35:32 INFO - mkdir: /builds/slave/test/build/upload/logs 11:35:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.035509 ========= master_lag: -0.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-27 11:35:32.504253) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 11:35:32.512202) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/483e6bcb271709f2354fa680250af1420153a457a4ef91f044f8506f670729708040a532115a551fa1da23d049ed6917af6c8d1c9364ff589bf213019457efa0", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcd671c241b96f06f499a6104650808a61325200ab9976f7df685df9d3ea941cc68a87199591a58e98c63fa0efd7e88a3a464f5a7d6cf3ca5b740ed88da38c91", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3404dc161d12fd1568382c9d2ff8d1708b2e468b00d68f6a53409994e5d5b196a1c849936afd9fe048f77ad93fc06fa7e2b15403efababf2b265eec0ba8f394d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36671552970b0840ad85b962f937b3453e2206836de3133ba8240570ede264f226f568e620d8b2b801fa90ddf64cb7b737467a24d16e0a2d89f4f54b0f02ef5a"} build_url:https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011480 build_url: 'https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/483e6bcb271709f2354fa680250af1420153a457a4ef91f044f8506f670729708040a532115a551fa1da23d049ed6917af6c8d1c9364ff589bf213019457efa0", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcd671c241b96f06f499a6104650808a61325200ab9976f7df685df9d3ea941cc68a87199591a58e98c63fa0efd7e88a3a464f5a7d6cf3ca5b740ed88da38c91", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3404dc161d12fd1568382c9d2ff8d1708b2e468b00d68f6a53409994e5d5b196a1c849936afd9fe048f77ad93fc06fa7e2b15403efababf2b265eec0ba8f394d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36671552970b0840ad85b962f937b3453e2206836de3133ba8240570ede264f226f568e620d8b2b801fa90ddf64cb7b737467a24d16e0a2d89f4f54b0f02ef5a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 11:35:32.542492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:35:32.542817) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1506535928.194594-1411638271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004619 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:35:32.625669) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 11:35:32.629016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 11:35:32.629342) ========= ========= Total master_lag: -0.10 =========