builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-078 starttime: 1508773098.63 results: success (0) revision: 9e21926958600c34dcdfec9a58986df3d7d41759 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-23 08:38:18.633714) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-23 08:38:18.634486) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-23 08:38:18.634754) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-23 08:38:18.685710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-23 08:38:18.685975) ========= 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=dac658600622fd96716c9acf000001b3-1508773097.602874-464651074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-23 08:38:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2017-10-23 08:38:18 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.154555 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-23 08:38:18.859781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-23 08:38:18.860106) ========= 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=dac658600622fd96716c9acf000001b3-1508773097.602874-464651074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017962 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-23 08:38:18.915917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-23 08:38:18.916295) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9e21926958600c34dcdfec9a58986df3d7d41759 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9e21926958600c34dcdfec9a58986df3d7d41759 --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=dac658600622fd96716c9acf000001b3-1508773097.602874-464651074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-23 08:38:18,927 truncating revision to first 12 chars 2017-10-23 08:38:18,927 Setting DEBUG logging. 2017-10-23 08:38:18,927 attempt 1/10 2017-10-23 08:38:18,927 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9e2192695860?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-23 08:38:19,423 unpacking tar archive at: mozilla-beta-9e2192695860/testing/mozharness/ program finished with exit code 0 elapsedTime=0.828523 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-23 08:38:19.770092) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-23 08:38:19.770411) ========= script_repo_revision: 9e21926958600c34dcdfec9a58986df3d7d41759 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-23 08:38:19.770785) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-23 08:38:19.771063) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-23 08:38:19.785842) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-10-23 08:38:19.786252) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dac658600622fd96716c9acf000001b3-1508773097.602874-464651074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:38:19 INFO - MultiFileLogger online at 20171023 08:38:19 in /builds/slave/test 08:38:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 08:38:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:38:19 INFO - {'append_to_log': False, 08:38:19 INFO - 'base_work_dir': '/builds/slave/test', 08:38:19 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 08:38:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:38:19 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 08:38:19 INFO - 'buildbot_json_path': 'buildprops.json', 08:38:19 INFO - 'code_coverage': False, 08:38:19 INFO - 'config_files': ('talos/linux_config.py',), 08:38:19 INFO - 'default_actions': ('clobber', 08:38:19 INFO - 'read-buildbot-config', 08:38:19 INFO - 'download-and-extract', 08:38:19 INFO - 'populate-webroot', 08:38:19 INFO - 'create-virtualenv', 08:38:19 INFO - 'install', 08:38:19 INFO - 'setup-mitmproxy', 08:38:19 INFO - 'run-tests'), 08:38:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:38:19 INFO - 'disable_ccov_upload': False, 08:38:19 INFO - 'disable_stylo': False, 08:38:19 INFO - 'download_minidump_stackwalk': True, 08:38:19 INFO - 'download_symbols': 'ondemand', 08:38:19 INFO - 'enable_stylo': False, 08:38:19 INFO - 'enable_webrender': False, 08:38:19 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 08:38:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:38:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:38:19 INFO - 'gecko_profile': False, 08:38:19 INFO - 'gecko_profile_interval': 0, 08:38:19 INFO - 'installer_path': 'installer.exe', 08:38:19 INFO - 'log_level': 'info', 08:38:19 INFO - 'log_name': 'talos', 08:38:19 INFO - 'log_to_console': True, 08:38:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:38:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:38:19 INFO - 'opt_config_files': (), 08:38:19 INFO - 'pip_index': False, 08:38:19 INFO - 'suite': 'dromaeojs-e10s', 08:38:19 INFO - 'system_bits': '32', 08:38:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:38:19 INFO - 'title': 'talos-linux64-ix-078', 08:38:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:38:19 INFO - 'use_talos_json': True, 08:38:19 INFO - 'verify': 'False', 08:38:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:38:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:38:19 INFO - 'work_dir': 'build'} 08:38:19 INFO - [mozharness: 2017-10-23 15:38:19.939093Z] Running clobber step. 08:38:19 INFO - Running pre-action listener: _resource_record_pre_action 08:38:19 INFO - Running main action method: clobber 08:38:19 INFO - rmtree: /builds/slave/test/build 08:38:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:38:21 INFO - Running post-action listener: _resource_record_post_action 08:38:21 INFO - [mozharness: 2017-10-23 15:38:21.005460Z] Finished clobber step (success) 08:38:21 INFO - [mozharness: 2017-10-23 15:38:21.005559Z] Running read-buildbot-config step. 08:38:21 INFO - Running pre-action listener: _resource_record_pre_action 08:38:21 INFO - Running main action method: read_buildbot_config 08:38:21 INFO - Using buildbot properties: 08:38:21 INFO - { 08:38:21 INFO - "project": "", 08:38:21 INFO - "product": "firefox", 08:38:21 INFO - "who": "ryanvm@gmail.com", 08:38:21 INFO - "installer_path": "public/build/target.tar.bz2", 08:38:21 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:38:21 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 08:38:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 08:38:21 INFO - "stage_platform": "linux64", 08:38:21 INFO - "basedir": "/builds/slave/test", 08:38:21 INFO - "buildnumber": 146, 08:38:21 INFO - "platform": "ubuntu64_hw", 08:38:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:38:21 INFO - "slavebuilddir": "test", 08:38:21 INFO - "taskId": "Wlsug1UGQm2RB_pa71m3Ig", 08:38:21 INFO - "branch": "mozilla-beta", 08:38:21 INFO - "script_repo_revision": "production", 08:38:21 INFO - "revision": "9e21926958600c34dcdfec9a58986df3d7d41759", 08:38:21 INFO - "slavename": "talos-linux64-ix-078", 08:38:21 INFO - "repo_path": "releases/mozilla-beta" 08:38:21 INFO - } 08:38:21 INFO - Finding installer, test and symbols from parent task. 08:38:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wlsug1UGQm2RB_pa71m3Ig'}, attempt #1 08:38:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wlsug1UGQm2RB_pa71m3Ig'}, attempt #1 08:38:21 INFO - Task dependencies: Ztf7t28RTumSCBPPjw2VQw 08:38:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw'}, attempt #1 08:38:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.tar.bz2 08:38:22 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.test_packages.json 08:38:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.crashreporter-symbols.zip 08:38:22 INFO - Running post-action listener: _resource_record_post_action 08:38:22 INFO - [mozharness: 2017-10-23 15:38:22.370640Z] Finished read-buildbot-config step (success) 08:38:22 INFO - [mozharness: 2017-10-23 15:38:22.370859Z] Running download-and-extract step. 08:38:22 INFO - Running pre-action listener: _resource_record_pre_action 08:38:22 INFO - Running main action method: download_and_extract 08:38:22 INFO - mkdir: /builds/slave/test/build/tests 08:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:22 INFO - trying https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.test_packages.json 08:38:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:38:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:38:22 INFO - Downloaded 989 bytes. 08:38:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:38:22 INFO - Using the following test package requirements: 08:38:22 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:38:22 INFO - u'common': [u'target.common.tests.zip'], 08:38:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:38:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:38:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:38:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:38:22 INFO - u'mozbase': [u'target.common.tests.zip'], 08:38:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:38:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:38:22 INFO - u'web-platform': [u'target.common.tests.zip', 08:38:22 INFO - u'target.web-platform.tests.tar.gz'], 08:38:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:38:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 08:38:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.common.tests.zip 08:38:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:38:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.common.tests.zip into memory 08:38:24 INFO - Content-Length response header: 55177339 08:38:24 INFO - Bytes received: 55177339 08:38:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.talos.tests.zip 08:38:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:38:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.talos.tests.zip into memory 08:38:37 INFO - Content-Length response header: 14509096 08:38:37 INFO - Bytes received: 14509096 08:38:37 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')]} 08:38:37 INFO - trying https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.tar.bz2 08:38:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:38:39 INFO - Downloaded 53535283 bytes. 08:38:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.tar.bz2 08:38:39 INFO - mkdir: /builds/slave/test/properties 08:38:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:38:39 INFO - Writing to file /builds/slave/test/properties/build_url 08:38:39 INFO - Contents: 08:38:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.tar.bz2 08:38:39 INFO - Running post-action listener: _resource_record_post_action 08:38:39 INFO - Running post-action listener: find_tests_for_verification 08:38:39 INFO - Running post-action listener: set_extra_try_arguments 08:38:39 INFO - [mozharness: 2017-10-23 15:38:39.260833Z] Finished download-and-extract step (success) 08:38:39 INFO - [mozharness: 2017-10-23 15:38:39.260931Z] Running populate-webroot step. 08:38:39 INFO - Running pre-action listener: _resource_record_pre_action 08:38:39 INFO - Running main action method: populate_webroot 08:38:39 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:38:39 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:38:39 INFO - 'tests': ['tresize', 08:38:39 INFO - 'tcanvasmark']}, 08:38:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:38:39 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:38:39 INFO - 'tests': ['dromaeo_css', 08:38:39 INFO - 'kraken']}, 08:38:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:38:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:38:39 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:38:39 INFO - 'talos_options': ['--disable-stylo'], 08:38:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:38:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:38:39 INFO - 'tests': ['damp', 'tps']}, 08:38:39 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:38:39 INFO - 'talos_options': ['--disable-stylo'], 08:38:39 INFO - 'tests': ['damp', 'tps']}, 08:38:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:38:39 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:38:39 INFO - 'tests': ['dromaeo_dom']}, 08:38:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:38:39 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:38:39 INFO - 'tests': ['basic_compositor_video', 08:38:39 INFO - 'glvideo']}, 08:38:39 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:38:39 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:38:39 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:38:39 INFO - 'talos_options': ['--disable-stylo'], 08:38:39 INFO - 'tests': ['ts_paint_webext', 08:38:39 INFO - 'tp5o_webext']}, 08:38:39 INFO - 'other-e10s': {'tests': ['a11yr', 08:38:39 INFO - 'ts_paint', 08:38:39 INFO - 'tpaint', 08:38:39 INFO - 'sessionrestore', 08:38:39 INFO - 'sessionrestore_many_windows', 08:38:39 INFO - 'sessionrestore_no_auto_restore', 08:38:39 INFO - 'tabpaint']}, 08:38:39 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:38:39 INFO - 'tests': ['a11yr', 08:38:39 INFO - 'ts_paint', 08:38:39 INFO - 'tpaint', 08:38:39 INFO - 'sessionrestore', 08:38:39 INFO - 'sessionrestore_many_windows', 08:38:39 INFO - 'sessionrestore_no_auto_restore', 08:38:39 INFO - 'tabpaint']}, 08:38:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:38:39 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 08:38:39 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:38:39 INFO - 'tests': ['perf_reftest_singletons']}, 08:38:39 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:38:39 INFO - 'tests': ['bloom_basic']}, 08:38:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:38:39 INFO - 'tsvgr_opacity', 08:38:39 INFO - 'tart', 08:38:39 INFO - 'tscrollx', 08:38:39 INFO - 'tsvg_static']}, 08:38:39 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:38:39 INFO - 'tests': ['tsvgx', 08:38:39 INFO - 'tsvgr_opacity', 08:38:39 INFO - 'tart', 08:38:39 INFO - 'tscrollx', 08:38:39 INFO - 'tsvg_static']}, 08:38:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:38:39 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:38:39 INFO - 'talos_options': ['--disable-stylo'], 08:38:39 INFO - 'tests': ['tp5o']}, 08:38:39 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:38:39 INFO - 'talos_options': ['--mitmproxy', 08:38:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:38:39 INFO - '--firstNonBlankPaint'], 08:38:39 INFO - 'tests': ['tp6_google', 08:38:39 INFO - 'tp6_youtube', 08:38:39 INFO - 'tp6_amazon', 08:38:39 INFO - 'tp6_facebook']}, 08:38:39 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:38:39 INFO - 'talos_options': ['--disable-stylo', 08:38:39 INFO - '--mitmproxy', 08:38:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:38:39 INFO - '--firstNonBlankPaint'], 08:38:39 INFO - 'tests': ['tp6_google', 08:38:39 INFO - 'tp6_youtube', 08:38:39 INFO - 'tp6_amazon', 08:38:39 INFO - 'tp6_facebook']}, 08:38:39 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:38:39 INFO - 'talos_options': ['--stylo-threads=1', 08:38:39 INFO - '--mitmproxy', 08:38:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:38:39 INFO - '--firstNonBlankPaint'], 08:38:39 INFO - 'tests': ['tp6_google', 08:38:39 INFO - 'tp6_youtube', 08:38:39 INFO - 'tp6_amazon', 08:38:39 INFO - 'tp6_facebook']}, 08:38:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:38:39 INFO - 'talos_options': ['--xperf_path', 08:38:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:38:39 INFO - 'tests': ['tp5n']}, 08:38:39 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:38:39 INFO - 'talos_options': ['--disable-stylo', 08:38:39 INFO - '--xperf_path', 08:38:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:38:39 INFO - 'tests': ['tp5n']}}} 08:38:39 INFO - Running post-action listener: _resource_record_post_action 08:38:39 INFO - [mozharness: 2017-10-23 15:38:39.275858Z] Finished populate-webroot step (success) 08:38:39 INFO - [mozharness: 2017-10-23 15:38:39.275947Z] Running create-virtualenv step. 08:38:39 INFO - Running pre-action listener: _resource_record_pre_action 08:38:39 INFO - Running main action method: create_virtualenv 08:38:39 INFO - Creating virtualenv /builds/slave/test/build/venv 08:38:39 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:38:39 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 08:38:39 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:38:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:38:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:38:40 INFO - Installing distribute.............................................................................................................................................................................................done. 08:38:40 INFO - Installing pip...............done. 08:38:40 INFO - Return code: 0 08:38:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:38:40 INFO - Reading from file tmpfile_stdout 08:38:40 INFO - Output received: 08:38:40 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 08:38:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:38:40 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')]} 08:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:40 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')]} 08:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:40 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 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c090>, '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 0x252cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2526f90>, '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': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', '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 08:38:40 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 08:38:40 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 08:38:40 INFO - Using env: {'DISPLAY': ':0', 08:38:40 INFO - 'HOME': '/home/cltbld', 08:38:40 INFO - 'LANG': 'en_US.UTF-8', 08:38:40 INFO - 'LANGUAGE': 'en_US:en', 08:38:40 INFO - 'LOGNAME': 'cltbld', 08:38:40 INFO - 'MAIL': '/var/mail/cltbld', 08:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:40 INFO - 'MOZ_NO_REMOTE': '1', 08:38:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:40 INFO - 'NO_EM_RESTART': '1', 08:38:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:40 INFO - 'PWD': '/builds/slave/test', 08:38:40 INFO - 'SHELL': '/bin/bash', 08:38:40 INFO - 'SHLVL': '1', 08:38:40 INFO - 'TERM': 'linux', 08:38:40 INFO - 'TMOUT': '86400', 08:38:40 INFO - 'USER': 'cltbld', 08:38:40 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', 08:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:40 INFO - '_': '/tools/buildbot/bin/python'} 08:38:41 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:38:41 INFO - Downloading/unpacking pip>=1.5 08:38:41 INFO - Running setup.py egg_info for package pip 08:38:41 INFO - warning: no files found matching 'pip/cacert.pem' 08:38:41 INFO - warning: no files found matching '*.html' under directory 'docs' 08:38:41 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:38:41 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:38:41 INFO - Installing collected packages: pip 08:38:41 INFO - Found existing installation: pip 1.1 08:38:41 INFO - Uninstalling pip: 08:38:41 INFO - Successfully uninstalled pip 08:38:41 INFO - Running setup.py install for pip 08:38:41 INFO - warning: no files found matching 'pip/cacert.pem' 08:38:41 INFO - warning: no files found matching '*.html' under directory 'docs' 08:38:41 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:38:41 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:38:41 INFO - Installing pip script to /builds/slave/test/build/venv/bin 08:38:41 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 08:38:41 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 08:38:41 INFO - Successfully installed pip 08:38:41 INFO - Cleaning up... 08:38:41 INFO - Return code: 0 08:38:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c090>, '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 0x252cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2526f90>, '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': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', '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 08:38:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:38:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:38:42 INFO - Using env: {'DISPLAY': ':0', 08:38:42 INFO - 'HOME': '/home/cltbld', 08:38:42 INFO - 'LANG': 'en_US.UTF-8', 08:38:42 INFO - 'LANGUAGE': 'en_US:en', 08:38:42 INFO - 'LOGNAME': 'cltbld', 08:38:42 INFO - 'MAIL': '/var/mail/cltbld', 08:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:42 INFO - 'MOZ_NO_REMOTE': '1', 08:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:42 INFO - 'NO_EM_RESTART': '1', 08:38:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:42 INFO - 'PWD': '/builds/slave/test', 08:38:42 INFO - 'SHELL': '/bin/bash', 08:38:42 INFO - 'SHLVL': '1', 08:38:42 INFO - 'TERM': 'linux', 08:38:42 INFO - 'TMOUT': '86400', 08:38:42 INFO - 'USER': 'cltbld', 08:38:42 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', 08:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:42 INFO - '_': '/tools/buildbot/bin/python'} 08:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:42 INFO - Downloading/unpacking psutil>=3.1.1 08:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:38:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:38:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:38:43 INFO - Installing collected packages: psutil 08:38:43 INFO - Running setup.py install for psutil 08:38:43 INFO - building 'psutil._psutil_linux' extension 08:38:43 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 08:38:44 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 08:38:44 INFO - building 'psutil._psutil_posix' extension 08:38:44 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 08:38:44 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 08:38:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:38:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:38:44 INFO - Successfully installed psutil 08:38:44 INFO - Cleaning up... 08:38:45 INFO - Return code: 0 08:38:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:38: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')]} 08:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38: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')]} 08:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c090>, '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 0x252cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2526f90>, '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': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', '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 08:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:38:45 INFO - Using env: {'DISPLAY': ':0', 08:38:45 INFO - 'HOME': '/home/cltbld', 08:38:45 INFO - 'LANG': 'en_US.UTF-8', 08:38:45 INFO - 'LANGUAGE': 'en_US:en', 08:38:45 INFO - 'LOGNAME': 'cltbld', 08:38:45 INFO - 'MAIL': '/var/mail/cltbld', 08:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:45 INFO - 'MOZ_NO_REMOTE': '1', 08:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:45 INFO - 'NO_EM_RESTART': '1', 08:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:45 INFO - 'PWD': '/builds/slave/test', 08:38:45 INFO - 'SHELL': '/bin/bash', 08:38:45 INFO - 'SHLVL': '1', 08:38:45 INFO - 'TERM': 'linux', 08:38:45 INFO - 'TMOUT': '86400', 08:38:45 INFO - 'USER': 'cltbld', 08:38:45 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', 08:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:45 INFO - '_': '/tools/buildbot/bin/python'} 08:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:38:47 INFO - Installing collected packages: mozsystemmonitor 08:38:47 INFO - Running setup.py install for mozsystemmonitor 08:38:49 INFO - Successfully installed mozsystemmonitor 08:38:49 INFO - Cleaning up... 08:38:49 INFO - Return code: 0 08:38:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:49 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 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c090>, '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 0x252cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2526f90>, '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': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', '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 08:38:49 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 08:38:49 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 08:38:49 INFO - Using env: {'DISPLAY': ':0', 08:38:49 INFO - 'HOME': '/home/cltbld', 08:38:49 INFO - 'LANG': 'en_US.UTF-8', 08:38:49 INFO - 'LANGUAGE': 'en_US:en', 08:38:49 INFO - 'LOGNAME': 'cltbld', 08:38:49 INFO - 'MAIL': '/var/mail/cltbld', 08:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:49 INFO - 'MOZ_NO_REMOTE': '1', 08:38:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:49 INFO - 'NO_EM_RESTART': '1', 08:38:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:49 INFO - 'PWD': '/builds/slave/test', 08:38:49 INFO - 'SHELL': '/bin/bash', 08:38:49 INFO - 'SHLVL': '1', 08:38:49 INFO - 'TERM': 'linux', 08:38:49 INFO - 'TMOUT': '86400', 08:38:49 INFO - 'USER': 'cltbld', 08:38:49 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', 08:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:49 INFO - '_': '/tools/buildbot/bin/python'} 08:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:49 INFO - Downloading/unpacking jsonschema==2.5.1 08:38:49 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 08:38:49 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 08:38:49 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 08:38:49 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 08:38:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:38:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:50 INFO - Downloading functools32-3.2.3-2.tar.gz 08:38:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:38:50 INFO - warning: no files found matching '*.txt' 08:38:50 INFO - no previously-included directories found matching 'build' 08:38:50 INFO - no previously-included directories found matching 'dist' 08:38:50 INFO - no previously-included directories found matching '.git*' 08:38:50 INFO - Installing collected packages: jsonschema, functools32 08:38:50 INFO - Running setup.py install for functools32 08:38:50 INFO - warning: no files found matching '*.txt' 08:38:50 INFO - no previously-included directories found matching 'build' 08:38:50 INFO - no previously-included directories found matching 'dist' 08:38:50 INFO - no previously-included directories found matching '.git*' 08:38:50 INFO - Successfully installed jsonschema functools32 08:38:50 INFO - Cleaning up... 08:38:50 INFO - Return code: 0 08:38:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c090>, '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 0x252cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2526f90>, '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': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', '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 08:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:38:50 INFO - Using env: {'DISPLAY': ':0', 08:38:50 INFO - 'HOME': '/home/cltbld', 08:38:50 INFO - 'LANG': 'en_US.UTF-8', 08:38:50 INFO - 'LANGUAGE': 'en_US:en', 08:38:50 INFO - 'LOGNAME': 'cltbld', 08:38:50 INFO - 'MAIL': '/var/mail/cltbld', 08:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:50 INFO - 'MOZ_NO_REMOTE': '1', 08:38:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:50 INFO - 'NO_EM_RESTART': '1', 08:38:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:50 INFO - 'PWD': '/builds/slave/test', 08:38:50 INFO - 'SHELL': '/bin/bash', 08:38:50 INFO - 'SHLVL': '1', 08:38:50 INFO - 'TERM': 'linux', 08:38:50 INFO - 'TMOUT': '86400', 08:38:50 INFO - 'USER': 'cltbld', 08:38:50 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', 08:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:50 INFO - '_': '/tools/buildbot/bin/python'} 08:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:38:51 INFO - Cleaning up... 08:38:51 INFO - Return code: 0 08:38:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:38:51 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')]} 08:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:51 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')]} 08:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:51 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 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c090>, '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 0x252cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2526f90>, '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': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', '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 08:38:51 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 08:38:51 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 08:38:51 INFO - Using env: {'DISPLAY': ':0', 08:38:51 INFO - 'HOME': '/home/cltbld', 08:38:51 INFO - 'LANG': 'en_US.UTF-8', 08:38:51 INFO - 'LANGUAGE': 'en_US:en', 08:38:51 INFO - 'LOGNAME': 'cltbld', 08:38:51 INFO - 'MAIL': '/var/mail/cltbld', 08:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:51 INFO - 'MOZ_NO_REMOTE': '1', 08:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:51 INFO - 'NO_EM_RESTART': '1', 08:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:51 INFO - 'PWD': '/builds/slave/test', 08:38:51 INFO - 'SHELL': '/bin/bash', 08:38:51 INFO - 'SHLVL': '1', 08:38:51 INFO - 'TERM': 'linux', 08:38:51 INFO - 'TMOUT': '86400', 08:38:51 INFO - 'USER': 'cltbld', 08:38:51 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', 08:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:51 INFO - '_': '/tools/buildbot/bin/python'} 08:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:51 INFO - Downloading/unpacking blobuploader==1.2.4 08:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:38:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:38:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:38:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:53 INFO - Downloading docopt-0.6.1.tar.gz 08:38:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:38:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:38:53 INFO - Running setup.py install for blobuploader 08:38:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:38:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:38:53 INFO - Running setup.py install for requests 08:38:53 INFO - Running setup.py install for docopt 08:38:53 INFO - Successfully installed blobuploader requests docopt 08:38:53 INFO - Cleaning up... 08:38:53 INFO - Return code: 0 08:38:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:53 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 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c090>, '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 0x252cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2526f90>, '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': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', '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 08:38:53 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 08:38:53 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 08:38:53 INFO - Using env: {'DISPLAY': ':0', 08:38:53 INFO - 'HOME': '/home/cltbld', 08:38:53 INFO - 'LANG': 'en_US.UTF-8', 08:38:53 INFO - 'LANGUAGE': 'en_US:en', 08:38:53 INFO - 'LOGNAME': 'cltbld', 08:38:53 INFO - 'MAIL': '/var/mail/cltbld', 08:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:53 INFO - 'MOZ_NO_REMOTE': '1', 08:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:53 INFO - 'NO_EM_RESTART': '1', 08:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:53 INFO - 'PWD': '/builds/slave/test', 08:38:53 INFO - 'SHELL': '/bin/bash', 08:38:53 INFO - 'SHLVL': '1', 08:38:53 INFO - 'TERM': 'linux', 08:38:53 INFO - 'TMOUT': '86400', 08:38:53 INFO - 'USER': 'cltbld', 08:38:53 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', 08:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:53 INFO - '_': '/tools/buildbot/bin/python'} 08:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:53 INFO - Running setup.py (path:/tmp/pip-aHNFYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:53 INFO - Running setup.py (path:/tmp/pip-oUPQjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:54 INFO - Running setup.py (path:/tmp/pip-bJaQWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:54 INFO - Running setup.py (path:/tmp/pip-71CLa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:54 INFO - Running setup.py (path:/tmp/pip-c2fri5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:54 INFO - Running setup.py (path:/tmp/pip-ZV0nCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:54 INFO - Running setup.py (path:/tmp/pip-RW0RgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:54 INFO - Running setup.py (path:/tmp/pip-Dt8J9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:54 INFO - Running setup.py (path:/tmp/pip-_KVoT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:54 INFO - Running setup.py (path:/tmp/pip-cYWi4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:54 INFO - Running setup.py (path:/tmp/pip-yMjyEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:54 INFO - Running setup.py (path:/tmp/pip-LljOEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:54 INFO - Running setup.py (path:/tmp/pip-zoqP9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:54 INFO - Running setup.py (path:/tmp/pip-rdV9jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:54 INFO - Running setup.py (path:/tmp/pip-VMKRN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:54 INFO - Running setup.py (path:/tmp/pip-nzx4wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:55 INFO - Running setup.py (path:/tmp/pip-GGLRyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:38:55 INFO - Running setup.py install for manifestparser 08:38:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:38:55 INFO - Running setup.py install for mozcrash 08:38:55 INFO - Running setup.py install for mozdebug 08:38:55 INFO - Running setup.py install for mozdevice 08:38:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:38:55 INFO - Running setup.py install for mozfile 08:38:55 INFO - Running setup.py install for mozhttpd 08:38:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:38:55 INFO - Running setup.py install for mozinfo 08:38:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:38:55 INFO - Running setup.py install for mozInstall 08:38:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:38:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:38:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:38:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:38:55 INFO - Running setup.py install for mozleak 08:38:55 INFO - Running setup.py install for mozlog 08:38:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:38:56 INFO - Running setup.py install for moznetwork 08:38:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:38:56 INFO - Running setup.py install for mozprocess 08:38:56 INFO - Running setup.py install for mozprofile 08:38:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:38:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:38:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:38:56 INFO - Running setup.py install for mozrunner 08:38:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:38:56 INFO - Running setup.py install for mozscreenshot 08:38:56 INFO - Running setup.py install for moztest 08:38:56 INFO - Running setup.py install for mozversion 08:38:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:38:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:38:56 INFO - Cleaning up... 08:38:56 INFO - Return code: 0 08:38:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:56 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')]} 08:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:56 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')]} 08:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:56 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 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c090>, '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 0x252cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2526f90>, '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': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', '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 08:38:56 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 08:38:56 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 08:38:56 INFO - Using env: {'DISPLAY': ':0', 08:38:56 INFO - 'HOME': '/home/cltbld', 08:38:56 INFO - 'LANG': 'en_US.UTF-8', 08:38:56 INFO - 'LANGUAGE': 'en_US:en', 08:38:56 INFO - 'LOGNAME': 'cltbld', 08:38:56 INFO - 'MAIL': '/var/mail/cltbld', 08:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:56 INFO - 'MOZ_NO_REMOTE': '1', 08:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:56 INFO - 'NO_EM_RESTART': '1', 08:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:56 INFO - 'PWD': '/builds/slave/test', 08:38:56 INFO - 'SHELL': '/bin/bash', 08:38:56 INFO - 'SHLVL': '1', 08:38:56 INFO - 'TERM': 'linux', 08:38:56 INFO - 'TMOUT': '86400', 08:38:56 INFO - 'USER': 'cltbld', 08:38:56 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', 08:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:56 INFO - '_': '/tools/buildbot/bin/python'} 08:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:57 INFO - Running setup.py (path:/tmp/pip-McsGkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:57 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)) 08:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:57 INFO - Running setup.py (path:/tmp/pip-B6T0jI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:57 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)) 08:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:57 INFO - Running setup.py (path:/tmp/pip-B6kwOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:57 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)) 08:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:57 INFO - Running setup.py (path:/tmp/pip-UISvoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:57 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)) 08:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:57 INFO - Running setup.py (path:/tmp/pip-94xOhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:57 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)) 08:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:57 INFO - Running setup.py (path:/tmp/pip-XlwjY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:57 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)) 08:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:57 INFO - Running setup.py (path:/tmp/pip-xdl8Ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:57 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)) 08:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:57 INFO - Running setup.py (path:/tmp/pip-nB0zex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:57 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)) 08:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:57 INFO - Running setup.py (path:/tmp/pip-vwu_Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:57 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)) 08:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:57 INFO - Running setup.py (path:/tmp/pip-YpRc0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:57 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)) 08:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:57 INFO - Running setup.py (path:/tmp/pip-FNVGPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:57 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)) 08:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:57 INFO - Running setup.py (path:/tmp/pip-ZEEc_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:57 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)) 08:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:57 INFO - Running setup.py (path:/tmp/pip-Px2qkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:58 INFO - Running setup.py (path:/tmp/pip-ezuhre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:58 INFO - Running setup.py (path:/tmp/pip-WfkahJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:58 INFO - Running setup.py (path:/tmp/pip-F1RsJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:58 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)) 08:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:58 INFO - Running setup.py (path:/tmp/pip-fHyDHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:58 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)) 08:38:58 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)) 08:38:58 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)) 08:38:58 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)) 08:38:58 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)) 08:38:58 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)) 08:38:58 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)) 08:38:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:38:58 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 08:38:58 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 08:38:58 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 08:38:58 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 08:38:59 INFO - Downloading blessings-1.6.tar.gz 08:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:38:59 INFO - Installing collected packages: blessings 08:38:59 INFO - Running setup.py install for blessings 08:38:59 INFO - Successfully installed blessings 08:38:59 INFO - Cleaning up... 08:38:59 INFO - Return code: 0 08:38:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:38:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:38:59 INFO - Reading from file tmpfile_stdout 08:38:59 INFO - Current package versions: 08:38:59 INFO - argparse == 1.2.1 08:38:59 INFO - blessings == 1.6 08:38:59 INFO - blobuploader == 1.2.4 08:38:59 INFO - docopt == 0.6.1 08:38:59 INFO - functools32 == 3.2.3-2 08:38:59 INFO - jsonschema == 2.5.1 08:38:59 INFO - manifestparser == 1.1 08:38:59 INFO - mozInstall == 1.13 08:38:59 INFO - mozcrash == 1.0 08:38:59 INFO - mozdebug == 0.1 08:38:59 INFO - mozdevice == 0.51 08:38:59 INFO - mozfile == 1.2 08:38:59 INFO - mozhttpd == 0.7 08:38:59 INFO - mozinfo == 0.10 08:38:59 INFO - mozleak == 0.1 08:38:59 INFO - mozlog == 3.5 08:38:59 INFO - moznetwork == 0.27 08:38:59 INFO - mozprocess == 0.25 08:38:59 INFO - mozprofile == 0.28 08:38:59 INFO - mozrunner == 6.13 08:38:59 INFO - mozscreenshot == 0.1 08:38:59 INFO - mozsystemmonitor == 0.3 08:38:59 INFO - moztest == 0.8 08:38:59 INFO - mozversion == 1.4 08:38:59 INFO - psutil == 3.1.1 08:38:59 INFO - requests == 1.2.3 08:38:59 INFO - wsgiref == 0.1.2 08:38:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:59 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')]} 08:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:59 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')]} 08:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:59 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 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c090>, '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 0x252cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2526f90>, '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': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', '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 08:38:59 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 08:38:59 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 08:38:59 INFO - Using env: {'DISPLAY': ':0', 08:38:59 INFO - 'HOME': '/home/cltbld', 08:38:59 INFO - 'LANG': 'en_US.UTF-8', 08:38:59 INFO - 'LANGUAGE': 'en_US:en', 08:38:59 INFO - 'LOGNAME': 'cltbld', 08:38:59 INFO - 'MAIL': '/var/mail/cltbld', 08:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:59 INFO - 'MOZ_NO_REMOTE': '1', 08:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:59 INFO - 'NO_EM_RESTART': '1', 08:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:59 INFO - 'PWD': '/builds/slave/test', 08:38:59 INFO - 'SHELL': '/bin/bash', 08:38:59 INFO - 'SHLVL': '1', 08:38:59 INFO - 'TERM': 'linux', 08:38:59 INFO - 'TMOUT': '86400', 08:38:59 INFO - 'USER': 'cltbld', 08:38:59 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', 08:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:59 INFO - '_': '/tools/buildbot/bin/python'} 08:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:00 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)) 08:39:00 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)) 08:39:00 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)) 08:39:00 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)) 08:39:00 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)) 08:39:00 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)) 08:39:00 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)) 08:39:00 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)) 08:39:00 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)) 08:39:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:39:01 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)) 08:39:01 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)) 08:39:01 INFO - Installing collected packages: simplejson 08:39:01 INFO - Running setup.py install for simplejson 08:39:01 INFO - building 'simplejson._speedups' extension 08:39:01 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 08:39:02 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 08:39:02 INFO - Successfully installed simplejson 08:39:02 INFO - Cleaning up... 08:39:02 INFO - Return code: 0 08:39:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:39:02 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')]} 08:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:02 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')]} 08:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:02 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 0x21bd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c090>, '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 0x252cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2526f90>, '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': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', '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 08:39:02 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 08:39:02 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 08:39:02 INFO - Using env: {'DISPLAY': ':0', 08:39:02 INFO - 'HOME': '/home/cltbld', 08:39:02 INFO - 'LANG': 'en_US.UTF-8', 08:39:02 INFO - 'LANGUAGE': 'en_US:en', 08:39:02 INFO - 'LOGNAME': 'cltbld', 08:39:02 INFO - 'MAIL': '/var/mail/cltbld', 08:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:02 INFO - 'MOZ_NO_REMOTE': '1', 08:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:02 INFO - 'NO_EM_RESTART': '1', 08:39:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:02 INFO - 'PWD': '/builds/slave/test', 08:39:02 INFO - 'SHELL': '/bin/bash', 08:39:02 INFO - 'SHLVL': '1', 08:39:02 INFO - 'TERM': 'linux', 08:39:02 INFO - 'TMOUT': '86400', 08:39:02 INFO - 'USER': 'cltbld', 08:39:02 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', 08:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:02 INFO - '_': '/tools/buildbot/bin/python'} 08:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:39:02 INFO - Cleaning up... 08:39:02 INFO - Return code: 0 08:39:02 INFO - Running post-action listener: _resource_record_post_action 08:39:02 INFO - Running post-action listener: _start_resource_monitoring 08:39:02 INFO - Starting resource monitoring. 08:39:02 INFO - [mozharness: 2017-10-23 15:39:02.595632Z] Finished create-virtualenv step (success) 08:39:02 INFO - [mozharness: 2017-10-23 15:39:02.596145Z] Running install step. 08:39:02 INFO - Running pre-action listener: _resource_record_pre_action 08:39:02 INFO - Running main action method: install 08:39:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:02 INFO - Reading from file tmpfile_stdout 08:39:02 INFO - Detecting whether we're running mozinstall >=1.0... 08:39:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:39:02 INFO - Reading from file tmpfile_stdout 08:39:02 INFO - Output received: 08:39:02 INFO - Usage: mozinstall [options] installer 08:39:02 INFO - Options: 08:39:02 INFO - -h, --help show this help message and exit 08:39:02 INFO - -d DEST, --destination=DEST 08:39:02 INFO - Directory to install application into. [default: 08:39:02 INFO - "/builds/slave/test"] 08:39:02 INFO - --app=APP Application being installed. [default: firefox] 08:39:02 INFO - mkdir: /builds/slave/test/build/application 08:39:02 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'] 08:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:39:17 INFO - Reading from file tmpfile_stdout 08:39:17 INFO - Output received: 08:39:17 INFO - /builds/slave/test/build/application/firefox/firefox 08:39:17 INFO - Running post-action listener: _resource_record_post_action 08:39:17 INFO - [mozharness: 2017-10-23 15:39:17.632543Z] Finished install step (success) 08:39:17 INFO - [mozharness: 2017-10-23 15:39:17.632879Z] Running setup-mitmproxy step. 08:39:17 INFO - Running pre-action listener: _resource_record_pre_action 08:39:17 INFO - Running main action method: setup_mitmproxy 08:39:17 INFO - Skipping: mitmproxy is not required 08:39:17 INFO - Running post-action listener: _resource_record_post_action 08:39:17 INFO - [mozharness: 2017-10-23 15:39:17.634611Z] Finished setup-mitmproxy step (success) 08:39:17 INFO - [mozharness: 2017-10-23 15:39:17.634924Z] Running run-tests step. 08:39:17 INFO - Running pre-action listener: _resource_record_pre_action 08:39:17 INFO - Running pre-action listener: _set_gcov_prefix 08:39:17 INFO - Running main action method: run_tests 08:39:17 WARNING - Try message not found. 08:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:39:17 INFO - Python 2.7.3 08:39:17 INFO - Return code: 0 08:39:17 INFO - grabbing minidump binary from tooltool 08:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:17 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 0x252c090>, '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 0x252cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2526f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:39:17 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 08:39:17 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 08:39:17 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 08:39:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:39:17 INFO - Return code: 0 08:39:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:39:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:39:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:39:17 INFO - ENV: RUST_BACKTRACE is now full 08:39:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:39:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--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 08:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-078 --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 08:39:17 INFO - Using env: {'DISPLAY': ':0', 08:39:17 INFO - 'HOME': '/home/cltbld', 08:39:17 INFO - 'LANG': 'en_US.UTF-8', 08:39:17 INFO - 'LANGUAGE': 'en_US:en', 08:39:17 INFO - 'LOGNAME': 'cltbld', 08:39:17 INFO - 'MAIL': '/var/mail/cltbld', 08:39:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:39:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:17 INFO - 'MOZ_NO_REMOTE': '1', 08:39:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:17 INFO - 'NO_EM_RESTART': '1', 08:39:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:17 INFO - 'PWD': '/builds/slave/test', 08:39:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:39:17 INFO - 'RUST_BACKTRACE': 'full', 08:39:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:39:17 INFO - 'SHELL': '/bin/bash', 08:39:17 INFO - 'SHLVL': '1', 08:39:17 INFO - 'TERM': 'linux', 08:39:17 INFO - 'TMOUT': '86400', 08:39:17 INFO - 'USER': 'cltbld', 08:39:17 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', 08:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:17 INFO - '_': '/tools/buildbot/bin/python'} 08:39:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--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 08:39:18 INFO - mozversion application_buildid: 20171023142109 08:39:18 INFO - mozversion application_changeset: 9e21926958600c34dcdfec9a58986df3d7d41759 08:39:18 INFO - mozversion application_display_name: Firefox 08:39:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:39:18 INFO - mozversion application_name: Firefox 08:39:18 INFO - mozversion application_remotingname: firefox 08:39:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:39:18 INFO - mozversion application_vendor: Mozilla 08:39:18 INFO - mozversion application_version: 57.0 08:39:18 INFO - mozversion platform_buildid: 20171023142109 08:39:18 INFO - mozversion platform_changeset: 9e21926958600c34dcdfec9a58986df3d7d41759 08:39:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:39:18 INFO - mozversion platform_version: 57.0 08:39:18 INFO - using testdate: 1508773157 08:39:18 INFO - actual date: 1508773157 08:39:18 INFO - starting webserver on 'localhost:34059' 08:39:18 INFO - SUITE-START | Running 2 tests 08:39:18 INFO - TEST-START | dromaeo_css 08:39:18 INFO - Initialising browser for dromaeo_css test... 08:39:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34059/getInfo.html -profile /tmp/tmpdrXyt6/profile 08:39:18 INFO - TEST-INFO | started process 2025 (/builds/slave/test/build/application/firefox/firefox http://localhost:34059/getInfo.html) 08:39:23 INFO - TEST-INFO | 2025: exit 0 08:39:23 INFO - Browser initialized. 08:39:23 INFO - Running cycle 1/1 for dromaeo_css test... 08:39:23 INFO - Using env: {'DISPLAY': ':0', 08:39:23 INFO - 'HOME': '/home/cltbld', 08:39:23 INFO - 'JSGC_DISABLE_POISONING': '1', 08:39:23 INFO - 'LANG': 'en_US.UTF-8', 08:39:23 INFO - 'LANGUAGE': 'en_US:en', 08:39:23 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:39:23 INFO - 'LOGNAME': 'cltbld', 08:39:23 INFO - 'MAIL': '/var/mail/cltbld', 08:39:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:39:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:39:23 INFO - 'MOZ_CRASHREPORTER': '1', 08:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:23 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:39:23 INFO - 'MOZ_NO_REMOTE': '1', 08:39:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:39:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:23 INFO - 'NO_EM_RESTART': '1', 08:39:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:23 INFO - 'PWD': '/builds/slave/test', 08:39:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:39:23 INFO - 'RUST_BACKTRACE': 'full', 08:39:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:39:23 INFO - 'SHELL': '/bin/bash', 08:39:23 INFO - 'SHLVL': '1', 08:39:23 INFO - 'TERM': 'linux', 08:39:23 INFO - 'TMOUT': '86400', 08:39:23 INFO - 'USER': 'cltbld', 08:39:23 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', 08:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:23 INFO - '_': '/tools/buildbot/bin/python'} 08:39:23 INFO - TEST-INFO | started process 2261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdrXyt6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:24 INFO - PID 2261 | 08:39:24 INFO - PID 2261 | (/builds/slave/test/build/application/firefox/firefox:2309): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:39:24 INFO - PID 2261 | 08:39:34 INFO - PID 2261 | RSS: Main: 137998336 08:39:34 INFO - PID 2261 | 08:42:31 INFO - PID 2261 | Cycle 1(1): loaded http://localhost:34059/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34059/tests/dromaeo/cssquery-ext.html) 08:42:32 INFO - PID 2261 | RSS: Main: 144130048 08:42:32 INFO - PID 2261 | 08:45:34 INFO - PID 2261 | Cycle 1(1): loaded http://localhost:34059/tests/dromaeo/cssquery-ext.html (next: http://localhost:34059/tests/dromaeo/cssquery-jquery.html) 08:45:35 INFO - PID 2261 | RSS: Main: 143974400 08:45:35 INFO - PID 2261 | 08:48:36 INFO - PID 2261 | Cycle 1(1): loaded http://localhost:34059/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34059/tests/dromaeo/cssquery-mootools.html) 08:48:37 INFO - PID 2261 | RSS: Main: 145227776 08:48:37 INFO - PID 2261 | 08:51:38 INFO - PID 2261 | Cycle 1(1): loaded http://localhost:34059/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34059/tests/dromaeo/cssquery-prototype.html) 08:51:39 INFO - PID 2261 | RSS: Main: 144998400 08:51:39 INFO - PID 2261 | 08:54:42 INFO - PID 2261 | Cycle 1(1): loaded http://localhost:34059/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34059/tests/dromaeo/cssquery-yui.html) 08:54:42 INFO - PID 2261 | RSS: Main: 146563072 08:54:42 INFO - PID 2261 | 08:57:44 INFO - PID 2261 | Cycle 1(1): loaded http://localhost:34059/tests/dromaeo/cssquery-yui.html (next: http://localhost:34059/tests/dromaeo/cssquery-dojo.html) 08:57:44 INFO - PID 2261 | RSS: Main: 148459520 08:57:44 INFO - PID 2261 | 08:57:44 INFO - PID 2261 | __start_tp_report 08:57:44 INFO - PID 2261 | _x_x_mozilla_page_load 08:57:44 INFO - PID 2261 | _x_x_mozilla_page_load_details 08:57:44 INFO - PID 2261 | |i|pagename|runs| 08:57:44 INFO - PID 2261 | |0;dojo.html;3968.1468484275874;3992.520897492301;4000.1199736058093;4003.819828107733;4011.3381292086797;6462.903056454151;6518.837029074276;6616.338366163382;6628.602283862965;6629.204495460545;6540.411362977343;6572.145621069266;6576.375244351791;6628.370304821046;6660.866782664344;5872.7944521941745;5941.732622032019;5963.731632076567;5986.07215881539;5986.521078313746;5913.970430147843;5947.167396564484;5955.166276721241;5976.521878249751;5988.850278743044;5877.177195192677;5943.791967281146;5987.0121429964;5992;6057.000594901836;5918.792842250544;6017.7592896284095;6031.517478601701;6056.364081771395;6079.696015199266;5917.260342457193;5965.761369545213;5976.342602313742;6018.578699491038;6062.454379105858;6403.519736019817;6508.707108180096;6519.185101862267;6519.380658837403;6526.249481309663;7104.147502299757;7111.111111111111;7197.748078817269;7202.279772022808;7229.674664640052;7144.392726618192;7151.928480715178;7182.245864184238;7237.565746055254;7241.927580724231;6537.93462065378;6617.8014659560295;6670.999350097476;6672.299408562079;6731.293214212486;7330.7434239802415;7430.6284685765495;7448;7459.291367320096;7462.403007759366;6996.965015174892;7060;7060.223375428699;7113.928860711327;7131.251218622074;7164.892526612105;7171.8565628688175;7181.461390395742;7183.964080179566;7187.64061796908;7005.1944026436595;7065.258147894397;7081.752138675225;7092.007119003344;7115.181754098345;7091.89362159568;7128.607926564089;7232.20445750967;7262.019627350346;7273.199948005715;5289.418164001957;5310.203469479532;5365.141577347606;5369.892602147936;5386.272853164773;4775.307580400822;4796.112719146969;4810.783514741775;4854.63590230727;4858.58702010333;6652.96673516639;6653.2681405045405;6711.429528490035;6743.797686069328;6752.3922846944015;7129.429645628337;7134.892976605355;7148.46386521013;7197.676104575306;7232.602206878672;6578.046183303394;6663.300353462913;6703.095082163943;6712.899306510406;6724.731010759613;5980.700964951735;5992.131140984533;5996;5998.730057147439;6027;7401.222871598512;7406.444516661272;7504.887426688604;7505.812354691177;7519.172890982097;6991.265917078736;7114.85770284581;7197.4961752677855;7199.568025918462;7199.820004499929;7206.783796486114;7301.4158867289425;7308.804715229211;7411.5553066816165;7512.060992375953;7029.824254393681;7124.608146551782;7132.465065120033;7139.21468638439;7140;7015.123109611299;7065.081539400051;7139.3574578286125;7148.785536433916;7245.746398876014;6874.759383421556;6950.3049695030095;6964;6969.651517424007;6980.441564674916;6793.728250870107;6861.2795656455355;6928.1339832520935;6936.861262774817;6954.652267386509;6774.254831968381;6876.346747059021;6878.174619045746;6900.585964842126;6905.274946130584;6900.93099069023;6921.89617155733;6942.201646810681;6972.163340399185;6985.196702379291;6698.765543205965;6722.462203023649;6772.492063095386;6796.320367963164;6823.863522729617 08:57:44 INFO - PID 2261 | |1;ext.html;954.88063992001;962.7641227899161;998.7752755629984;1013.9999999999995;1016.2124353625941;45132;45710;45752.31371529426;45929;45976.54023459765;45812;46354;46361;46451.76774116133;46522;8552.486850788957;8655.95672021639;8685.609147588373;8690.04409514953;8692.217700406962;8626.87059694102;8714.651413943435;8736;8760.474371537697;8776.2101410873;8720.825583488326;8751.474911505298;8784.868226976601;8809.11908809117;8846.867296990551;8685.478871267744;8690.56547172642;8693.826123477527;8748.956255218684;8751.606177722018;8684.2184203422;8718.43330183536;8721.433106848099;8735.868961965576;8741.344399170024;40783;40838;41074;41130.383044254064;41193.382099268536;3888;3925.2738243425056;3930.6855451563806;3948.4077388391684;3959.089409435846;34581.82709086464;34641.82679086588;34715.479267811;34811.30377392438;35469;5068.898622027539;5231.136862417697;5299.284596579451;5305.73471326436;5339.385970613352;242004;242555;243749.99999999822;244444;245042;54817;54860.72569637206;54963;55002.724986374815;55010.44989550053;57110;57800.42199577951;57895.421045789;57977.42022579804;57997;17681.911590441967;17935.551611209823;17967;17992.91003545;18022.098895055457;14618.195999219932;14625.707485850224;14626.707465850623;14680.632984175267;14695.853041469662;14407.92796036034;14754.778678319833;14761.852381476048;14825.77761333581;14842.777358339634;5525.668459892419;5544.805931792368;5546.533416614616;5566.053770858883;5646.97176514123;1110.1063643766684;1115.2750712037077;1119.6249256499002;1122.3714719756963;1127.0645364347572;26288.868555657482;26440.074597389;26578.6013209802;26729.19812405631;26827.061052863057;1241.2862604002735;1243.3907385381099;1255.209218192533;1257.5975687779824;1261.1991385470292;13686.384112714753;13858.307084645727;14064.156150630995;14127.646808829655;14213.85786142146;284857;284914;285701;285753;286125;61286.69356653188;61709.38290617126;65242.34757652363;65489;65550;1519.8632123108753;1533.8542838430556;1541.6068902429809;1554.9611259718372;1571.4657016614406;31460.52809207818;31843.36313273768;32504.02487925366;32541.02376928696;32709.34581308408;44769.32846007247;45083.77458112688;45148.77425612851;45173.77413113045;45219.095618086794;252160;253065;253087;253867;254198;37464;37641.81179094197;37717.245655087296;37901.62098379091;38071.809640951615;47820.04359912852;48392.75803620959;48408;48768.756156218995;49064.50935490742;36068.45897311595;36539.26921461609;36573.08567285733;36850.63149368579;36863.81568092143;35801;35962.28075438424;36125.638743612224;36267.09332266715;37014.44478332773;43212;43345.34981975336;43402;43491;43564;36023.819880900424;36069.819650901576;36489.27021459503;36669.44995825118;36830.263394732494;26581.7341826587;26659.46681066329;26684.866575666998;26864;26949.0567830125 08:57:44 INFO - PID 2261 | |2;jquery.html;633.6519247899462;643.3405759096925;648.1015655056079;654.5941516259919;656.3567703650423;23105.884470577625;24169.637455438162;25121.874390628065;25267.873660631692;25375.873120634416;26546;26892.865535672296;26925.999999999953;26939.326516837038;26970.5954410684;6791.3887750102485;6886.035954966309;6918.584884906896;6924.4114250288785;7039.049728286667;6915.65421728914;6949.965250173742;6951.4786391020625;6962.582245065287;6963.756268530602;6829;6840.657967101625;6862.416694580967;6915.619640919747;6920.411764999981;6877.724891004354;6878.793636190897;6890.483213758963;6925;6927.618980956071;6401.519886008568;6413.102165696806;6471.5146364022885;6480.092787009822;6482.611043337415;29370.265743356373;30038.098857034325;30219.697803021907;30293.091207263817;30319;2280.6008948434123;2301.4591570980806;2301.7583153768946;2302.9193978210683;2305.8616483010906;19417.902910485358;19734.40796776099;20234.190632374688;20245.08897099634;20265.898670506554;2567.2683285263797;2639.300585344866;2645.021342103415;2656.9335766605795;2670.5326567850548;144619.27690361586;153188.234058829;159508;163748.18125909413;166148;16119.677606447805;16739.414120505724;16903.23935422909;16975.575610609834;17171.828281717022;27435.039773607827;27460.862695686792;27487.725122748918;27508.17475475739;27549.449011020068;11428.485718142703;11449;11488.655340339803;11511.884881151249;11807.40962951849;10342.482875856178;10427.739306517245;10612.946935265429;10654.840177397346;10693.625723099654;10160.593576256866;10167.644132455329;10181.167389869894;10254.28220024591;10287.639932602324;2704.2157774245643;2714.7013828478853;2734.6581677290337;2758.7517123458983;2857.5999360089604;1054.593981317183;1063.4629512096342;1073.039629531565;1074.6346242277664;1078.5847448732295;21490.462738431663;21702.457438563848;21969.890150549145;22069.448263793212;22365.776342236695;1118.608487029533;1129.2151954391618;1133.8469306643663;1140.0936255676756;1145.5017067575632;11847.933685968304;11886.762264754829;11899.762004759856;12103.273803571814;12104.757904841854;656283;666632;670242;684427;689415;130659;133127;133631.3318433421;133672.3316383412;133952;1270.6759776256995;1301.0502333296556;1343.40890008396;1375.1748950629742;1386.3761307411705;23102.306930792103;23193.304200874;23309.533809324057;23311.53376932486;23560.528789423774;68591.65704171447;69117.65441172762;69239.65380173268;70984.64507677428;71280.28719712737;84246.57876710578;84358.57820710857;84593.88515287168;85579;87408.56295718736;16029.759553606473;16276;16423.096729679983;16526.66946661084;16534.09062501574;24103.879480602485;24117;24385.26844194677;24425.755742442347;24842.25473235806;19316.227350906367;19550.706739398636;19686.212551498353;19727;20234.08946597377;17290.91354543219;17400.82599173992;17534.210960506553;17661.205245763715;17705.91147044308;19695.901520492305;20006.69956452826;20042.599148016667;20619.278325259143;20731.27440539574;16162.272697728866;16191;16199.838001619833;16273.59316017109;16295.59261018484;19625.411237662895;19670.213191472754;19884.70172947378;19904;20255.29106481325 08:57:44 INFO - PID 2261 | |3;mootools.html;1445.3495926832925;1448.724742298963;1461.2401551193386;1472.5023597794216;1521.1101505619213;17640.823591764078;18335.541611459703;18347.26610935561;18384.632307353862;18395.448136555926;17697.82302176978;17787.11064446779;17911.820881791176;17963.012034338106;17977.910110449462;2992.7755418343604;3041.7718671099647;3049.6340439147334;3059.6940305969447;3080.152957936563;2989.641243050837;3024.0474250610987;3042.4827779277466;3043.0566524377514;3043.513037913923;2961.6446026476747;3104.1618762933995;3202.59967504062;3202.631697354799;3203.615566132067;3189.3940151371166;3200.5519227308196;3211;3228.8385580721106;3229.1604182912492;2885.379643376663;2961.540961151025;2974.9702502975124;2982;3046.7562594992346;17313.220905059177;17705.7344139838;17709.114544272863;17722.556936076573;17731.822681773145;8923.73228803137;9105.180533751995;9148.908510914873;9164.312676549285;9172.403793753452;5544.390117087117;5743.770249190027;5863.9151756924675;5941.10883367494;5941.584089113764;1829.1768704083215;1839.7424360589528;1855.7216417537343;1870.1958157992058;1915.8409162456653;30547.694523054928;30590.235244118852;30873.69126308753;30880;30924.690753092407;7836.294733474015;7866.370690344758;7945.165757595485;7955.880661790078;7977.082635496992;20757.481062973246;20784.376468705963;20821.895890520755;20832.27087051946;20935.790642093383;9081.727548173565;9159.542022898828;9164.266858651292;9264.583093760797;9269.397489163182;8331.29184019353;8339.374546908884;8412.537310447862;8423.157684231528;8499.320054395634;5892.204552385373;6147.538934579924;6187.16473276102;6229.626222426669;6274.058891166362;1677.5302915183768;1733.1662731433944;1797.9550511237323;1811.3298079710592;1818.9454316370266;948;956.3735753081743;958.3770549143113;959.0170075672352;959.5490119643756;8273.751787446387;8327.20891515305;8363.58182090893;8412.411131220755;8577.92775903012;1052.1267348101057;1070.7911957168278;1111.4664960818852;1113.638067628008;1130.796456637813;5233.476652334736;5236.29310043147;5239.502247286502;5332.866678332995;5341.011912796145;25918.22245332643;25987.480250394885;26734.5989810153;26847.194584162506;26915;25635.87182064115;26336.20991370262;26821.463570728865;26859.059932902645;27068.729312706622;11883.821742673867;11936.940315298369;12013.159078864395;12037.398130093461;12093.939530302292;9701.70894873155;9891.703248902544;9910.454924979196;9996.850047249152;10141.594336226468;22178.44553886166;22514.549709006056;22527.88736056309;22537.09851605983;22728.09087636476;23387.883060584587;23495.88252058729;23783;23789.881050594635;24776;12548.309842958724;12669.986401087706;12774.36128193568;12797.29614871191;12857.485700572246;16129.67740645204;16201.270942807838;16341.918290408472;16345.509634710977;16353.836461635232;12949.158304710163;13239.404226809624;13346.933265333611;13458.730825383633;13503.527376542166;12064.215825971283;12097.395130243276;12138.696532586757;12462.189957652723;12660.11379203447;10694.946525267635;10730.785384292427;10844.67465976022;10850.511726972463;10865.891341086804;8350.83298334042;8587.484750914715;8632.525211113198;8635.738626173294;8696.652133914573;8058.758237252891;8358.749237522885;8429.831403372022;8450.830983380176;8496.787580310542 08:57:44 INFO - PID 2261 | |4;prototype.html;575.4446958684869;577.8382053025153;591.1339887065449;608.695652173913;612.58038243803;6456.709448074842;6550.934490655092;6557.704903279352;6568.671566421672;6585.485338372166;6373.745050197998;6419.390157934989;6419.775307864225;6480.449161821239;6483.448906842924;5331.466853314676;5332.280142180794;5332.546733527654;5353.384360798509;5363.302770639812;5024.949750502485;5258.395284542269;5314.441983591725;5370;5370.140777475604;5122.3084883540805;5158.329417175762;5172.456892026339;5182.637215394924;5208.880090780482;5126.410462796789;5135.7674158202135;5167.974160129213;5181.5077567631015;5202.479752024805;4702.13010593038;4703.412073490814;4721.3390125382475;4745.59662428694;4756.571908528214;6372.808815735535;6415.518836087265;6448.516361272877;6449.742300251452;6455.709493072776;6066.150738896558;6100.328963813977;6123.755049798003;6151.138840562325;6163.3836616338;6684.131062961784;6752.6961286741725;6760.729570817161;6776.052417198485;6843.62360070196;5044.344235249394;5238.228475497635;5274.945010997816;5281.947180528184;5298.867528311785;7026.191987921352;7042;7090.645467726645;7143.89284160738;7173.1349849039625;5322.175062865262;5335.519803217651;5375.946240537544;5389.946100538945;5411.2965314508865;5492.80775172867;5500.4224556420995;5500.58745594074;5507.889842203213;5516.862078448071;6039.335673076046;6080.3886969953;6122.357152499013;6126.387361263838;6145.631262124287;6862.348076932683;6880.449564034865;6881.449484041264;6936.861262774716;6961.164660240804;1831.2491878330088;1863.2546981207624;1865.4403678896276;1887.8300952914303;1896.8577356698304;1295.6825577733516;1340.3901224942822;1340.671535473815;1341.382963836646;1359.789232668938;6392.4566411854585;6406.974884018628;6418.261899881573;6421.357864213542;6511.641859697667;6885.208201056842;6917.506659137103;6922.7923162305215;6984.930150698428;6988.580685158907;6309.14826498426;6413.807585772434;6450.8064758057335;6480.351964803482;6504.317046710027;3633.2006958469096;3648.635136486383;3671.430928206079;3695.6304369562827;3703.407454807218;7311.707531698778;7358.96320518394;7361.227071157558;7362;7372.852542949111;7134.003718438268;7158.677859496231;7216.386607138347;7238.963805181046;7255.854882902312;7370.48406611532;7371.115466144097;7378.29906158914;7380.335769780853;7387.593682347415;6962.582245065312;6975.162980442379;7016.929830701832;7042.929570704432;7064.15230172362;6824.965875170592;6827.726890924506;6875.656217189021;6891.75878844238;6941.618210998444;7129.643517824192;7207.459440541876;7218.3503484686635;7258.963705181441;7276.653819043494;5384.919226211531;5389.326334208224;5405.405405405324;5433.266509021231;5462.180672899097;6665.566738162004;6813.3527314905;6895.379415852597;6938.479614028867;6985.720571177096;6571.901421478586;6720.731170753115;6733;6758.797236082925;6850.177978642595;6669.733210671713;6702.899456508254;6734.8653026940165;6770.627615481196;6817.488688348294;6651.301613330531;6741.393274605309;6771.221309549464;6779.762708305186;6788.66056697173;6788.59268443895;6798.388145066968;6840.41856442208;6882.174139103339;6928.896066559107;6545.476361890942;6679.760316246714;6711.161104861892;6722.697478613572;6739.66301684904 08:57:44 INFO - PID 2261 | |5;yui.html;985.3989066669326;996.626265150569;1002.7543251903285;1032.8295831187854;1046.30943577239;19236.519087022833;19552.80447195531;19602.019899005063;19611.5097122572;19617.411477655674;19253.807461925375;19524.414267571996;19539;19547.120379582917;19554.413367598958;1101.8402331661905;1131.2194585735856;1134.3307448605321;1134.8865113488625;1134.909207263419;1058.391424930664;1058.925875188737;1061.984070238947;1105.2263415609066;1106.4301884529473;1106.7731115121421;1117.474786850179;1119.462657924197;1122.6239209864664;1176.2824676947055;1140.2588317593547;1142.126273400849;1143.0741099709262;1148.5176225985106;1152.1128730877178;843.1105184030845;846.9661213551451;849.6728759427604;849.7833052571616;850.8255807559498;19835.900820495805;19907.601847963106;20066.398008059783;20240;20264;22608;22817.88591057051;23203.68163619423;23316.65025024626;23375.298741037797;18372.26510939561;18457.353992610195;18788.154533046047;18814.341498047503;18826.71759923602;3971.285168669667;4046.8785936421955;4046.9392959105635;4049.4533238012787;4051.392291156321;164557.17721411315;169164.15417922955;171864;172138;175523;18092.638147236983;18179.091045447676;18431.07844607764;18441.53896152607;18536;35543.11142221413;36220.27559448796;36401.45397819035;36446.817765911;36458.088547785985;8286.02838297029;8366.828643989846;8509.446885952517;8514.531700756394;8551.74344769658;4638.721676699409;4654.138984287918;4661.510541393172;4668.813247470063;4697.060587882437;5850.736716847752;5862.534366408398;5895.4399332063385;5958.731857066442;5969.940300597025;1045.5033858916954;1064.8296272596347;1067.8344856547249;1077.989220107789;1080.3949788118678;729.0813574895669;744.144234130754;747.5327920049968;751.2862780358572;766.7469734987441;12437.84075250145;12469.189502682297;13281.40233689467;13824.516141934984;14207.928960355131;759.2104211619964;760.9657565409569;763.4119637702819;767.4321002458141;785.0814546980047;6276.72754885898;6504.252011018699;6540.247871494839;6550.377714117151;6580.309067547839;149733;151589;152518;155470;160402;131691.34154329167;135771;136631;136781;139366;114528.42735786267;116384.41807790907;116981;117880;120695;12156.270623762603;12174.208676436003;12186.878131218575;12303.261804291771;12415.503379864704;57386;59406.405935940085;59767.70116149391;60240.397596025236;60762.69618652055;72659.63670181615;73906;74558.2544174573;74645.62677186579;74982.62508687422;16352.836471635132;17052.48842534726;17155.91422042882;17315.9610423375;17369.392071277445;18402;18569;18621.44135675932;18702.625947481247;18822.623547529245;17312.653746924738;17451.38920137789;17671.646567068845;17741.64516709633;17837.554061148574;17844.464666060037;17920.551986200448;18098.185581649122;18321.26714931441;18329.541761456072;16585.336586536403;16607.169641518118;16608.086555239577;16697.332106715596;16746.49760507187;12505.062120340828;12603.117781755189;12625.87374126247;12674.619761407173;12681;13619.727605448034;13970.580882573538;13972.79040814409;13990.16059036461;14034.649133771738 08:57:44 INFO - PID 2261 | __end_tp_report 08:57:44 INFO - PID 2261 | __start_cc_report 08:57:44 INFO - PID 2261 | _x_x_mozilla_cycle_collect,234 08:57:44 INFO - PID 2261 | __end_cc_report 08:57:44 INFO - PID 2261 | __startTimestamp1508774264427__endTimestamp 08:57:44 INFO - PID 2261 | 08:57:44 INFO - PID 2261 | ------- Summary: start ------- 08:57:44 INFO - PID 2261 | Number of tests: 6 08:57:44 INFO - PID 2261 | 08:57:44 INFO - PID 2261 | [#0] dojo.html Cycles:165 Average:6600.49 Median:6861.28 stddev:767.82 (11.2%) stddev-sans-first:741.89 08:57:44 INFO - PID 2261 | Values: 3968.1 3992.5 4000.1 4003.8 4011.3 6462.9 6518.8 6616.3 6628.6 6629.2 6540.4 6572.1 6576.4 6628.4 6660.9 5872.8 5941.7 5963.7 5986.1 5986.5 5914.0 5947.2 5955.2 5976.5 5988.9 5877.2 5943.8 5987.0 5992.0 6057.0 5918.8 6017.8 6031.5 6056.4 6079.7 5917.3 5965.8 5976.3 6018.6 6062.5 6403.5 6508.7 6519.2 6519.4 6526.2 7104.1 7111.1 7197.7 7202.3 7229.7 7144.4 7151.9 7182.2 7237.6 7241.9 6537.9 6617.8 6671.0 6672.3 6731.3 7330.7 7430.6 7448.0 7459.3 7462.4 6997.0 7060.0 7060.2 7113.9 7131.3 7164.9 7171.9 7181.5 7184.0 7187.6 7005.2 7065.3 7081.8 7092.0 7115.2 7091.9 7128.6 7232.2 7262.0 7273.2 5289.4 5310.2 5365.1 5369.9 5386.3 4775.3 4796.1 4810.8 4854.6 4858.6 6653.0 6653.3 6711.4 6743.8 6752.4 7129.4 7134.9 7148.5 7197.7 7232.6 6578.0 6663.3 6703.1 6712.9 6724.7 5980.7 5992.1 5996.0 5998.7 6027.0 7401.2 7406.4 7504.9 7505.8 7519.2 6991.3 7114.9 7197.5 7199.6 7199.8 7206.8 7301.4 7308.8 7411.6 7512.1 7029.8 7124.6 7132.5 7139.2 7140.0 7015.1 7065.1 7139.4 7148.8 7245.7 6874.8 6950.3 6964.0 6969.7 6980.4 6793.7 6861.3 6928.1 6936.9 6954.7 6774.3 6876.3 6878.2 6900.6 6905.3 6900.9 6921.9 6942.2 6972.2 6985.2 6698.8 6722.5 6772.5 6796.3 6823.9 08:57:44 INFO - PID 2261 | 08:57:44 INFO - PID 2261 | [#1] ext.html Cycles:180 Average:45019.75 Median:37986.72 stddev:67910.07 (178.8%) stddev-sans-first:68019.98 08:57:44 INFO - PID 2261 | Values: 954.9 962.8 998.8 1014.0 1016.2 45132.0 45710.0 45752.3 45929.0 45976.5 45812.0 46354.0 46361.0 46451.8 46522.0 8552.5 8656.0 8685.6 8690.0 8692.2 8626.9 8714.7 8736.0 8760.5 8776.2 8720.8 8751.5 8784.9 8809.1 8846.9 8685.5 8690.6 8693.8 8749.0 8751.6 8684.2 8718.4 8721.4 8735.9 8741.3 40783.0 40838.0 41074.0 41130.4 41193.4 3888.0 3925.3 3930.7 3948.4 3959.1 34581.8 34641.8 34715.5 34811.3 35469.0 5068.9 5231.1 5299.3 5305.7 5339.4 242004.0 242555.0 243750.0 244444.0 245042.0 54817.0 54860.7 54963.0 55002.7 55010.4 57110.0 57800.4 57895.4 57977.4 57997.0 17681.9 17935.6 17967.0 17992.9 18022.1 14618.2 14625.7 14626.7 14680.6 14695.9 14407.9 14754.8 14761.9 14825.8 14842.8 5525.7 5544.8 5546.5 5566.1 5647.0 1110.1 1115.3 1119.6 1122.4 1127.1 26288.9 26440.1 26578.6 26729.2 26827.1 1241.3 1243.4 1255.2 1257.6 1261.2 13686.4 13858.3 14064.2 14127.6 14213.9 284857.0 284914.0 285701.0 285753.0 286125.0 61286.7 61709.4 65242.3 65489.0 65550.0 1519.9 1533.9 1541.6 1555.0 1571.5 31460.5 31843.4 32504.0 32541.0 32709.3 44769.3 45083.8 45148.8 45173.8 45219.1 252160.0 253065.0 253087.0 253867.0 254198.0 37464.0 37641.8 37717.2 37901.6 38071.8 47820.0 48392.8 48408.0 48768.8 49064.5 36068.5 36539.3 36573.1 36850.6 36863.8 35801.0 35962.3 36125.6 36267.1 37014.4 43212.0 43345.3 43402.0 43491.0 43564.0 36023.8 36069.8 36489.3 36669.4 36830.3 26581.7 26659.5 26684.9 26864.0 26949.1 08:57:44 INFO - PID 2261 | 08:57:44 INFO - PID 2261 | [#2] jquery.html Cycles:180 Average:42621.99 Median:2291.03 stddev:112235.34 (4898.9%) stddev-sans-first:112505.91 08:57:44 INFO - PID 2261 | Values: 633.7 643.3 648.1 654.6 656.4 23105.9 24169.6 25121.9 25267.9 25375.9 26546.0 26892.9 26926.0 26939.3 26970.6 6791.4 6886.0 6918.6 6924.4 7039.0 6915.7 6950.0 6951.5 6962.6 6963.8 6829.0 6840.7 6862.4 6915.6 6920.4 6877.7 6878.8 6890.5 6925.0 6927.6 6401.5 6413.1 6471.5 6480.1 6482.6 29370.3 30038.1 30219.7 30293.1 30319.0 2280.6 2301.5 2301.8 2302.9 2305.9 19417.9 19734.4 20234.2 20245.1 20265.9 2567.3 2639.3 2645.0 2656.9 2670.5 144619.3 153188.2 159508.0 163748.2 166148.0 16119.7 16739.4 16903.2 16975.6 17171.8 27435.0 27460.9 27487.7 27508.2 27549.4 11428.5 11449.0 11488.7 11511.9 11807.4 10342.5 10427.7 10612.9 10654.8 10693.6 10160.6 10167.6 10181.2 10254.3 10287.6 2704.2 2714.7 2734.7 2758.8 2857.6 1054.6 1063.5 1073.0 1074.6 1078.6 21490.5 21702.5 21969.9 22069.4 22365.8 1118.6 1129.2 1133.8 1140.1 1145.5 11847.9 11886.8 11899.8 12103.3 12104.8 656283.0 666632.0 670242.0 684427.0 689415.0 130659.0 133127.0 133631.3 133672.3 133952.0 1270.7 1301.1 1343.4 1375.2 1386.4 23102.3 23193.3 23309.5 23311.5 23560.5 68591.7 69117.7 69239.7 70984.6 71280.3 84246.6 84358.6 84593.9 85579.0 87408.6 16029.8 16276.0 16423.1 16526.7 16534.1 24103.9 24117.0 24385.3 24425.8 24842.3 19316.2 19550.7 19686.2 19727.0 20234.1 17290.9 17400.8 17534.2 17661.2 17705.9 19695.9 20006.7 20042.6 20619.3 20731.3 16162.3 16191.0 16199.8 16273.6 16295.6 19625.4 19670.2 19884.7 19904.0 20255.3 08:57:44 INFO - PID 2261 | 08:57:44 INFO - PID 2261 | [#3] mootools.html Cycles:180 Average:10880.56 Median:14977.05 stddev:8098.49 (54.1%) stddev-sans-first:8090.19 08:57:44 INFO - PID 2261 | Values: 1445.3 1448.7 1461.2 1472.5 1521.1 17640.8 18335.5 18347.3 18384.6 18395.4 17697.8 17787.1 17911.8 17963.0 17977.9 2992.8 3041.8 3049.6 3059.7 3080.2 2989.6 3024.0 3042.5 3043.1 3043.5 2961.6 3104.2 3202.6 3202.6 3203.6 3189.4 3200.6 3211.0 3228.8 3229.2 2885.4 2961.5 2975.0 2982.0 3046.8 17313.2 17705.7 17709.1 17722.6 17731.8 8923.7 9105.2 9148.9 9164.3 9172.4 5544.4 5743.8 5863.9 5941.1 5941.6 1829.2 1839.7 1855.7 1870.2 1915.8 30547.7 30590.2 30873.7 30880.0 30924.7 7836.3 7866.4 7945.2 7955.9 7977.1 20757.5 20784.4 20821.9 20832.3 20935.8 9081.7 9159.5 9164.3 9264.6 9269.4 8331.3 8339.4 8412.5 8423.2 8499.3 5892.2 6147.5 6187.2 6229.6 6274.1 1677.5 1733.2 1798.0 1811.3 1818.9 948.0 956.4 958.4 959.0 959.5 8273.8 8327.2 8363.6 8412.4 8577.9 1052.1 1070.8 1111.5 1113.6 1130.8 5233.5 5236.3 5239.5 5332.9 5341.0 25918.2 25987.5 26734.6 26847.2 26915.0 25635.9 26336.2 26821.5 26859.1 27068.7 11883.8 11936.9 12013.2 12037.4 12093.9 9701.7 9891.7 9910.5 9996.9 10141.6 22178.4 22514.5 22527.9 22537.1 22728.1 23387.9 23495.9 23783.0 23789.9 24776.0 12548.3 12670.0 12774.4 12797.3 12857.5 16129.7 16201.3 16341.9 16345.5 16353.8 12949.2 13239.4 13346.9 13458.7 13503.5 12064.2 12097.4 12138.7 12462.2 12660.1 10694.9 10730.8 10844.7 10850.5 10865.9 8350.8 8587.5 8632.5 8635.7 8696.7 8058.8 8358.7 8429.8 8450.8 8496.8 08:57:44 INFO - PID 2261 | 08:57:44 INFO - PID 2261 | [#4] prototype.html Cycles:180 Average:5846.66 Median:6468.53 stddev:1627.66 (25.2%) stddev-sans-first:1583.41 08:57:44 INFO - PID 2261 | Values: 575.4 577.8 591.1 608.7 612.6 6456.7 6550.9 6557.7 6568.7 6585.5 6373.7 6419.4 6419.8 6480.4 6483.4 5331.5 5332.3 5332.5 5353.4 5363.3 5024.9 5258.4 5314.4 5370.0 5370.1 5122.3 5158.3 5172.5 5182.6 5208.9 5126.4 5135.8 5168.0 5181.5 5202.5 4702.1 4703.4 4721.3 4745.6 4756.6 6372.8 6415.5 6448.5 6449.7 6455.7 6066.2 6100.3 6123.8 6151.1 6163.4 6684.1 6752.7 6760.7 6776.1 6843.6 5044.3 5238.2 5274.9 5281.9 5298.9 7026.2 7042.0 7090.6 7143.9 7173.1 5322.2 5335.5 5375.9 5389.9 5411.3 5492.8 5500.4 5500.6 5507.9 5516.9 6039.3 6080.4 6122.4 6126.4 6145.6 6862.3 6880.4 6881.4 6936.9 6961.2 1831.2 1863.3 1865.4 1887.8 1896.9 1295.7 1340.4 1340.7 1341.4 1359.8 6392.5 6407.0 6418.3 6421.4 6511.6 6885.2 6917.5 6922.8 6984.9 6988.6 6309.1 6413.8 6450.8 6480.4 6504.3 3633.2 3648.6 3671.4 3695.6 3703.4 7311.7 7359.0 7361.2 7362.0 7372.9 7134.0 7158.7 7216.4 7239.0 7255.9 7370.5 7371.1 7378.3 7380.3 7387.6 6962.6 6975.2 7016.9 7042.9 7064.2 6825.0 6827.7 6875.7 6891.8 6941.6 7129.6 7207.5 7218.4 7259.0 7276.7 5384.9 5389.3 5405.4 5433.3 5462.2 6665.6 6813.4 6895.4 6938.5 6985.7 6571.9 6720.7 6733.0 6758.8 6850.2 6669.7 6702.9 6734.9 6770.6 6817.5 6651.3 6741.4 6771.2 6779.8 6788.7 6788.6 6798.4 6840.4 6882.2 6928.9 6545.5 6679.8 6711.2 6722.7 6739.7 08:57:44 INFO - PID 2261 | 08:57:44 INFO - PID 2261 | [#5] yui.html Cycles:180 Average:29040.31 Median:18387.13 stddev:44194.74 (240.4%) stddev-sans-first:44268.52 08:57:44 INFO - PID 2261 | Values: 985.4 996.6 1002.8 1032.8 1046.3 19236.5 19552.8 19602.0 19611.5 19617.4 19253.8 19524.4 19539.0 19547.1 19554.4 1101.8 1131.2 1134.3 1134.9 1134.9 1058.4 1058.9 1062.0 1105.2 1106.4 1106.8 1117.5 1119.5 1122.6 1176.3 1140.3 1142.1 1143.1 1148.5 1152.1 843.1 847.0 849.7 849.8 850.8 19835.9 19907.6 20066.4 20240.0 20264.0 22608.0 22817.9 23203.7 23316.7 23375.3 18372.3 18457.4 18788.2 18814.3 18826.7 3971.3 4046.9 4046.9 4049.5 4051.4 164557.2 169164.2 171864.0 172138.0 175523.0 18092.6 18179.1 18431.1 18441.5 18536.0 35543.1 36220.3 36401.5 36446.8 36458.1 8286.0 8366.8 8509.4 8514.5 8551.7 4638.7 4654.1 4661.5 4668.8 4697.1 5850.7 5862.5 5895.4 5958.7 5969.9 1045.5 1064.8 1067.8 1078.0 1080.4 729.1 744.1 747.5 751.3 766.7 12437.8 12469.2 13281.4 13824.5 14207.9 759.2 761.0 763.4 767.4 785.1 6276.7 6504.3 6540.2 6550.4 6580.3 149733.0 151589.0 152518.0 155470.0 160402.0 131691.3 135771.0 136631.0 136781.0 139366.0 114528.4 116384.4 116981.0 117880.0 120695.0 12156.3 12174.2 12186.9 12303.3 12415.5 57386.0 59406.4 59767.7 60240.4 60762.7 72659.6 73906.0 74558.3 74645.6 74982.6 16352.8 17052.5 17155.9 17316.0 17369.4 18402.0 18569.0 18621.4 18702.6 18822.6 17312.7 17451.4 17671.6 17741.6 17837.6 17844.5 17920.6 18098.2 18321.3 18329.5 16585.3 16607.2 16608.1 16697.3 16746.5 12505.1 12603.1 12625.9 12674.6 12681.0 13619.7 13970.6 13972.8 13990.2 14034.6 08:57:44 INFO - PID 2261 | -------- Summary: end -------- 08:57:44 INFO - PID 2261 | 08:57:44 INFO - TEST-INFO | 2261: exit 0 08:57:45 INFO - TEST-OK | dromaeo_css | took 1107011ms 08:57:45 INFO - TEST-START | kraken 08:57:45 INFO - Initialising browser for kraken test... 08:57:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34059/getInfo.html -profile /tmp/tmpYyooN0/profile 08:57:45 INFO - TEST-INFO | started process 2616 (/builds/slave/test/build/application/firefox/firefox http://localhost:34059/getInfo.html) 08:57:49 INFO - TEST-INFO | 2616: exit 0 08:57:49 INFO - Browser initialized. 08:57:49 INFO - Running cycle 1/1 for kraken test... 08:57:49 INFO - Using env: {'DISPLAY': ':0', 08:57:49 INFO - 'HOME': '/home/cltbld', 08:57:49 INFO - 'JSGC_DISABLE_POISONING': '1', 08:57:49 INFO - 'LANG': 'en_US.UTF-8', 08:57:49 INFO - 'LANGUAGE': 'en_US:en', 08:57:49 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:57:49 INFO - 'LOGNAME': 'cltbld', 08:57:49 INFO - 'MAIL': '/var/mail/cltbld', 08:57:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:57:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:57:49 INFO - 'MOZ_CRASHREPORTER': '1', 08:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:49 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:57:49 INFO - 'MOZ_NO_REMOTE': '1', 08:57:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:49 INFO - 'NO_EM_RESTART': '1', 08:57:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:49 INFO - 'PWD': '/builds/slave/test', 08:57:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:57:49 INFO - 'RUST_BACKTRACE': 'full', 08:57:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:57:49 INFO - 'SHELL': '/bin/bash', 08:57:49 INFO - 'SHLVL': '1', 08:57:49 INFO - 'TERM': 'linux', 08:57:49 INFO - 'TMOUT': '86400', 08:57:49 INFO - 'USER': 'cltbld', 08:57:49 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1508773097.602874-464651074', 08:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:49 INFO - '_': '/tools/buildbot/bin/python'} 08:57:49 INFO - TEST-INFO | started process 2938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYyooN0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:50 INFO - PID 2938 | 08:57:50 INFO - PID 2938 | (/builds/slave/test/build/application/firefox/firefox:3036): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:57:50 INFO - PID 2938 | 08:58:00 INFO - PID 2938 | RSS: Main: 143327232 08:58:00 INFO - PID 2938 | 08:58:03 INFO - PID 2938 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34059/tests/kraken/driver.html?testName=audio-beat-detection) 08:58:04 INFO - PID 2938 | RSS: Main: 149159936 08:58:04 INFO - PID 2938 | 08:58:06 INFO - PID 2938 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34059/tests/kraken/driver.html?testName=audio-dft) 08:58:07 INFO - PID 2938 | RSS: Main: 149753856 08:58:07 INFO - PID 2938 | 08:58:10 INFO - PID 2938 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34059/tests/kraken/driver.html?testName=audio-fft) 08:58:10 INFO - PID 2938 | RSS: Main: 151293952 08:58:10 INFO - PID 2938 | 08:58:12 INFO - PID 2938 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34059/tests/kraken/driver.html?testName=audio-oscillator) 08:58:13 INFO - PID 2938 | RSS: Main: 151195648 08:58:13 INFO - PID 2938 | 08:58:15 INFO - PID 2938 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34059/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:58:16 INFO - PID 2938 | RSS: Main: 150667264 08:58:16 INFO - PID 2938 | 08:58:19 INFO - PID 2938 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34059/tests/kraken/driver.html?testName=imaging-darkroom) 08:58:19 INFO - PID 2938 | RSS: Main: 150818816 08:58:19 INFO - PID 2938 | 08:58:23 INFO - PID 2938 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34059/tests/kraken/driver.html?testName=imaging-desaturate) 08:58:23 INFO - PID 2938 | RSS: Main: 153370624 08:58:23 INFO - PID 2938 | 08:58:26 INFO - PID 2938 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34059/tests/kraken/driver.html?testName=json-parse-financial) 08:58:27 INFO - PID 2938 | RSS: Main: 153718784 08:58:27 INFO - PID 2938 | 08:58:28 INFO - PID 2938 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34059/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:58:29 INFO - PID 2938 | RSS: Main: 153382912 08:58:29 INFO - PID 2938 | 08:58:30 INFO - PID 2938 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34059/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:58:31 INFO - PID 2938 | RSS: Main: 153169920 08:58:31 INFO - PID 2938 | 08:58:33 INFO - PID 2938 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34059/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:58:34 INFO - PID 2938 | RSS: Main: 150138880 08:58:34 INFO - PID 2938 | 08:58:36 INFO - PID 2938 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:58:37 INFO - PID 2938 | RSS: Main: 150339584 08:58:37 INFO - PID 2938 | 08:58:39 INFO - PID 2938 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:58:40 INFO - PID 2938 | RSS: Main: 150921216 08:58:40 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | Cycle 1(1): loaded http://localhost:34059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34059/tests/kraken/driver.html?testName=ai-astar) 08:58:42 INFO - PID 2938 | RSS: Main: 152805376 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | __start_tp_report 08:58:42 INFO - PID 2938 | _x_x_mozilla_page_load 08:58:42 INFO - PID 2938 | _x_x_mozilla_page_load_details 08:58:42 INFO - PID 2938 | |i|pagename|runs| 08:58:42 INFO - PID 2938 | |0;ai-astar;106;104;104;103;105;105;108;104;105;105 08:58:42 INFO - PID 2938 | |1;audio-beat-detection;115;111;110;112;111;142;115;110;109;111 08:58:42 INFO - PID 2938 | |2;audio-dft;164;165;165;163;164;163;163;166;163;163 08:58:42 INFO - PID 2938 | |3;audio-fft;74;75;72;72;72;74;74;72;73;74 08:58:42 INFO - PID 2938 | |4;audio-oscillator;77;78;77;78;77;77;77;77;77;78 08:58:42 INFO - PID 2938 | |5;imaging-gaussian-blur;114;113;113;110;113;111;114;110;113;113 08:58:42 INFO - PID 2938 | |6;imaging-darkroom;148;148;147;147;148;150;148;148;149;151 08:58:42 INFO - PID 2938 | |7;imaging-desaturate;94;94;95;93;94;94;94;94;94;94 08:58:42 INFO - PID 2938 | |8;json-parse-financial;45;46;45;44;45;44;48;46;45;43 08:58:42 INFO - PID 2938 | |9;json-stringify-tinderbox;38;38;39;37;38;38;42;37;38;38 08:58:42 INFO - PID 2938 | |10;stanford-crypto-aes;71;72;77;70;69;68;69;69;70;73 08:58:42 INFO - PID 2938 | |11;stanford-crypto-ccm;104;108;103;105;106;102;101;111;108;102 08:58:42 INFO - PID 2938 | |12;stanford-crypto-pbkdf2;163;143;144;144;143;142;143;145;154;145 08:58:42 INFO - PID 2938 | |13;stanford-crypto-sha256-iterative;62;61;57;57;58;58;58;61;59;57 08:58:42 INFO - PID 2938 | __end_tp_report 08:58:42 INFO - PID 2938 | __start_cc_report 08:58:42 INFO - PID 2938 | _x_x_mozilla_cycle_collect,695 08:58:42 INFO - PID 2938 | __end_cc_report 08:58:42 INFO - PID 2938 | __startTimestamp1508774322257__endTimestamp 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | ------- Summary: start ------- 08:58:42 INFO - PID 2938 | Number of tests: 14 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | [#0] ai-astar Cycles:10 Average:104.90 Median:105.00 stddev:1.37 (1.3%) stddev-sans-first:1.39 08:58:42 INFO - PID 2938 | Values: 106.0 104.0 104.0 103.0 105.0 105.0 108.0 104.0 105.0 105.0 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | [#1] audio-beat-detection Cycles:10 Average:114.60 Median:111.50 stddev:9.83 (8.8%) stddev-sans-first:10.43 08:58:42 INFO - PID 2938 | Values: 115.0 111.0 110.0 112.0 111.0 142.0 115.0 110.0 109.0 111.0 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 08:58:42 INFO - PID 2938 | Values: 164.0 165.0 165.0 163.0 164.0 163.0 163.0 166.0 163.0 163.0 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | [#3] audio-fft Cycles:10 Average:73.20 Median:74.00 stddev:1.14 (1.5%) stddev-sans-first:1.17 08:58:42 INFO - PID 2938 | Values: 74.0 75.0 72.0 72.0 72.0 74.0 74.0 72.0 73.0 74.0 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:77.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 08:58:42 INFO - PID 2938 | Values: 77.0 78.0 77.0 78.0 77.0 77.0 77.0 77.0 77.0 78.0 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | [#5] imaging-gaussian-blur Cycles:10 Average:112.40 Median:113.00 stddev:1.51 (1.3%) stddev-sans-first:1.48 08:58:42 INFO - PID 2938 | Values: 114.0 113.0 113.0 110.0 113.0 111.0 114.0 110.0 113.0 113.0 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:1.26 (0.9%) stddev-sans-first:1.33 08:58:42 INFO - PID 2938 | Values: 148.0 148.0 147.0 147.0 148.0 150.0 148.0 148.0 149.0 151.0 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 08:58:42 INFO - PID 2938 | Values: 94.0 94.0 95.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | [#8] json-parse-financial Cycles:10 Average:45.10 Median:45.00 stddev:1.37 (3.0%) stddev-sans-first:1.45 08:58:42 INFO - PID 2938 | Values: 45.0 46.0 45.0 44.0 45.0 44.0 48.0 46.0 45.0 43.0 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | [#9] json-stringify-tinderbox Cycles:10 Average:38.30 Median:38.00 stddev:1.42 (3.7%) stddev-sans-first:1.50 08:58:42 INFO - PID 2938 | Values: 38.0 38.0 39.0 37.0 38.0 38.0 42.0 37.0 38.0 38.0 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | [#10] stanford-crypto-aes Cycles:10 Average:70.80 Median:70.50 stddev:2.66 (3.8%) stddev-sans-first:2.82 08:58:42 INFO - PID 2938 | Values: 71.0 72.0 77.0 70.0 69.0 68.0 69.0 69.0 70.0 73.0 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | [#11] stanford-crypto-ccm Cycles:10 Average:105.00 Median:105.50 stddev:3.23 (3.1%) stddev-sans-first:3.41 08:58:42 INFO - PID 2938 | Values: 104.0 108.0 103.0 105.0 106.0 102.0 101.0 111.0 108.0 102.0 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:144.50 stddev:6.69 (4.6%) stddev-sans-first:3.60 08:58:42 INFO - PID 2938 | Values: 163.0 143.0 144.0 144.0 143.0 142.0 143.0 145.0 154.0 145.0 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.80 Median:58.50 stddev:1.87 (3.2%) stddev-sans-first:1.59 08:58:42 INFO - PID 2938 | Values: 62.0 61.0 57.0 57.0 58.0 58.0 58.0 61.0 59.0 57.0 08:58:42 INFO - PID 2938 | -------- Summary: end -------- 08:58:42 INFO - PID 2938 | 08:58:42 INFO - PID 2938 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:58:42 INFO - TEST-INFO | 2938: exit 0 08:58:42 INFO - TEST-OK | kraken | took 57912ms 08:58:42 INFO - SUITE-END | took 1164s 08:58:42 INFO - Completed test suite (00:19:24) 08:58:42 INFO - javascript benchmark 08:58:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9410.15140454411, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3968.1468484275874, 3992.520897492301, 4000.1199736058093, 4003.819828107733, 4011.3381292086797, 6462.903056454151, 6518.837029074276, 6616.338366163382, 6628.602283862965, 6629.204495460545, 6540.411362977343, 6572.145621069266, 6576.375244351791, 6628.370304821046, 6660.866782664344, 5872.7944521941745, 5941.732622032019, 5963.731632076567, 5986.07215881539, 5986.521078313746, 5913.970430147843, 5947.167396564484, 5955.166276721241, 5976.521878249751, 5988.850278743044, 5877.177195192677, 5943.791967281146, 5987.0121429964, 5992.0, 6057.000594901836, 5918.792842250544, 6017.7592896284095, 6031.517478601701, 6056.364081771395, 6079.696015199266, 5917.260342457193, 5965.761369545213, 5976.342602313742, 6018.578699491038, 6062.454379105858, 6403.519736019817, 6508.707108180096, 6519.185101862267, 6519.380658837403, 6526.249481309663, 7104.147502299757, 7111.111111111111, 7197.748078817269, 7202.279772022808, 7229.674664640052, 7144.392726618192, 7151.928480715178, 7182.245864184238, 7237.565746055254, 7241.927580724231, 6537.93462065378, 6617.8014659560295, 6670.999350097476, 6672.299408562079, 6731.293214212486, 7330.7434239802415, 7430.6284685765495, 7448.0, 7459.291367320096, 7462.403007759366, 6996.965015174892, 7060.0, 7060.223375428699, 7113.928860711327, 7131.251218622074, 7164.892526612105, 7171.8565628688175, 7181.461390395742, 7183.964080179566, 7187.64061796908, 7005.1944026436595, 7065.258147894397, 7081.752138675225, 7092.007119003344, 7115.181754098345, 7091.89362159568, 7128.607926564089, 7232.20445750967, 7262.019627350346, 7273.199948005715, 5289.418164001957, 5310.203469479532, 5365.141577347606, 5369.892602147936, 5386.272853164773, 4775.307580400822, 4796.112719146969, 4810.783514741775, 4854.63590230727, 4858.58702010333, 6652.96673516639, 6653.2681405045405, 6711.429528490035, 6743.797686069328, 6752.3922846944015, 7129.429645628337, 7134.892976605355, 7148.46386521013, 7197.676104575306, 7232.602206878672, 6578.046183303394, 6663.300353462913, 6703.095082163943, 6712.899306510406, 6724.731010759613, 5980.700964951735, 5992.131140984533, 5996.0, 5998.730057147439, 6027.0, 7401.222871598512, 7406.444516661272, 7504.887426688604, 7505.812354691177, 7519.172890982097, 6991.265917078736, 7114.85770284581, 7197.4961752677855, 7199.568025918462, 7199.820004499929, 7206.783796486114, 7301.4158867289425, 7308.804715229211, 7411.5553066816165, 7512.060992375953, 7029.824254393681, 7124.608146551782, 7132.465065120033, 7139.21468638439, 7140.0, 7015.123109611299, 7065.081539400051, 7139.3574578286125, 7148.785536433916, 7245.746398876014, 6874.759383421556, 6950.3049695030095, 6964.0, 6969.651517424007, 6980.441564674916, 6793.728250870107, 6861.2795656455355, 6928.1339832520935, 6936.861262774817, 6954.652267386509, 6774.254831968381, 6876.346747059021, 6878.174619045746, 6900.585964842126, 6905.274946130584, 6900.93099069023, 6921.89617155733, 6942.201646810681, 6972.163340399185, 6985.196702379291, 6698.765543205965, 6722.462203023649, 6772.492063095386, 6796.320367963164, 6823.863522729617], "value": 6548.813281253374, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [954.88063992001, 962.7641227899161, 998.7752755629984, 1013.9999999999995, 1016.2124353625941, 45132.0, 45710.0, 45752.31371529426, 45929.0, 45976.54023459765, 45812.0, 46354.0, 46361.0, 46451.76774116133, 46522.0, 8552.486850788957, 8655.95672021639, 8685.609147588373, 8690.04409514953, 8692.217700406962, 8626.87059694102, 8714.651413943435, 8736.0, 8760.474371537697, 8776.2101410873, 8720.825583488326, 8751.474911505298, 8784.868226976601, 8809.11908809117, 8846.867296990551, 8685.478871267744, 8690.56547172642, 8693.826123477527, 8748.956255218684, 8751.606177722018, 8684.2184203422, 8718.43330183536, 8721.433106848099, 8735.868961965576, 8741.344399170024, 40783.0, 40838.0, 41074.0, 41130.383044254064, 41193.382099268536, 3888.0, 3925.2738243425056, 3930.6855451563806, 3948.4077388391684, 3959.089409435846, 34581.82709086464, 34641.82679086588, 34715.479267811, 34811.30377392438, 35469.0, 5068.898622027539, 5231.136862417697, 5299.284596579451, 5305.73471326436, 5339.385970613352, 242004.0, 242555.0, 243749.99999999822, 244444.0, 245042.0, 54817.0, 54860.72569637206, 54963.0, 55002.724986374815, 55010.44989550053, 57110.0, 57800.42199577951, 57895.421045789, 57977.42022579804, 57997.0, 17681.911590441967, 17935.551611209823, 17967.0, 17992.91003545, 18022.098895055457, 14618.195999219932, 14625.707485850224, 14626.707465850623, 14680.632984175267, 14695.853041469662, 14407.92796036034, 14754.778678319833, 14761.852381476048, 14825.77761333581, 14842.777358339634, 5525.668459892419, 5544.805931792368, 5546.533416614616, 5566.053770858883, 5646.97176514123, 1110.1063643766684, 1115.2750712037077, 1119.6249256499002, 1122.3714719756963, 1127.0645364347572, 26288.868555657482, 26440.074597389, 26578.6013209802, 26729.19812405631, 26827.061052863057, 1241.2862604002735, 1243.3907385381099, 1255.209218192533, 1257.5975687779824, 1261.1991385470292, 13686.384112714753, 13858.307084645727, 14064.156150630995, 14127.646808829655, 14213.85786142146, 284857.0, 284914.0, 285701.0, 285753.0, 286125.0, 61286.69356653188, 61709.38290617126, 65242.34757652363, 65489.0, 65550.0, 1519.8632123108753, 1533.8542838430556, 1541.6068902429809, 1554.9611259718372, 1571.4657016614406, 31460.52809207818, 31843.36313273768, 32504.02487925366, 32541.02376928696, 32709.34581308408, 44769.32846007247, 45083.77458112688, 45148.77425612851, 45173.77413113045, 45219.095618086794, 252160.0, 253065.0, 253087.0, 253867.0, 254198.0, 37464.0, 37641.81179094197, 37717.245655087296, 37901.62098379091, 38071.809640951615, 47820.04359912852, 48392.75803620959, 48408.0, 48768.756156218995, 49064.50935490742, 36068.45897311595, 36539.26921461609, 36573.08567285733, 36850.63149368579, 36863.81568092143, 35801.0, 35962.28075438424, 36125.638743612224, 36267.09332266715, 37014.44478332773, 43212.0, 43345.34981975336, 43402.0, 43491.0, 43564.0, 36023.819880900424, 36069.819650901576, 36489.27021459503, 36669.44995825118, 36830.263394732494, 26581.7341826587, 26659.46681066329, 26684.866575666998, 26864.0, 26949.0567830125], "value": 19520.20503087482, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.6519247899462, 643.3405759096925, 648.1015655056079, 654.5941516259919, 656.3567703650423, 23105.884470577625, 24169.637455438162, 25121.874390628065, 25267.873660631692, 25375.873120634416, 26546.0, 26892.865535672296, 26925.999999999953, 26939.326516837038, 26970.5954410684, 6791.3887750102485, 6886.035954966309, 6918.584884906896, 6924.4114250288785, 7039.049728286667, 6915.65421728914, 6949.965250173742, 6951.4786391020625, 6962.582245065287, 6963.756268530602, 6829.0, 6840.657967101625, 6862.416694580967, 6915.619640919747, 6920.411764999981, 6877.724891004354, 6878.793636190897, 6890.483213758963, 6925.0, 6927.618980956071, 6401.519886008568, 6413.102165696806, 6471.5146364022885, 6480.092787009822, 6482.611043337415, 29370.265743356373, 30038.098857034325, 30219.697803021907, 30293.091207263817, 30319.0, 2280.6008948434123, 2301.4591570980806, 2301.7583153768946, 2302.9193978210683, 2305.8616483010906, 19417.902910485358, 19734.40796776099, 20234.190632374688, 20245.08897099634, 20265.898670506554, 2567.2683285263797, 2639.300585344866, 2645.021342103415, 2656.9335766605795, 2670.5326567850548, 144619.27690361586, 153188.234058829, 159508.0, 163748.18125909413, 166148.0, 16119.677606447805, 16739.414120505724, 16903.23935422909, 16975.575610609834, 17171.828281717022, 27435.039773607827, 27460.862695686792, 27487.725122748918, 27508.17475475739, 27549.449011020068, 11428.485718142703, 11449.0, 11488.655340339803, 11511.884881151249, 11807.40962951849, 10342.482875856178, 10427.739306517245, 10612.946935265429, 10654.840177397346, 10693.625723099654, 10160.593576256866, 10167.644132455329, 10181.167389869894, 10254.28220024591, 10287.639932602324, 2704.2157774245643, 2714.7013828478853, 2734.6581677290337, 2758.7517123458983, 2857.5999360089604, 1054.593981317183, 1063.4629512096342, 1073.039629531565, 1074.6346242277664, 1078.5847448732295, 21490.462738431663, 21702.457438563848, 21969.890150549145, 22069.448263793212, 22365.776342236695, 1118.608487029533, 1129.2151954391618, 1133.8469306643663, 1140.0936255676756, 1145.5017067575632, 11847.933685968304, 11886.762264754829, 11899.762004759856, 12103.273803571814, 12104.757904841854, 656283.0, 666632.0, 670242.0, 684427.0, 689415.0, 130659.0, 133127.0, 133631.3318433421, 133672.3316383412, 133952.0, 1270.6759776256995, 1301.0502333296556, 1343.40890008396, 1375.1748950629742, 1386.3761307411705, 23102.306930792103, 23193.304200874, 23309.533809324057, 23311.53376932486, 23560.528789423774, 68591.65704171447, 69117.65441172762, 69239.65380173268, 70984.64507677428, 71280.28719712737, 84246.57876710578, 84358.57820710857, 84593.88515287168, 85579.0, 87408.56295718736, 16029.759553606473, 16276.0, 16423.096729679983, 16526.66946661084, 16534.09062501574, 24103.879480602485, 24117.0, 24385.26844194677, 24425.755742442347, 24842.25473235806, 19316.227350906367, 19550.706739398636, 19686.212551498353, 19727.0, 20234.08946597377, 17290.91354543219, 17400.82599173992, 17534.210960506553, 17661.205245763715, 17705.91147044308, 19695.901520492305, 20006.69956452826, 20042.599148016667, 20619.278325259143, 20731.27440539574, 16162.272697728866, 16191.0, 16199.838001619833, 16273.59316017109, 16295.59261018484, 19625.411237662895, 19670.213191472754, 19884.70172947378, 19904.0, 20255.29106481325], "value": 13276.462155435062, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.3495926832925, 1448.724742298963, 1461.2401551193386, 1472.5023597794216, 1521.1101505619213, 17640.823591764078, 18335.541611459703, 18347.26610935561, 18384.632307353862, 18395.448136555926, 17697.82302176978, 17787.11064446779, 17911.820881791176, 17963.012034338106, 17977.910110449462, 2992.7755418343604, 3041.7718671099647, 3049.6340439147334, 3059.6940305969447, 3080.152957936563, 2989.641243050837, 3024.0474250610987, 3042.4827779277466, 3043.0566524377514, 3043.513037913923, 2961.6446026476747, 3104.1618762933995, 3202.59967504062, 3202.631697354799, 3203.615566132067, 3189.3940151371166, 3200.5519227308196, 3211.0, 3228.8385580721106, 3229.1604182912492, 2885.379643376663, 2961.540961151025, 2974.9702502975124, 2982.0, 3046.7562594992346, 17313.220905059177, 17705.7344139838, 17709.114544272863, 17722.556936076573, 17731.822681773145, 8923.73228803137, 9105.180533751995, 9148.908510914873, 9164.312676549285, 9172.403793753452, 5544.390117087117, 5743.770249190027, 5863.9151756924675, 5941.10883367494, 5941.584089113764, 1829.1768704083215, 1839.7424360589528, 1855.7216417537343, 1870.1958157992058, 1915.8409162456653, 30547.694523054928, 30590.235244118852, 30873.69126308753, 30880.0, 30924.690753092407, 7836.294733474015, 7866.370690344758, 7945.165757595485, 7955.880661790078, 7977.082635496992, 20757.481062973246, 20784.376468705963, 20821.895890520755, 20832.27087051946, 20935.790642093383, 9081.727548173565, 9159.542022898828, 9164.266858651292, 9264.583093760797, 9269.397489163182, 8331.29184019353, 8339.374546908884, 8412.537310447862, 8423.157684231528, 8499.320054395634, 5892.204552385373, 6147.538934579924, 6187.16473276102, 6229.626222426669, 6274.058891166362, 1677.5302915183768, 1733.1662731433944, 1797.9550511237323, 1811.3298079710592, 1818.9454316370266, 948.0, 956.3735753081743, 958.3770549143113, 959.0170075672352, 959.5490119643756, 8273.751787446387, 8327.20891515305, 8363.58182090893, 8412.411131220755, 8577.92775903012, 1052.1267348101057, 1070.7911957168278, 1111.4664960818852, 1113.638067628008, 1130.796456637813, 5233.476652334736, 5236.29310043147, 5239.502247286502, 5332.866678332995, 5341.011912796145, 25918.22245332643, 25987.480250394885, 26734.5989810153, 26847.194584162506, 26915.0, 25635.87182064115, 26336.20991370262, 26821.463570728865, 26859.059932902645, 27068.729312706622, 11883.821742673867, 11936.940315298369, 12013.159078864395, 12037.398130093461, 12093.939530302292, 9701.70894873155, 9891.703248902544, 9910.454924979196, 9996.850047249152, 10141.594336226468, 22178.44553886166, 22514.549709006056, 22527.88736056309, 22537.09851605983, 22728.09087636476, 23387.883060584587, 23495.88252058729, 23783.0, 23789.881050594635, 24776.0, 12548.309842958724, 12669.986401087706, 12774.36128193568, 12797.29614871191, 12857.485700572246, 16129.67740645204, 16201.270942807838, 16341.918290408472, 16345.509634710977, 16353.836461635232, 12949.158304710163, 13239.404226809624, 13346.933265333611, 13458.730825383633, 13503.527376542166, 12064.215825971283, 12097.395130243276, 12138.696532586757, 12462.189957652723, 12660.11379203447, 10694.946525267635, 10730.785384292427, 10844.67465976022, 10850.511726972463, 10865.891341086804, 8350.83298334042, 8587.484750914715, 8632.525211113198, 8635.738626173294, 8696.652133914573, 8058.758237252891, 8358.749237522885, 8429.831403372022, 8450.830983380176, 8496.787580310542], "value": 7608.731934284338, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.4446958684869, 577.8382053025153, 591.1339887065449, 608.695652173913, 612.58038243803, 6456.709448074842, 6550.934490655092, 6557.704903279352, 6568.671566421672, 6585.485338372166, 6373.745050197998, 6419.390157934989, 6419.775307864225, 6480.449161821239, 6483.448906842924, 5331.466853314676, 5332.280142180794, 5332.546733527654, 5353.384360798509, 5363.302770639812, 5024.949750502485, 5258.395284542269, 5314.441983591725, 5370.0, 5370.140777475604, 5122.3084883540805, 5158.329417175762, 5172.456892026339, 5182.637215394924, 5208.880090780482, 5126.410462796789, 5135.7674158202135, 5167.974160129213, 5181.5077567631015, 5202.479752024805, 4702.13010593038, 4703.412073490814, 4721.3390125382475, 4745.59662428694, 4756.571908528214, 6372.808815735535, 6415.518836087265, 6448.516361272877, 6449.742300251452, 6455.709493072776, 6066.150738896558, 6100.328963813977, 6123.755049798003, 6151.138840562325, 6163.3836616338, 6684.131062961784, 6752.6961286741725, 6760.729570817161, 6776.052417198485, 6843.62360070196, 5044.344235249394, 5238.228475497635, 5274.945010997816, 5281.947180528184, 5298.867528311785, 7026.191987921352, 7042.0, 7090.645467726645, 7143.89284160738, 7173.1349849039625, 5322.175062865262, 5335.519803217651, 5375.946240537544, 5389.946100538945, 5411.2965314508865, 5492.80775172867, 5500.4224556420995, 5500.58745594074, 5507.889842203213, 5516.862078448071, 6039.335673076046, 6080.3886969953, 6122.357152499013, 6126.387361263838, 6145.631262124287, 6862.348076932683, 6880.449564034865, 6881.449484041264, 6936.861262774716, 6961.164660240804, 1831.2491878330088, 1863.2546981207624, 1865.4403678896276, 1887.8300952914303, 1896.8577356698304, 1295.6825577733516, 1340.3901224942822, 1340.671535473815, 1341.382963836646, 1359.789232668938, 6392.4566411854585, 6406.974884018628, 6418.261899881573, 6421.357864213542, 6511.641859697667, 6885.208201056842, 6917.506659137103, 6922.7923162305215, 6984.930150698428, 6988.580685158907, 6309.14826498426, 6413.807585772434, 6450.8064758057335, 6480.351964803482, 6504.317046710027, 3633.2006958469096, 3648.635136486383, 3671.430928206079, 3695.6304369562827, 3703.407454807218, 7311.707531698778, 7358.96320518394, 7361.227071157558, 7362.0, 7372.852542949111, 7134.003718438268, 7158.677859496231, 7216.386607138347, 7238.963805181046, 7255.854882902312, 7370.48406611532, 7371.115466144097, 7378.29906158914, 7380.335769780853, 7387.593682347415, 6962.582245065312, 6975.162980442379, 7016.929830701832, 7042.929570704432, 7064.15230172362, 6824.965875170592, 6827.726890924506, 6875.656217189021, 6891.75878844238, 6941.618210998444, 7129.643517824192, 7207.459440541876, 7218.3503484686635, 7258.963705181441, 7276.653819043494, 5384.919226211531, 5389.326334208224, 5405.405405405324, 5433.266509021231, 5462.180672899097, 6665.566738162004, 6813.3527314905, 6895.379415852597, 6938.479614028867, 6985.720571177096, 6571.901421478586, 6720.731170753115, 6733.0, 6758.797236082925, 6850.177978642595, 6669.733210671713, 6702.899456508254, 6734.8653026940165, 6770.627615481196, 6817.488688348294, 6651.301613330531, 6741.393274605309, 6771.221309549464, 6779.762708305186, 6788.66056697173, 6788.59268443895, 6798.388145066968, 6840.41856442208, 6882.174139103339, 6928.896066559107, 6545.476361890942, 6679.760316246714, 6711.161104861892, 6722.697478613572, 6739.66301684904], "value": 5379.458518571731, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [985.3989066669326, 996.626265150569, 1002.7543251903285, 1032.8295831187854, 1046.30943577239, 19236.519087022833, 19552.80447195531, 19602.019899005063, 19611.5097122572, 19617.411477655674, 19253.807461925375, 19524.414267571996, 19539.0, 19547.120379582917, 19554.413367598958, 1101.8402331661905, 1131.2194585735856, 1134.3307448605321, 1134.8865113488625, 1134.909207263419, 1058.391424930664, 1058.925875188737, 1061.984070238947, 1105.2263415609066, 1106.4301884529473, 1106.7731115121421, 1117.474786850179, 1119.462657924197, 1122.6239209864664, 1176.2824676947055, 1140.2588317593547, 1142.126273400849, 1143.0741099709262, 1148.5176225985106, 1152.1128730877178, 843.1105184030845, 846.9661213551451, 849.6728759427604, 849.7833052571616, 850.8255807559498, 19835.900820495805, 19907.601847963106, 20066.398008059783, 20240.0, 20264.0, 22608.0, 22817.88591057051, 23203.68163619423, 23316.65025024626, 23375.298741037797, 18372.26510939561, 18457.353992610195, 18788.154533046047, 18814.341498047503, 18826.71759923602, 3971.285168669667, 4046.8785936421955, 4046.9392959105635, 4049.4533238012787, 4051.392291156321, 164557.17721411315, 169164.15417922955, 171864.0, 172138.0, 175523.0, 18092.638147236983, 18179.091045447676, 18431.07844607764, 18441.53896152607, 18536.0, 35543.11142221413, 36220.27559448796, 36401.45397819035, 36446.817765911, 36458.088547785985, 8286.02838297029, 8366.828643989846, 8509.446885952517, 8514.531700756394, 8551.74344769658, 4638.721676699409, 4654.138984287918, 4661.510541393172, 4668.813247470063, 4697.060587882437, 5850.736716847752, 5862.534366408398, 5895.4399332063385, 5958.731857066442, 5969.940300597025, 1045.5033858916954, 1064.8296272596347, 1067.8344856547249, 1077.989220107789, 1080.3949788118678, 729.0813574895669, 744.144234130754, 747.5327920049968, 751.2862780358572, 766.7469734987441, 12437.84075250145, 12469.189502682297, 13281.40233689467, 13824.516141934984, 14207.928960355131, 759.2104211619964, 760.9657565409569, 763.4119637702819, 767.4321002458141, 785.0814546980047, 6276.72754885898, 6504.252011018699, 6540.247871494839, 6550.377714117151, 6580.309067547839, 149733.0, 151589.0, 152518.0, 155470.0, 160402.0, 131691.34154329167, 135771.0, 136631.0, 136781.0, 139366.0, 114528.42735786267, 116384.41807790907, 116981.0, 117880.0, 120695.0, 12156.270623762603, 12174.208676436003, 12186.878131218575, 12303.261804291771, 12415.503379864704, 57386.0, 59406.405935940085, 59767.70116149391, 60240.397596025236, 60762.69618652055, 72659.63670181615, 73906.0, 74558.2544174573, 74645.62677186579, 74982.62508687422, 16352.836471635132, 17052.48842534726, 17155.91422042882, 17315.9610423375, 17369.392071277445, 18402.0, 18569.0, 18621.44135675932, 18702.625947481247, 18822.623547529245, 17312.653746924738, 17451.38920137789, 17671.646567068845, 17741.64516709633, 17837.554061148574, 17844.464666060037, 17920.551986200448, 18098.185581649122, 18321.26714931441, 18329.541761456072, 16585.336586536403, 16607.169641518118, 16608.086555239577, 16697.332106715596, 16746.49760507187, 12505.062120340828, 12603.117781755189, 12625.87374126247, 12674.619761407173, 12681.0, 13619.727605448034, 13970.580882573538, 13972.79040814409, 13990.16059036461, 14034.649133771738], "value": 9994.794095489357, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1353.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 104.0, 104.0, 103.0, 105.0, 105.0, 108.0, 104.0, 105.0, 105.0], "value": 104.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 110.0, 112.0, 111.0, 142.0, 115.0, 110.0, 109.0, 111.0], "value": 114.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 165.0, 163.0, 164.0, 163.0, 163.0, 166.0, 163.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 72.0, 72.0, 72.0, 74.0, 74.0, 72.0, 73.0, 74.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 78.0, 77.0, 77.0, 77.0, 77.0, 77.0, 78.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 110.0, 113.0, 111.0, 114.0, 110.0, 113.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 148.0, 150.0, 148.0, 148.0, 149.0, 151.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 46.0, 45.0, 44.0, 45.0, 44.0, 48.0, 46.0, 45.0, 43.0], "value": 45.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 39.0, 37.0, 38.0, 38.0, 42.0, 37.0, 38.0, 38.0], "value": 38.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 77.0, 70.0, 69.0, 68.0, 69.0, 69.0, 70.0, 73.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 108.0, 103.0, 105.0, 106.0, 102.0, 101.0, 111.0, 108.0, 102.0], "value": 105.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 143.0, 144.0, 144.0, 143.0, 142.0, 143.0, 145.0, 154.0, 145.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 57.0, 57.0, 58.0, 58.0, 58.0, 61.0, 59.0, 57.0], "value": 58.8, "unit": "score"}]}]} 08:58:42 INFO - Return code: 0 08:58:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:58:43 INFO - # TBPL SUCCESS # 08:58:43 INFO - Running post-action listener: _package_coverage_data 08:58:43 INFO - Running post-action listener: _resource_record_post_action 08:58:43 INFO - [mozharness: 2017-10-23 15:58:43.038815Z] Finished run-tests step (success) 08:58:43 INFO - Running post-run listener: _resource_record_post_run 08:58:43 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283426816; Read time: 12; Write time: 144564 08:58:43 INFO - TinderboxPrint: CPU usage
13.0% 08:58:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:58:43 INFO - TinderboxPrint: I/O write bytes / time
283,426,816 / 144,564 08:58:43 INFO - TinderboxPrint: CPU idle
8,180.8 (86.9%) 08:58:43 INFO - TinderboxPrint: CPU user
1,180.0 (12.5%) 08:58:43 INFO - TinderboxPrint: Swap in / out
0 / 0 08:58:43 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9150464; Read time: 0; Write time: 1584 08:58:43 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:58:43 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 0; Write bytes: 273707008; Read time: 0; Write time: 142788 08:58:43 INFO - Running post-run listener: _upload_blobber_files 08:58:43 INFO - Blob upload gear active. 08:58:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:58:43 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 08:58:43 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:58:43 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:58:44 INFO - (blobuploader) - INFO - Open directory for files ... 08:58:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:58:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:58:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:47 INFO - (blobuploader) - INFO - Done attempting. 08:58:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:58:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:58:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:48 INFO - (blobuploader) - INFO - Done attempting. 08:58:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:58:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:58:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:49 INFO - (blobuploader) - INFO - Done attempting. 08:58:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:58:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:58:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:50 INFO - (blobuploader) - INFO - Done attempting. 08:58:50 INFO - (blobuploader) - INFO - Iteration through files over. 08:58:50 INFO - Return code: 0 08:58:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:58:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:58:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a97e69e5d243dbd9753ef9c4c673e235ed7299d44bd8abeb77a7a893bbdfe44ea8a9336bbe02a4c173704998790bd6883840449b5b92397a3fee3f8fb383518b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f90c7e5c2906a7836973d89011cd36bf128ba6680ce2a0031d26e5af2c14a38c739a6504fce4007307e19b4bce25d5978fe35ed869da3a6e145e7d4fb1631636", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9b84c255aeb5b6c2fe9597d6d04ea0fa5ae54f8c1e407a639c4a0dc43b536f9b5eda6c47e282159616338f7ba685b8c4a79f73f62991511cfe212836e55bf009", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/03600190565ac42a90af32cf157e4957d455a5c0af1d13ae7ac8b03e5c60c0a066c4171dfe704fa044d277ccceff0633bdd99f446754f96ac723ce6213341a43"} 08:58:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:58:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:58:50 INFO - Contents: 08:58:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a97e69e5d243dbd9753ef9c4c673e235ed7299d44bd8abeb77a7a893bbdfe44ea8a9336bbe02a4c173704998790bd6883840449b5b92397a3fee3f8fb383518b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f90c7e5c2906a7836973d89011cd36bf128ba6680ce2a0031d26e5af2c14a38c739a6504fce4007307e19b4bce25d5978fe35ed869da3a6e145e7d4fb1631636", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9b84c255aeb5b6c2fe9597d6d04ea0fa5ae54f8c1e407a639c4a0dc43b536f9b5eda6c47e282159616338f7ba685b8c4a79f73f62991511cfe212836e55bf009", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/03600190565ac42a90af32cf157e4957d455a5c0af1d13ae7ac8b03e5c60c0a066c4171dfe704fa044d277ccceff0633bdd99f446754f96ac723ce6213341a43"} 08:58:50 INFO - Running post-run listener: copy_logs_to_upload_dir 08:58:50 INFO - Copying logs to upload dir... 08:58:50 INFO - mkdir: /builds/slave/test/build/upload/logs 08:58:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.775971 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-10-23 08:58:50.596781) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-23 08:58:50.600495) ========= 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=dac658600622fd96716c9acf000001b3-1508773097.602874-464651074 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/Mozilla-Beta-Non-PGO/sha512/a97e69e5d243dbd9753ef9c4c673e235ed7299d44bd8abeb77a7a893bbdfe44ea8a9336bbe02a4c173704998790bd6883840449b5b92397a3fee3f8fb383518b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f90c7e5c2906a7836973d89011cd36bf128ba6680ce2a0031d26e5af2c14a38c739a6504fce4007307e19b4bce25d5978fe35ed869da3a6e145e7d4fb1631636", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9b84c255aeb5b6c2fe9597d6d04ea0fa5ae54f8c1e407a639c4a0dc43b536f9b5eda6c47e282159616338f7ba685b8c4a79f73f62991511cfe212836e55bf009", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/03600190565ac42a90af32cf157e4957d455a5c0af1d13ae7ac8b03e5c60c0a066c4171dfe704fa044d277ccceff0633bdd99f446754f96ac723ce6213341a43"} build_url:https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011362 build_url: 'https://queue.taskcluster.net/v1/task/Ztf7t28RTumSCBPPjw2VQw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a97e69e5d243dbd9753ef9c4c673e235ed7299d44bd8abeb77a7a893bbdfe44ea8a9336bbe02a4c173704998790bd6883840449b5b92397a3fee3f8fb383518b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f90c7e5c2906a7836973d89011cd36bf128ba6680ce2a0031d26e5af2c14a38c739a6504fce4007307e19b4bce25d5978fe35ed869da3a6e145e7d4fb1631636", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9b84c255aeb5b6c2fe9597d6d04ea0fa5ae54f8c1e407a639c4a0dc43b536f9b5eda6c47e282159616338f7ba685b8c4a79f73f62991511cfe212836e55bf009", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/03600190565ac42a90af32cf157e4957d455a5c0af1d13ae7ac8b03e5c60c0a066c4171dfe704fa044d277ccceff0633bdd99f446754f96ac723ce6213341a43"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-23 08:58:50.630396) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-23 08:58:50.630726) ========= 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=dac658600622fd96716c9acf000001b3-1508773097.602874-464651074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-23 08:58:50.714477) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-23 08:58:50.714789) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-23 08:58:50.715103) ========= ========= Total master_lag: 0.21 =========