builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-078 starttime: 1506336565.29 results: success (0) revision: 13ce77b78e364cc952d51b959f22202502be2941 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:25.287347) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:25.287738) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:25.287999) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:25.359358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:25.359689) ========= 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-1506336406.831786-777331707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 03:49:26-- 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% 372K=0.03s 2017-09-25 03:49:26 (372 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.173965 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:25.554265) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:25.554632) ========= 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-1506336406.831786-777331707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019495 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:25.609413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 03:49:25.609755) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 13ce77b78e364cc952d51b959f22202502be2941 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 13ce77b78e364cc952d51b959f22202502be2941 --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-1506336406.831786-777331707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 03:49:26,491 truncating revision to first 12 chars 2017-09-25 03:49:26,491 Setting DEBUG logging. 2017-09-25 03:49:26,491 attempt 1/10 2017-09-25 03:49:26,491 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/13ce77b78e36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 03:49:27,232 unpacking tar archive at: mozilla-central-13ce77b78e36/testing/mozharness/ program finished with exit code 0 elapsedTime=1.064067 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 03:49:26.694995) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:26.695295) ========= script_repo_revision: 13ce77b78e364cc952d51b959f22202502be2941 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:26.695671) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:26.695940) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:26.727686) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-25 03:49:26.728003) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dac658600622fd96716c9acf000001b3-1506336406.831786-777331707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:49:27 INFO - MultiFileLogger online at 20170925 03:49:27 in /builds/slave/test 03:49:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:49:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:49:27 INFO - {'append_to_log': False, 03:49:27 INFO - 'base_work_dir': '/builds/slave/test', 03:49:27 INFO - 'blob_upload_branch': 'Firefox', 03:49:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:49:27 INFO - 'branch': 'Firefox', 03:49:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:49:27 INFO - 'code_coverage': False, 03:49:27 INFO - 'config_files': ('talos/linux_config.py',), 03:49:27 INFO - 'default_actions': ('clobber', 03:49:27 INFO - 'read-buildbot-config', 03:49:27 INFO - 'download-and-extract', 03:49:27 INFO - 'populate-webroot', 03:49:27 INFO - 'create-virtualenv', 03:49:27 INFO - 'install', 03:49:27 INFO - 'setup-mitmproxy', 03:49:27 INFO - 'run-tests'), 03:49:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:49:27 INFO - 'disable_ccov_upload': False, 03:49:27 INFO - 'disable_stylo': False, 03:49:27 INFO - 'download_minidump_stackwalk': True, 03:49:27 INFO - 'download_symbols': 'ondemand', 03:49:27 INFO - 'enable_stylo': False, 03:49:27 INFO - 'enable_webrender': False, 03:49:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:49:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:49:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:49:27 INFO - 'gecko_profile': False, 03:49:27 INFO - 'gecko_profile_interval': 0, 03:49:27 INFO - 'installer_path': 'installer.exe', 03:49:27 INFO - 'log_level': 'info', 03:49:27 INFO - 'log_name': 'talos', 03:49:27 INFO - 'log_to_console': True, 03:49:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:49:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:49:27 INFO - 'opt_config_files': (), 03:49:27 INFO - 'pip_index': False, 03:49:27 INFO - 'suite': 'dromaeojs-e10s', 03:49:27 INFO - 'system_bits': '32', 03:49:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:49:27 INFO - 'title': 'talos-linux64-ix-078', 03:49:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:49:27 INFO - 'use_talos_json': True, 03:49:27 INFO - 'verify': 'False', 03:49:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:49:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:49:27 INFO - 'work_dir': 'build'} 03:49:27 INFO - [mozharness: 2017-09-25 10:49:27.740423Z] Running clobber step. 03:49:27 INFO - Running pre-action listener: _resource_record_pre_action 03:49:27 INFO - Running main action method: clobber 03:49:27 INFO - rmtree: /builds/slave/test/build 03:49:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:49:29 INFO - Running post-action listener: _resource_record_post_action 03:49:29 INFO - [mozharness: 2017-09-25 10:49:29.265245Z] Finished clobber step (success) 03:49:29 INFO - [mozharness: 2017-09-25 10:49:29.265343Z] Running read-buildbot-config step. 03:49:29 INFO - Running pre-action listener: _resource_record_pre_action 03:49:29 INFO - Running main action method: read_buildbot_config 03:49:29 INFO - Using buildbot properties: 03:49:29 INFO - { 03:49:29 INFO - "project": "", 03:49:29 INFO - "product": "firefox", 03:49:29 INFO - "who": "archaeopteryx@coole-files.de", 03:49:29 INFO - "installer_path": "public/build/target.tar.bz2", 03:49:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:49:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:49:29 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:49:29 INFO - "stage_platform": "linux64-qr", 03:49:29 INFO - "basedir": "/builds/slave/test", 03:49:29 INFO - "buildnumber": 94, 03:49:29 INFO - "platform": "ubuntu64_hw_qr", 03:49:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:49:29 INFO - "slavebuilddir": "test", 03:49:29 INFO - "taskId": "D0y-JmpdQ0yxOsD-8WtpvQ", 03:49:29 INFO - "branch": "mozilla-central", 03:49:29 INFO - "script_repo_revision": "production", 03:49:29 INFO - "revision": "13ce77b78e364cc952d51b959f22202502be2941", 03:49:29 INFO - "slavename": "talos-linux64-ix-078", 03:49:29 INFO - "repo_path": "mozilla-central" 03:49:29 INFO - } 03:49:29 INFO - Finding installer, test and symbols from parent task. 03:49:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D0y-JmpdQ0yxOsD-8WtpvQ'}, attempt #1 03:49:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D0y-JmpdQ0yxOsD-8WtpvQ'}, attempt #1 03:49:30 INFO - Task dependencies: JwN-TpclSCu1HPYGslnjhA 03:49:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA'}, attempt #1 03:49:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 03:49:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.test_packages.json 03:49:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.crashreporter-symbols.zip 03:49:30 INFO - Running post-action listener: _resource_record_post_action 03:49:30 INFO - [mozharness: 2017-09-25 10:49:30.584476Z] Finished read-buildbot-config step (success) 03:49:30 INFO - [mozharness: 2017-09-25 10:49:30.584695Z] Running download-and-extract step. 03:49:30 INFO - Running pre-action listener: _resource_record_pre_action 03:49:30 INFO - Running main action method: download_and_extract 03:49:30 INFO - mkdir: /builds/slave/test/build/tests 03:49:30 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')]} 03:49:30 INFO - trying https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.test_packages.json 03:49:30 INFO - Downloading https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:49:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:49:31 INFO - Downloaded 989 bytes. 03:49:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:49:31 INFO - Using the following test package requirements: 03:49:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:49:31 INFO - u'common': [u'target.common.tests.zip'], 03:49:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:49:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:49:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:49:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:49:31 INFO - u'mozbase': [u'target.common.tests.zip'], 03:49:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:49:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:49:31 INFO - u'web-platform': [u'target.common.tests.zip', 03:49:31 INFO - u'target.web-platform.tests.tar.gz'], 03:49:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:49:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:49:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.common.tests.zip 03:49:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:49:31 INFO - Fetch https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.common.tests.zip into memory 03:49:33 INFO - Content-Length response header: 54943883 03:49:33 INFO - Bytes received: 54943883 03:49:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.talos.tests.zip 03:49:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:49:43 INFO - Fetch https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.talos.tests.zip into memory 03:49:45 INFO - Content-Length response header: 14513823 03:49:45 INFO - Bytes received: 14513823 03:49: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')]} 03:49:45 INFO - trying https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 03:49:45 INFO - Downloading https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:49:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:49:47 INFO - Downloaded 61752580 bytes. 03:49:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 03:49:48 INFO - mkdir: /builds/slave/test/properties 03:49:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:49:48 INFO - Writing to file /builds/slave/test/properties/build_url 03:49:48 INFO - Contents: 03:49:48 INFO - build_url:https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 03:49:48 INFO - Running post-action listener: _resource_record_post_action 03:49:48 INFO - Running post-action listener: find_tests_for_verification 03:49:48 INFO - Running post-action listener: set_extra_try_arguments 03:49:48 INFO - [mozharness: 2017-09-25 10:49:48.312390Z] Finished download-and-extract step (success) 03:49:48 INFO - [mozharness: 2017-09-25 10:49:48.312491Z] Running populate-webroot step. 03:49:48 INFO - Running pre-action listener: _resource_record_pre_action 03:49:48 INFO - Running main action method: populate_webroot 03:49:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:49:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['tresize', 03:49:48 INFO - 'tcanvasmark']}, 03:49:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:49:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['dromaeo_css', 03:49:48 INFO - 'kraken']}, 03:49:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:49:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:49:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'tests': ['damp', 'tps']}, 03:49:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['damp', 'tps']}, 03:49:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:49:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['dromaeo_dom']}, 03:49:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:49:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['basic_compositor_video', 03:49:48 INFO - 'glvideo']}, 03:49:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:49:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['ts_paint_webext', 03:49:48 INFO - 'tp5o_webext']}, 03:49:48 INFO - 'other-e10s': {'tests': ['a11yr', 03:49:48 INFO - 'ts_paint', 03:49:48 INFO - 'tpaint', 03:49:48 INFO - 'sessionrestore', 03:49:48 INFO - 'sessionrestore_many_windows', 03:49:48 INFO - 'sessionrestore_no_auto_restore', 03:49:48 INFO - 'tabpaint']}, 03:49:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['a11yr', 03:49:48 INFO - 'ts_paint', 03:49:48 INFO - 'tpaint', 03:49:48 INFO - 'sessionrestore', 03:49:48 INFO - 'sessionrestore_many_windows', 03:49:48 INFO - 'sessionrestore_no_auto_restore', 03:49:48 INFO - 'tabpaint']}, 03:49:48 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:49:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:49:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['perf_reftest_singletons']}, 03:49:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['perf_reftest']}, 03:49:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:49:48 INFO - 'tsvgr_opacity', 03:49:48 INFO - 'tart', 03:49:48 INFO - 'tscrollx', 03:49:48 INFO - 'tsvg_static']}, 03:49:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['tsvgx', 03:49:48 INFO - 'tsvgr_opacity', 03:49:48 INFO - 'tart', 03:49:48 INFO - 'tscrollx', 03:49:48 INFO - 'tsvg_static']}, 03:49:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:49:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['tp5o']}, 03:49:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:49:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:49:48 INFO - 'talos_options': ['--mitmproxy', 03:49:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:49:48 INFO - '--firstNonBlankPaint'], 03:49:48 INFO - 'tests': ['tp6_google', 03:49:48 INFO - 'tp6_youtube', 03:49:48 INFO - 'tp6_amazon', 03:49:48 INFO - 'tp6_facebook']}, 03:49:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:49:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:49:48 INFO - 'talos_options': ['--disable-stylo', 03:49:48 INFO - '--mitmproxy', 03:49:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:49:48 INFO - '--firstNonBlankPaint'], 03:49:48 INFO - 'tests': ['tp6_google', 03:49:48 INFO - 'tp6_youtube', 03:49:48 INFO - 'tp6_amazon', 03:49:48 INFO - 'tp6_facebook']}, 03:49:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:49:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:49:48 INFO - 'talos_options': ['--stylo-threads=1', 03:49:48 INFO - '--mitmproxy', 03:49:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:49:48 INFO - '--firstNonBlankPaint'], 03:49:48 INFO - 'tests': ['tp6_google', 03:49:48 INFO - 'tp6_youtube', 03:49:48 INFO - 'tp6_amazon', 03:49:48 INFO - 'tp6_facebook']}, 03:49:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'talos_options': ['--xperf_path', 03:49:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:49:48 INFO - 'tests': ['tp5n']}, 03:49:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'talos_options': ['--disable-stylo', 03:49:48 INFO - '--xperf_path', 03:49:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:49:48 INFO - 'tests': ['tp5n']}}} 03:49:48 INFO - Running post-action listener: _resource_record_post_action 03:49:48 INFO - [mozharness: 2017-09-25 10:49:48.331399Z] Finished populate-webroot step (success) 03:49:48 INFO - [mozharness: 2017-09-25 10:49:48.331489Z] Running create-virtualenv step. 03:49:48 INFO - Running pre-action listener: _resource_record_pre_action 03:49:48 INFO - Running main action method: create_virtualenv 03:49:48 INFO - Creating virtualenv /builds/slave/test/build/venv 03:49:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:49:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:49:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:49:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:49:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:49:48 INFO - Installing distribute.............................................................................................................................................................................................done. 03:49:49 INFO - Installing pip...............done. 03:49:49 INFO - Return code: 0 03:49:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:49:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:49:49 INFO - Reading from file tmpfile_stdout 03:49:49 INFO - Output received: 03:49:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:49:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:49: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')]} 03:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49: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')]} 03:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f779c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f74d60>, '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 0x1f75a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f75ef0>, '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-1506336406.831786-777331707', '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 03:49: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', 'pip>=1.5'] in /builds/slave/test/build 03:49: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 pip>=1.5 03:49:49 INFO - Using env: {'DISPLAY': ':0', 03:49:49 INFO - 'HOME': '/home/cltbld', 03:49:49 INFO - 'LANG': 'en_US.UTF-8', 03:49:49 INFO - 'LANGUAGE': 'en_US:en', 03:49:49 INFO - 'LOGNAME': 'cltbld', 03:49:49 INFO - 'MAIL': '/var/mail/cltbld', 03:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:49 INFO - 'MOZ_NO_REMOTE': '1', 03:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:49 INFO - 'NO_EM_RESTART': '1', 03:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:49 INFO - 'PWD': '/builds/slave/test', 03:49:49 INFO - 'SHELL': '/bin/bash', 03:49:49 INFO - 'SHLVL': '1', 03:49:49 INFO - 'TERM': 'linux', 03:49:49 INFO - 'TMOUT': '86400', 03:49:49 INFO - 'USER': 'cltbld', 03:49:49 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506336406.831786-777331707', 03:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:49 INFO - '_': '/tools/buildbot/bin/python'} 03:49:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:49:50 INFO - Downloading/unpacking pip>=1.5 03:49:50 INFO - Running setup.py egg_info for package pip 03:49:50 INFO - warning: no files found matching 'pip/cacert.pem' 03:49:50 INFO - warning: no files found matching '*.html' under directory 'docs' 03:49:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:49:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:49:50 INFO - Installing collected packages: pip 03:49:50 INFO - Found existing installation: pip 1.1 03:49:50 INFO - Uninstalling pip: 03:49:50 INFO - Successfully uninstalled pip 03:49:50 INFO - Running setup.py install for pip 03:49:50 INFO - warning: no files found matching 'pip/cacert.pem' 03:49:50 INFO - warning: no files found matching '*.html' under directory 'docs' 03:49:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:49:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:49:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:49:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:49:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:49:50 INFO - Successfully installed pip 03:49:50 INFO - Cleaning up... 03:49:50 INFO - Return code: 0 03:49:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:49: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')]} 03:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49: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')]} 03:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49: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', '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 0x1c0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f779c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f74d60>, '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 0x1f75a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f75ef0>, '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-1506336406.831786-777331707', '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 03:49: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:49: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 psutil>=3.1.1 03:49:50 INFO - Using env: {'DISPLAY': ':0', 03:49:50 INFO - 'HOME': '/home/cltbld', 03:49:50 INFO - 'LANG': 'en_US.UTF-8', 03:49:50 INFO - 'LANGUAGE': 'en_US:en', 03:49:50 INFO - 'LOGNAME': 'cltbld', 03:49:50 INFO - 'MAIL': '/var/mail/cltbld', 03:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:50 INFO - 'MOZ_NO_REMOTE': '1', 03:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:50 INFO - 'NO_EM_RESTART': '1', 03:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:50 INFO - 'PWD': '/builds/slave/test', 03:49:50 INFO - 'SHELL': '/bin/bash', 03:49:50 INFO - 'SHLVL': '1', 03:49:50 INFO - 'TERM': 'linux', 03:49:50 INFO - 'TMOUT': '86400', 03:49:50 INFO - 'USER': 'cltbld', 03:49:50 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506336406.831786-777331707', 03:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:50 INFO - '_': '/tools/buildbot/bin/python'} 03:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:50 INFO - Downloading/unpacking psutil>=3.1.1 03:49: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 03:49: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 03:49: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 03:49: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 03:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:49:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:49:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:49:51 INFO - Installing collected packages: psutil 03:49:51 INFO - Running setup.py install for psutil 03:49:52 INFO - building 'psutil._psutil_linux' extension 03:49:52 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 03:49:52 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 03:49:52 INFO - building 'psutil._psutil_posix' extension 03:49:52 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 03:49:52 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 03:49:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:49:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:49:52 INFO - Successfully installed psutil 03:49:52 INFO - Cleaning up... 03:49:52 INFO - Return code: 0 03:49:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:52 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 0x1c0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f779c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f74d60>, '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 0x1f75a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f75ef0>, '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-1506336406.831786-777331707', '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 03:49:52 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 03:49:52 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 03:49:52 INFO - Using env: {'DISPLAY': ':0', 03:49:52 INFO - 'HOME': '/home/cltbld', 03:49:52 INFO - 'LANG': 'en_US.UTF-8', 03:49:52 INFO - 'LANGUAGE': 'en_US:en', 03:49:52 INFO - 'LOGNAME': 'cltbld', 03:49:52 INFO - 'MAIL': '/var/mail/cltbld', 03:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:52 INFO - 'MOZ_NO_REMOTE': '1', 03:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:52 INFO - 'NO_EM_RESTART': '1', 03:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:52 INFO - 'PWD': '/builds/slave/test', 03:49:52 INFO - 'SHELL': '/bin/bash', 03:49:52 INFO - 'SHLVL': '1', 03:49:52 INFO - 'TERM': 'linux', 03:49:52 INFO - 'TMOUT': '86400', 03:49:52 INFO - 'USER': 'cltbld', 03:49:52 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506336406.831786-777331707', 03:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:52 INFO - '_': '/tools/buildbot/bin/python'} 03:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:49: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 03:49: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 03:49: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 03:49: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 03:49:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:49:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:49:53 INFO - Installing collected packages: mozsystemmonitor 03:49:53 INFO - Running setup.py install for mozsystemmonitor 03:49:54 INFO - Successfully installed mozsystemmonitor 03:49:54 INFO - Cleaning up... 03:49:54 INFO - Return code: 0 03:49:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f779c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f74d60>, '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 0x1f75a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f75ef0>, '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-1506336406.831786-777331707', '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 03:49:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:49:54 INFO - Using env: {'DISPLAY': ':0', 03:49:54 INFO - 'HOME': '/home/cltbld', 03:49:54 INFO - 'LANG': 'en_US.UTF-8', 03:49:54 INFO - 'LANGUAGE': 'en_US:en', 03:49:54 INFO - 'LOGNAME': 'cltbld', 03:49:54 INFO - 'MAIL': '/var/mail/cltbld', 03:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:54 INFO - 'MOZ_NO_REMOTE': '1', 03:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:54 INFO - 'NO_EM_RESTART': '1', 03:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:54 INFO - 'PWD': '/builds/slave/test', 03:49:54 INFO - 'SHELL': '/bin/bash', 03:49:54 INFO - 'SHLVL': '1', 03:49:54 INFO - 'TERM': 'linux', 03:49:54 INFO - 'TMOUT': '86400', 03:49:54 INFO - 'USER': 'cltbld', 03:49:54 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506336406.831786-777331707', 03:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:54 INFO - '_': '/tools/buildbot/bin/python'} 03:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:54 INFO - Downloading/unpacking jsonschema==2.5.1 03:49:54 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 03:49:54 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 03:49:54 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 03:49:54 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 03:49:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:49:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:49:55 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 03:49:55 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 03:49:55 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 03:49:55 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 03:49:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:49:55 INFO - warning: no files found matching '*.txt' 03:49:55 INFO - no previously-included directories found matching 'build' 03:49:55 INFO - no previously-included directories found matching 'dist' 03:49:55 INFO - no previously-included directories found matching '.git*' 03:49:55 INFO - Installing collected packages: jsonschema, functools32 03:49:56 INFO - Running setup.py install for functools32 03:49:56 INFO - warning: no files found matching '*.txt' 03:49:56 INFO - no previously-included directories found matching 'build' 03:49:56 INFO - no previously-included directories found matching 'dist' 03:49:56 INFO - no previously-included directories found matching '.git*' 03:49:56 INFO - Successfully installed jsonschema functools32 03:49:56 INFO - Cleaning up... 03:49:56 INFO - Return code: 0 03:49:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:49: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')]} 03:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49: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')]} 03:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:56 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 0x1c0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f779c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f74d60>, '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 0x1f75a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f75ef0>, '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-1506336406.831786-777331707', '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 03:49:56 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 03:49:56 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 03:49:56 INFO - Using env: {'DISPLAY': ':0', 03:49:56 INFO - 'HOME': '/home/cltbld', 03:49:56 INFO - 'LANG': 'en_US.UTF-8', 03:49:56 INFO - 'LANGUAGE': 'en_US:en', 03:49:56 INFO - 'LOGNAME': 'cltbld', 03:49:56 INFO - 'MAIL': '/var/mail/cltbld', 03:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:56 INFO - 'MOZ_NO_REMOTE': '1', 03:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:56 INFO - 'NO_EM_RESTART': '1', 03:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:56 INFO - 'PWD': '/builds/slave/test', 03:49:56 INFO - 'SHELL': '/bin/bash', 03:49:56 INFO - 'SHLVL': '1', 03:49:56 INFO - 'TERM': 'linux', 03:49:56 INFO - 'TMOUT': '86400', 03:49:56 INFO - 'USER': 'cltbld', 03:49:56 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506336406.831786-777331707', 03:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:56 INFO - '_': '/tools/buildbot/bin/python'} 03:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:49:56 INFO - Cleaning up... 03:49:56 INFO - Return code: 0 03:49:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:49: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')]} 03:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49: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')]} 03:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:56 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 0x1c0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f779c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f74d60>, '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 0x1f75a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f75ef0>, '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-1506336406.831786-777331707', '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 03:49:56 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 03:49:56 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 03:49:56 INFO - Using env: {'DISPLAY': ':0', 03:49:56 INFO - 'HOME': '/home/cltbld', 03:49:56 INFO - 'LANG': 'en_US.UTF-8', 03:49:56 INFO - 'LANGUAGE': 'en_US:en', 03:49:56 INFO - 'LOGNAME': 'cltbld', 03:49:56 INFO - 'MAIL': '/var/mail/cltbld', 03:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:56 INFO - 'MOZ_NO_REMOTE': '1', 03:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:56 INFO - 'NO_EM_RESTART': '1', 03:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:56 INFO - 'PWD': '/builds/slave/test', 03:49:56 INFO - 'SHELL': '/bin/bash', 03:49:56 INFO - 'SHLVL': '1', 03:49:56 INFO - 'TERM': 'linux', 03:49:56 INFO - 'TMOUT': '86400', 03:49:56 INFO - 'USER': 'cltbld', 03:49:56 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506336406.831786-777331707', 03:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:56 INFO - '_': '/tools/buildbot/bin/python'} 03:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:56 INFO - Downloading/unpacking blobuploader==1.2.4 03:49:56 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 03:49:56 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 03:49:56 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 03:49:56 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 03:49:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:49:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:49:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:49: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 03:49: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 03:49: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 03:49: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 03:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:49:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:49: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 03:49: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 03:49: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 03:49: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 03:49:58 INFO - Downloading docopt-0.6.1.tar.gz 03:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:49:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:49:58 INFO - Running setup.py install for blobuploader 03:49:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:49:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:49:58 INFO - Running setup.py install for requests 03:49:59 INFO - Running setup.py install for docopt 03:49:59 INFO - Successfully installed blobuploader requests docopt 03:49:59 INFO - Cleaning up... 03:49:59 INFO - Return code: 0 03:49:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49: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')]} 03:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49: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')]} 03:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:59 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 0x1c0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f779c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f74d60>, '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 0x1f75a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f75ef0>, '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-1506336406.831786-777331707', '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 03:49:59 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 03:49:59 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 03:49:59 INFO - Using env: {'DISPLAY': ':0', 03:49:59 INFO - 'HOME': '/home/cltbld', 03:49:59 INFO - 'LANG': 'en_US.UTF-8', 03:49:59 INFO - 'LANGUAGE': 'en_US:en', 03:49:59 INFO - 'LOGNAME': 'cltbld', 03:49:59 INFO - 'MAIL': '/var/mail/cltbld', 03:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:59 INFO - 'MOZ_NO_REMOTE': '1', 03:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:59 INFO - 'NO_EM_RESTART': '1', 03:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:59 INFO - 'PWD': '/builds/slave/test', 03:49:59 INFO - 'SHELL': '/bin/bash', 03:49:59 INFO - 'SHLVL': '1', 03:49:59 INFO - 'TERM': 'linux', 03:49:59 INFO - 'TMOUT': '86400', 03:49:59 INFO - 'USER': 'cltbld', 03:49:59 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506336406.831786-777331707', 03:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:59 INFO - '_': '/tools/buildbot/bin/python'} 03:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:49:59 INFO - Running setup.py (path:/tmp/pip-YtuBqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:49:59 INFO - Running setup.py (path:/tmp/pip-_xNYUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:49:59 INFO - Running setup.py (path:/tmp/pip-tgXoP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:49:59 INFO - Running setup.py (path:/tmp/pip-vmFVJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:49:59 INFO - Running setup.py (path:/tmp/pip-fh2Qs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:49:59 INFO - Running setup.py (path:/tmp/pip-qSxWDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:49:59 INFO - Running setup.py (path:/tmp/pip-OFdMWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:49:59 INFO - Running setup.py (path:/tmp/pip-rXXhTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:49:59 INFO - Running setup.py (path:/tmp/pip-xuY8BN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:50:00 INFO - Running setup.py (path:/tmp/pip-lTFMXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:50:00 INFO - Running setup.py (path:/tmp/pip-SCcgPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:50:00 INFO - Running setup.py (path:/tmp/pip-EIeVH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:50:00 INFO - Running setup.py (path:/tmp/pip-bkgb5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:50:00 INFO - Running setup.py (path:/tmp/pip-1llkP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:00 INFO - Running setup.py (path:/tmp/pip-1wxD30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:50:00 INFO - Running setup.py (path:/tmp/pip-Yos6Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:50:00 INFO - Running setup.py (path:/tmp/pip-VuUarw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:50:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:50:00 INFO - Running setup.py install for manifestparser 03:50:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:50:00 INFO - Running setup.py install for mozcrash 03:50:00 INFO - Running setup.py install for mozdebug 03:50:00 INFO - Running setup.py install for mozdevice 03:50:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Running setup.py install for mozfile 03:50:01 INFO - Running setup.py install for mozhttpd 03:50:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Running setup.py install for mozinfo 03:50:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Running setup.py install for mozInstall 03:50:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Running setup.py install for mozleak 03:50:01 INFO - Running setup.py install for mozlog 03:50:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Running setup.py install for moznetwork 03:50:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Running setup.py install for mozprocess 03:50:01 INFO - Running setup.py install for mozprofile 03:50:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Running setup.py install for mozrunner 03:50:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:50:02 INFO - Running setup.py install for mozscreenshot 03:50:02 INFO - Running setup.py install for moztest 03:50:02 INFO - Running setup.py install for mozversion 03:50:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:50:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:50:02 INFO - Cleaning up... 03:50:02 INFO - Return code: 0 03:50:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50: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')]} 03:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50: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')]} 03:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:02 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 0x1c0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f779c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f74d60>, '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 0x1f75a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f75ef0>, '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-1506336406.831786-777331707', '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 03:50:02 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 03:50:02 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 03:50:02 INFO - Using env: {'DISPLAY': ':0', 03:50:02 INFO - 'HOME': '/home/cltbld', 03:50:02 INFO - 'LANG': 'en_US.UTF-8', 03:50:02 INFO - 'LANGUAGE': 'en_US:en', 03:50:02 INFO - 'LOGNAME': 'cltbld', 03:50:02 INFO - 'MAIL': '/var/mail/cltbld', 03:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:02 INFO - 'MOZ_NO_REMOTE': '1', 03:50:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:02 INFO - 'NO_EM_RESTART': '1', 03:50:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:02 INFO - 'PWD': '/builds/slave/test', 03:50:02 INFO - 'SHELL': '/bin/bash', 03:50:02 INFO - 'SHLVL': '1', 03:50:02 INFO - 'TERM': 'linux', 03:50:02 INFO - 'TMOUT': '86400', 03:50:02 INFO - 'USER': 'cltbld', 03:50:02 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506336406.831786-777331707', 03:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:02 INFO - '_': '/tools/buildbot/bin/python'} 03:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:50:02 INFO - Running setup.py (path:/tmp/pip-WtjB_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:50:02 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)) 03:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:50:02 INFO - Running setup.py (path:/tmp/pip-nPyf4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:50:02 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)) 03:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:50:02 INFO - Running setup.py (path:/tmp/pip-KocWUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:50:02 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)) 03:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:50:02 INFO - Running setup.py (path:/tmp/pip-t22kEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:50:02 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)) 03:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:50:02 INFO - Running setup.py (path:/tmp/pip-5CSG4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:50:02 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)) 03:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:50:02 INFO - Running setup.py (path:/tmp/pip-VDVgnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:50:03 INFO - Running setup.py (path:/tmp/pip-7xAE9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:50:03 INFO - Running setup.py (path:/tmp/pip-WuZzZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:50:03 INFO - Running setup.py (path:/tmp/pip-GFgL5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:50:03 INFO - Running setup.py (path:/tmp/pip-XI_x8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:50:03 INFO - Running setup.py (path:/tmp/pip-ROzNZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:50:03 INFO - Running setup.py (path:/tmp/pip-GMoA96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:50:03 INFO - Running setup.py (path:/tmp/pip-3P0Dsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:50:03 INFO - Running setup.py (path:/tmp/pip-BbsSBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:03 INFO - Running setup.py (path:/tmp/pip-X4FSwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:50:03 INFO - Running setup.py (path:/tmp/pip-TLgwlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:50:03 INFO - Running setup.py (path:/tmp/pip-tzsEBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:50:03 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)) 03:50:03 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)) 03:50:03 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)) 03:50:03 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)) 03:50:03 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)) 03:50:03 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)) 03:50:03 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)) 03:50:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:50:03 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 03:50:03 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 03:50:03 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 03:50:03 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 03:50:04 INFO - Downloading blessings-1.6.tar.gz 03:50:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:50:05 INFO - Installing collected packages: blessings 03:50:05 INFO - Running setup.py install for blessings 03:50:05 INFO - Successfully installed blessings 03:50:05 INFO - Cleaning up... 03:50:05 INFO - Return code: 0 03:50:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:50:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:50:05 INFO - Reading from file tmpfile_stdout 03:50:05 INFO - Current package versions: 03:50:05 INFO - argparse == 1.2.1 03:50:05 INFO - blessings == 1.6 03:50:05 INFO - blobuploader == 1.2.4 03:50:05 INFO - docopt == 0.6.1 03:50:05 INFO - functools32 == 3.2.3-2 03:50:05 INFO - jsonschema == 2.5.1 03:50:05 INFO - manifestparser == 1.1 03:50:05 INFO - mozInstall == 1.13 03:50:05 INFO - mozcrash == 1.0 03:50:05 INFO - mozdebug == 0.1 03:50:05 INFO - mozdevice == 0.51 03:50:05 INFO - mozfile == 1.2 03:50:05 INFO - mozhttpd == 0.7 03:50:05 INFO - mozinfo == 0.10 03:50:05 INFO - mozleak == 0.1 03:50:05 INFO - mozlog == 3.5 03:50:05 INFO - moznetwork == 0.27 03:50:05 INFO - mozprocess == 0.25 03:50:05 INFO - mozprofile == 0.28 03:50:05 INFO - mozrunner == 6.13 03:50:05 INFO - mozscreenshot == 0.1 03:50:05 INFO - mozsystemmonitor == 0.3 03:50:05 INFO - moztest == 0.8 03:50:05 INFO - mozversion == 1.4 03:50:05 INFO - psutil == 3.1.1 03:50:05 INFO - requests == 1.2.3 03:50:05 INFO - wsgiref == 0.1.2 03:50:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:05 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 0x1c0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f779c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f74d60>, '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 0x1f75a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f75ef0>, '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-1506336406.831786-777331707', '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 03:50:05 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 03:50:05 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 03:50:05 INFO - Using env: {'DISPLAY': ':0', 03:50:05 INFO - 'HOME': '/home/cltbld', 03:50:05 INFO - 'LANG': 'en_US.UTF-8', 03:50:05 INFO - 'LANGUAGE': 'en_US:en', 03:50:05 INFO - 'LOGNAME': 'cltbld', 03:50:05 INFO - 'MAIL': '/var/mail/cltbld', 03:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:05 INFO - 'MOZ_NO_REMOTE': '1', 03:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:05 INFO - 'NO_EM_RESTART': '1', 03:50:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:05 INFO - 'PWD': '/builds/slave/test', 03:50:05 INFO - 'SHELL': '/bin/bash', 03:50:05 INFO - 'SHLVL': '1', 03:50:05 INFO - 'TERM': 'linux', 03:50:05 INFO - 'TMOUT': '86400', 03:50:05 INFO - 'USER': 'cltbld', 03:50:05 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506336406.831786-777331707', 03:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:05 INFO - '_': '/tools/buildbot/bin/python'} 03:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:05 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)) 03:50:05 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)) 03:50:05 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)) 03:50:05 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)) 03:50:05 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)) 03:50:05 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)) 03:50:05 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)) 03:50:05 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)) 03:50:05 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)) 03:50:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:50:06 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)) 03:50:06 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)) 03:50:06 INFO - Installing collected packages: simplejson 03:50:06 INFO - Running setup.py install for simplejson 03:50:06 INFO - building 'simplejson._speedups' extension 03:50:06 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 03:50:07 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 03:50:07 INFO - Successfully installed simplejson 03:50:07 INFO - Cleaning up... 03:50:07 INFO - Return code: 0 03:50:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:50:07 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')]} 03:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:07 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')]} 03:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:07 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 0x1c0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f779c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f74d60>, '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 0x1f75a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f75ef0>, '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-1506336406.831786-777331707', '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 03:50:07 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 03:50:07 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 03:50:07 INFO - Using env: {'DISPLAY': ':0', 03:50:07 INFO - 'HOME': '/home/cltbld', 03:50:07 INFO - 'LANG': 'en_US.UTF-8', 03:50:07 INFO - 'LANGUAGE': 'en_US:en', 03:50:07 INFO - 'LOGNAME': 'cltbld', 03:50:07 INFO - 'MAIL': '/var/mail/cltbld', 03:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:07 INFO - 'MOZ_NO_REMOTE': '1', 03:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:07 INFO - 'NO_EM_RESTART': '1', 03:50:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:07 INFO - 'PWD': '/builds/slave/test', 03:50:07 INFO - 'SHELL': '/bin/bash', 03:50:07 INFO - 'SHLVL': '1', 03:50:07 INFO - 'TERM': 'linux', 03:50:07 INFO - 'TMOUT': '86400', 03:50:07 INFO - 'USER': 'cltbld', 03:50:07 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506336406.831786-777331707', 03:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:07 INFO - '_': '/tools/buildbot/bin/python'} 03:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:50:08 INFO - Cleaning up... 03:50:08 INFO - Return code: 0 03:50:08 INFO - Running post-action listener: _resource_record_post_action 03:50:08 INFO - Running post-action listener: _start_resource_monitoring 03:50:08 INFO - Starting resource monitoring. 03:50:08 INFO - [mozharness: 2017-09-25 10:50:08.078711Z] Finished create-virtualenv step (success) 03:50:08 INFO - [mozharness: 2017-09-25 10:50:08.079195Z] Running install step. 03:50:08 INFO - Running pre-action listener: _resource_record_pre_action 03:50:08 INFO - Running main action method: install 03:50:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:50:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:50:08 INFO - Reading from file tmpfile_stdout 03:50:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:50:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:50:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:50:08 INFO - Reading from file tmpfile_stdout 03:50:08 INFO - Output received: 03:50:08 INFO - Usage: mozinstall [options] installer 03:50:08 INFO - Options: 03:50:08 INFO - -h, --help show this help message and exit 03:50:08 INFO - -d DEST, --destination=DEST 03:50:08 INFO - Directory to install application into. [default: 03:50:08 INFO - "/builds/slave/test"] 03:50:08 INFO - --app=APP Application being installed. [default: firefox] 03:50:08 INFO - mkdir: /builds/slave/test/build/application 03:50:08 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'] 03:50:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:50:26 INFO - Reading from file tmpfile_stdout 03:50:26 INFO - Output received: 03:50:26 INFO - /builds/slave/test/build/application/firefox/firefox 03:50:26 INFO - Running post-action listener: _resource_record_post_action 03:50:26 INFO - [mozharness: 2017-09-25 10:50:26.210666Z] Finished install step (success) 03:50:26 INFO - [mozharness: 2017-09-25 10:50:26.210918Z] Running setup-mitmproxy step. 03:50:26 INFO - Running pre-action listener: _resource_record_pre_action 03:50:26 INFO - Running main action method: setup_mitmproxy 03:50:26 INFO - Skipping: mitmproxy is not required 03:50:26 INFO - Running post-action listener: _resource_record_post_action 03:50:26 INFO - [mozharness: 2017-09-25 10:50:26.212051Z] Finished setup-mitmproxy step (success) 03:50:26 INFO - [mozharness: 2017-09-25 10:50:26.212273Z] Running run-tests step. 03:50:26 INFO - Running pre-action listener: _resource_record_pre_action 03:50:26 INFO - Running pre-action listener: _set_gcov_prefix 03:50:26 INFO - Running main action method: run_tests 03:50:26 WARNING - Try message not found. 03:50:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:50:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:50:26 INFO - Python 2.7.3 03:50:26 INFO - Return code: 0 03:50:26 INFO - grabbing minidump binary from tooltool 03:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:26 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 0x1f74d60>, '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 0x1f75a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f75ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:50:26 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 03:50:26 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 03:50:26 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 03:50:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:50:26 INFO - Return code: 0 03:50:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:50:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:50:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:50:26 INFO - ENV: RUST_BACKTRACE is now full 03:50:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:50:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:50:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/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 03:50:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/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 03:50:26 INFO - Using env: {'DISPLAY': ':0', 03:50:26 INFO - 'HOME': '/home/cltbld', 03:50:26 INFO - 'LANG': 'en_US.UTF-8', 03:50:26 INFO - 'LANGUAGE': 'en_US:en', 03:50:26 INFO - 'LOGNAME': 'cltbld', 03:50:26 INFO - 'MAIL': '/var/mail/cltbld', 03:50:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:50:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:50:26 INFO - 'MOZ_ACCELERATED': '1', 03:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:26 INFO - 'MOZ_NO_REMOTE': '1', 03:50:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:50:26 INFO - 'MOZ_WEBRENDER': '1', 03:50:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:26 INFO - 'NO_EM_RESTART': '1', 03:50:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:26 INFO - 'PWD': '/builds/slave/test', 03:50:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:50:26 INFO - 'RUST_BACKTRACE': 'full', 03:50:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:50:26 INFO - 'SHELL': '/bin/bash', 03:50:26 INFO - 'SHLVL': '1', 03:50:26 INFO - 'TERM': 'linux', 03:50:26 INFO - 'TMOUT': '86400', 03:50:26 INFO - 'USER': 'cltbld', 03:50:26 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506336406.831786-777331707', 03:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:26 INFO - '_': '/tools/buildbot/bin/python'} 03:50:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/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 03:50:26 INFO - mozversion application_buildid: 20170925095628 03:50:26 INFO - mozversion application_changeset: 13ce77b78e364cc952d51b959f22202502be2941 03:50:26 INFO - mozversion application_display_name: Nightly 03:50:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:50:26 INFO - mozversion application_name: Firefox 03:50:26 INFO - mozversion application_remotingname: firefox 03:50:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:50:26 INFO - mozversion application_vendor: Mozilla 03:50:26 INFO - mozversion application_version: 58.0a1 03:50:26 INFO - mozversion platform_buildid: 20170925095628 03:50:26 INFO - mozversion platform_changeset: 13ce77b78e364cc952d51b959f22202502be2941 03:50:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:50:26 INFO - mozversion platform_version: 58.0a1 03:50:26 INFO - using testdate: 1506336626 03:50:26 INFO - actual date: 1506336626 03:50:26 INFO - starting webserver on 'localhost:35315' 03:50:26 INFO - SUITE-START | Running 2 tests 03:50:26 INFO - TEST-START | dromaeo_css 03:50:26 INFO - Initialising browser for dromaeo_css test... 03:50:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35315/getInfo.html -profile /tmp/tmpmiTb9i/profile 03:50:26 INFO - TEST-INFO | started process 28805 (/builds/slave/test/build/application/firefox/firefox http://localhost:35315/getInfo.html) 03:50:33 INFO - TEST-INFO | 28805: exit 0 03:50:33 INFO - Browser initialized. 03:50:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:50:33 INFO - Using env: {'DISPLAY': ':0', 03:50:33 INFO - 'HOME': '/home/cltbld', 03:50:33 INFO - 'JSGC_DISABLE_POISONING': '1', 03:50:33 INFO - 'LANG': 'en_US.UTF-8', 03:50:33 INFO - 'LANGUAGE': 'en_US:en', 03:50:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:50:33 INFO - 'LOGNAME': 'cltbld', 03:50:33 INFO - 'MAIL': '/var/mail/cltbld', 03:50:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:50:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:50:33 INFO - 'MOZ_ACCELERATED': '1', 03:50:33 INFO - 'MOZ_CRASHREPORTER': '1', 03:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:50:33 INFO - 'MOZ_NO_REMOTE': '1', 03:50:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:50:33 INFO - 'MOZ_WEBRENDER': '1', 03:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:33 INFO - 'NO_EM_RESTART': '1', 03:50:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:33 INFO - 'PWD': '/builds/slave/test', 03:50:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:50:33 INFO - 'RUST_BACKTRACE': 'full', 03:50:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:50:33 INFO - 'SHELL': '/bin/bash', 03:50:33 INFO - 'SHLVL': '1', 03:50:33 INFO - 'TERM': 'linux', 03:50:33 INFO - 'TMOUT': '86400', 03:50:33 INFO - 'USER': 'cltbld', 03:50:33 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506336406.831786-777331707', 03:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:33 INFO - '_': '/tools/buildbot/bin/python'} 03:50:33 INFO - TEST-INFO | started process 29052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmiTb9i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:34 INFO - PID 29052 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:50:34 INFO - PID 29052 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:50:34 INFO - PID 29052 | 03:50:34 INFO - PID 29052 | (/builds/slave/test/build/application/firefox/firefox:29111): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:50:34 INFO - PID 29052 | 03:50:44 INFO - PID 29052 | RSS: Main: 184692736 03:50:44 INFO - PID 29052 | 03:53:43 INFO - PID 29052 | Cycle 1(1): loaded http://localhost:35315/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35315/tests/dromaeo/cssquery-ext.html) 03:53:44 INFO - PID 29052 | RSS: Main: 189140992 03:53:44 INFO - PID 29052 | 03:56:46 INFO - PID 29052 | Cycle 1(1): loaded http://localhost:35315/tests/dromaeo/cssquery-ext.html (next: http://localhost:35315/tests/dromaeo/cssquery-jquery.html) 03:56:46 INFO - PID 29052 | RSS: Main: 192950272 03:56:46 INFO - PID 29052 | 03:59:49 INFO - PID 29052 | Cycle 1(1): loaded http://localhost:35315/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35315/tests/dromaeo/cssquery-mootools.html) 03:59:49 INFO - PID 29052 | RSS: Main: 195973120 03:59:49 INFO - PID 29052 | 04:02:51 INFO - PID 29052 | Cycle 1(1): loaded http://localhost:35315/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35315/tests/dromaeo/cssquery-prototype.html) 04:02:52 INFO - PID 29052 | RSS: Main: 191823872 04:02:52 INFO - PID 29052 | 04:05:56 INFO - PID 29052 | Cycle 1(1): loaded http://localhost:35315/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35315/tests/dromaeo/cssquery-yui.html) 04:05:56 INFO - PID 29052 | RSS: Main: 192393216 04:05:56 INFO - PID 29052 | 04:08:58 INFO - PID 29052 | Cycle 1(1): loaded http://localhost:35315/tests/dromaeo/cssquery-yui.html (next: http://localhost:35315/tests/dromaeo/cssquery-dojo.html) 04:08:58 INFO - PID 29052 | RSS: Main: 194793472 04:08:58 INFO - PID 29052 | 04:08:58 INFO - PID 29052 | __start_tp_report 04:08:58 INFO - PID 29052 | _x_x_mozilla_page_load 04:08:58 INFO - PID 29052 | _x_x_mozilla_page_load_details 04:08:58 INFO - PID 29052 | |i|pagename|runs| 04:08:58 INFO - PID 29052 | |0;dojo.html;3099.132242971968;3113.968860311397;3114.486109791886;3133.279345750476;3162.873485060598;6084.695765211733;6226.221722284715;6234.84412889678;6309.3375195604485;6319.810405687826;6179.5674302798825;6213.502919766419;6227.034809604518;6243.71903264353;6266.342034086424;5666.9433305667035;5712.485876271135;5746.942530574683;5755.856103597413;5789.2763404574425;5790.276215473066;5836.824895253128;5837.50381217597;5859.238299021121;5890.764369425217;5712.257406537145;5724.055530837407;5740.569457290699;5765;5814.4185581441725;5165.845024649267;5485.232067510552;5592.217089607459;5731.484166425042;5781.479666830005;5609.915851262234;5626.324841019063;5673.461021202979;5723.112917497794;5736.397678243766;6088.299845517734;6155.984262596666;6164.907526387108;6231.688415579203;6266.091416744592;6709.832254193684;6752.2234942981695;6766.391024807791;6775.796726098225;6852.109225800664;6728.259891411941;6795.7961261162245;6846.691898864513;6885.483588730815;6894.862102757967;6128.601640893327;6283.3088360280335;6313.779017734403;6338.334474880164;6350.904736428957;6844.931550684529;6905.37851593359;6912.205096413977;6931.584104953618;6933;6503.642299673564;6523.7064332105165;6586.769463068769;6630.734770609218;6632.369924857131;6565.67171641416;6639.43564796988;6659.833504162338;6742.5280230383405;6780.966095169492;6490;6604.240512341046;6612.140421745143;6634.23706273775;6648.767293144813;6627.271000189975;6691.966540167366;6695.230048544479;6748.865022699519;6761.357671021246;5207.947920520746;5309.787608495617;5333.466653334713;5349.304590403222;5356.973215133899;4586.633069354443;4662.020975595163;4711.081339138835;4714.481407045222;4719.38647975761;5667.971660141673;5770.480656740913;5803;5834.066549352084;5841.094630332305;6663.900041499382;6716.227633822075;6720.932790672128;6732.192136943598;6793.524453288322;5789.710514474259;5843.474087332161;5852.297724273115;5875.853103672443;5899.882002359929;5769;5820.214271073351;5854.619449735838;5871.266091738533;5885.882282354329;6537.346265373425;6561.1142495763415;6636.966815165893;6645.634490102994;6650.20197576294;6554.541182117397;6644.335566443317;6651.235107962646;6653.434458071119;6814.727410903508;6346.682665866781;6362.681865906594;6380.617162970237;6397.808065758035;6465.870682586416;6669;6691.1636045494315;6712.463002959849;6724.327567243236;6736.360045795642;6720.865582688221;6749.628770417674;6759.898601521079;6849;6860.656967151723;6375.330590287953;6506.186726659168;6545.541812073109;6591.6374599397495;6599.4720422365135;6396.072569477493;6510.283868774336;6568.1789776277965;6586.176727909012;6600;6290.370962903673;6396.29640739509;6438.903416448663;6458.903116453163;6480.027995800668;6577.868442631217;6579.967100164468;6623.768168114093;6676.89984650221;6698.5980841149685;6172.506199504119;6335.429811317003;6435.420812126931;6464.644444555594;6477.902831457438 04:08:58 INFO - PID 29052 | |1;ext.html;885.991140088599;887.9067697891722;913.2876356441977;918.5866360137937;925.5603588295564;40925.38611920823;42567.36148957764;42579.78710106449;42593.36109958353;42632.57367426325;39522.8023859881;39763.80118099406;39899.202015959665;39949.60050399495;39978.8001059995;7108.0759501264765;7245.130584329861;7245.710171593157;7253.891191632129;7277.672504737299;7209.89185162223;7342.926570734277;7348.3753880920185;7349;7353.852922941538;7314.963425182867;7334.119905611334;7338.9633051834935;7912.960435197816;8125.674973001072;8002.559859207741;8086.353091752704;8087.959560202161;8094;8095.5952202389935;7962.761117166494;8070.596470176526;8115.715949941783;8124.959375203086;8126.268635822746;37880.242395151945;38010.809945950095;38211.42682859759;38450.42324365137;38460;3495.5805303363504;3529.047157267549;3545.308664810363;3548.7515873888838;3566.3937130687846;31386;31606.841965790252;31714.207144821332;31792.682073179203;31943.84028079868;5155.097857874857;5193.013327467769;5203.271541984125;5210.296609957645;5317.096093664087;186897;188502;188714;189035;190175.04912475488;43450;44433.77783111064;44437.55562444399;49895.50104498908;50266.48667566607;52482.73758631182;53094.73452632789;53138.46861531412;53254.46745532573;53480;16634.417795377347;16745;16755;16770.916145419196;16780;13694.52069177574;13710.794338084937;13726.313684315945;13799.931000344934;13830.23933683657;14451.421943122368;14528.273586320642;14582.76046536035;14585.708285834224;14738.778918316233;5789.247397838254;5792.565557583198;5828.621139625996;5907.822765317047;5983.670898100646;997.3666721631671;1002.6490728245055;1002.9398236105857;1019.8062368150028;1022.7443139215196;22760.772392276198;22953.885230574073;22976.770232297797;23221.53556928886;23281.301560953198;1087.1846115413439;1107.645553422913;1110.9444527773578;1119.6641007697658;1126.0822429719751;12182.695432614255;12312;12341.13612047166;12367.319797411048;12476.625701228797;217010;218174;219167;219527;219684;54224;54227.45772542224;54447.72776136173;54598.18102728462;54721.1791823123;1378.6070969773566;1452.3609611770787;1462.3711803924202;1469.7134058858633;1480.156310902775;22598.209062682727;22616.547669046857;23205;23221;23236.883815580815;37415;37563;37860.62139378681;37918.241635167695;38015.80992095022;188993;189111;189539;190829;191165;31667.683323166475;34276.48585271273;34634.48048279227;35741.82129089338;35999;44279.55720442755;44559.55440445684;44846;45110.09779804451;45142;32387.19032024218;32411;32574.34851303008;32656.34687306193;32657;31844.68155318417;31994;32193.678063219068;32208.355832882742;32213.03360899177;35108;36217.63782362143;36509;36683.266334672626;36968.26063478662;31543.369132617678;31757.8412107938;32176.517352239265;32320;32543.51184732278;23750.643740343563;24051;24070.75929240755;24150.033998639858;24316.75683243216 04:08:58 INFO - PID 29052 | |2;jquery.html;586.6392168816177;598.6228675934161;602.1539736669979;606.9848253793657;613.4724137241972;21859.67210491842;22717.886410567946;22764.999999999978;22834.54330913385;22891.77108228917;23176.42058948527;24650.260492185218;24662.876685616593;24772.752272477315;24803.379915502075;6650.401463868251;6785.76249831256;6822.147231596051;6833.350831670983;6878;6364.49084073273;6649.368310010541;6746.730130794763;6749.561278516905;6755.4933379996455;6620.735170593171;6633.966830165842;6653.53425260232;6676.632785196813;6695.129633147684;6598.604083754966;6620.371064748865;6635.435987941007;6665.666716664147;6696.8995465068065;5966.254218222723;6152.78465253714;6205.596636218631;6219.782307619257;6234.251889773211;27950.580741288693;28633.427331453255;28698.282542936595;28726.712732872613;28779.28051798701;2004.0280463974962;2004.2183548416128;2024;2029.4723371923258;2031.1672214392177;17162.742558861628;18392.816071839377;18818.717719234224;18851.71722424165;18857.528561785926;2237.3176181264707;2462.4705688276927;2473.245660073677;2483.801295896324;2489.0790407549143;125238.37380813129;131036;131283;133993;140001.99999999898;14624.435109792614;14855.92572037133;14903;15033.548993529992;15178.31697573612;23338.883305583364;23469.7653023471;23598.88200558986;23620.409489762893;23653.408664783517;9322.953385233166;9407.43555386679;9491.38306010107;9496.762580935394;9514.38156519824;8569.828603427897;8570.357223208284;8593.742187734379;8691.739247822576;8759.211670949646;8802;8920.24177944882;9038.559588911088;9195.862062069074;9208.26333893287;2743.7942154338502;2763.903263385772;2846.8576571171357;2855.614492043589;2951.778616603763;953.8092381523722;973.732223638505;983.8327484327682;1000.8798944126752;1001.4041645221082;18376.173072211783;18526.629467410847;18667.066646667885;18795.436136915916;18987.860728356343;1043.410473082706;1046.0585473074293;1048.8479170520231;1059.8251288537306;1061.532925512772;10133.594656213669;10294.948525257476;10297.94851025755;10561.260711750258;10562.102221311121;448606;456392;458997;462898;468118;110924;113016;113326;114595.42702286436;117043;1136.4885801389573;1143.4511434511314;1144.079016391796;1163.8486996690376;1169.2692067457838;16664.83335166633;16685.249163787415;16749.162541872614;16768.496945091665;16841.073740944365;54229;57017;57034;57436;57639.711801440724;66493;66733.66633166804;67990.66004669946;68542.65728671524;68702.3129768696;13621.863781362059;13884.791728123884;13958.441662333393;13970.441182352999;14157;21192.36422907315;21292;21383.89308053512;21655.783442165375;21660.133594656036;16529.752053719443;16716.164191790605;16923.323067077177;17107.14464276806;17368.305267789146;14963.551093467213;14969.700605988037;14991.700165996837;15211.011284266488;15950.361985520449;17253.74119388185;17456.650866982844;17516.211770470614;17555.473335799947;17580.296788128333;13521.256330901895;13685;13692.45230190821;13700.862991370357;13700.97242706781;16581.668366632843;16911.91544042272;16925.746113808058;17163.141842908055;17215.225314861113 04:08:58 INFO - PID 29052 | |3;mootools.html;1274.6430999320191;1317.2425855133301;1333.926634035128;1335.5993202039385;1338.698792771626;12611.747765044694;13158.868411315883;13249.205047697145;15576.376944922218;16068.27692753826;15549.378024879019;15790.4473343433;15873.92063039686;15876.841231587681;15893.761593576077;2571.90998315059;2787.1917144028207;2834.54647256439;2835.050258163518;2854.4861924853517;2674.371522692166;2676.411189538308;2855.3718181999925;2871.511842986687;2877.553979133227;2774.0429551804596;2811.7610003149757;2816.6760822505366;2834.9433011339866;2841.4317136572663;2728.2633688904084;2760.6687197536326;2761.047438633668;2781.5132351838447;2784.1786672931535;2653.0165116418043;2663.933401664974;2668.546347120994;2677.8928842846262;2680.584509401046;14903.105813651217;15166.24168791567;15240.161791101486;15267.541973740805;15351.769723454157;8202.179782021809;8487.193716596914;8527.445716028438;8574.571271436465;8581.95709021451;5271.262023316739;5577.776888924438;5603.159526071122;5626.746796394172;5648.6893220872835;1875.3623767918973;1879.52072221584;1930.1954012722313;1960.2746983616012;1974.3780709076739;26573.33566660849;26818;26893.32766680829;26961.730382696314;26993.32516687079;6877.209120951155;6892;6893.620850853251;6901.764717506784;7242.891356629655;16756.581085472717;16836.32654693823;16851.74722379165;16860.494185174466;16924.323027079026;8067.193280671886;8160.755177344689;8217.95891020541;8236.50580965132;8263.380246481538;6558.442532384705;7309;7386.113666359964;7583.7724868254045;7618.085829700472;5086.847394578169;5318.7074710891275;5515.25544051556;5598.272224610774;5618.353889302701;1547.3810475809767;1555.844415558435;1583.8099428068706;1594.131198496822;1600.0719582642039;863.0937515608585;864.3085531574715;878.7188099808128;881.2201201936333;896.7623579751371;8220;8289.129641387688;8417.70538031166;8463.66145354179;8476.449030812977;965.5558443116245;986.541258314887;991.9752006199758;996.1881066930429;1005.5374527717186;5162.896742065138;5204.193350030751;5222.268882356473;5286.788528458896;5330.200469929541;21309.25417610407;21416.250431234832;22014.229501967355;22379.44051398728;22608.660870086962;21436.356909292434;21817.345479635635;22030.559388812453;22143.667844982338;22579.43551411195;11423.942880285545;11763.470643821049;11833.822492662617;11839.171258011856;11871;7963.960180199062;8238.50568965864;8347.081820999563;8353.791155221168;8460.873086903579;18576.81423185805;19214.327498537485;19451.3192038278;19750.80249197547;19774;19643.901780491007;19895.403137905887;20031.39905802828;20174.79825201729;20365.287214948;11452.770944581229;11460.885391145981;11567.537298507965;11568.13239007061;11570.421478926188;13875.861241387456;13908.37412316428;13967.860321396656;13996.090254133449;14103.224322662352;11075.667729968114;11314.490847911698;11375.089992800722;11415.258008229439;11632.476538555617;11282.548698051985;11368.772624547628;11391.316521008766;11465.885341146815;11547.538098475967;9932.304738668225;10197.592096316064;10264.127549158406;10266.691999240034;10273.691789246335;7194.532355396883;7239.8914016288745;7297.16082650502;7298.452616053711;7405.925940740739;7491.913672517346;7496.1754207038275;7538.295620219411;7690.038745156856;7709.4603377763015 04:08:58 INFO - PID 29052 | |4;prototype.html;505.84571705629793;528.3554064041869;539.6222644149092;550.7934524553292;553.239295968044;6081.148639190511;6221.408966148214;6240.251169859612;6275.686215689215;6309.810705678826;6065.969670151654;6089.817305480831;6094.052779830996;6143.931256713207;6178.752849885999;4959.950400495994;5000;5065.1642478990925;5065.214891691794;5066.493350664941;4814.470408255089;5038.598945711648;5050.838307189349;5058.873528161807;5075.949240507584;4966.106100901836;4968.677035992667;5015.423226328982;5018.498150184971;5054.1660625996665;4972.8508144755715;5020.468757029104;5032.119379108678;5033.471485494026;5064.518870707277;4510.233260345716;4520.621210530787;4521.932171017437;4524.5927866492175;4526.117407105616;6070.453659170652;6158.230221222348;6164.599301045418;6171;6218.347073557256;5740.56945729072;5742.856428589277;5743.4543718346695;5758.827235182951;5767.769289228426;6444.258910225337;6480.773172938972;6547.9017814732815;6595.8021259362295;6607.8017659469815;4888.340074089988;4918.090153321611;4931.67944083637;4933.703977761345;4945.629077819142;6929.549579277331;6951.478639102037;6989.078003549064;7022.1573411190475;7025.683844227022;5046.47012063728;5093.1087059764395;5126.2054381570915;5133;5134.922976155361;5101.821436249787;5108.795648174106;5130.897382052338;5145.639805213599;5147.3308469898675;5696.259486266842;5719.628224165499;5726.398728133569;5736.885262294814;5756.079027355603;6333.068414133733;6544.509161812788;6660.800175994728;6675.7997260082275;6690.899636505456;1714.3970387687552;1720.6644704282794;1768.9027103509172;1769.9645707261395;1787.6692811829853;1225.8835410635975;1253.9623811285676;1273.4396865379204;1276.5914907229783;1284.6274580371587;5470.507654311052;5536.474034966672;5551.833444996657;5558.471945165203;5629.746661400247;6585.703643336062;6602.735890564323;6613.404793568602;6708.3291670833505;6835.179778426621;5694.946434909555;5728.1694154348215;5799.739011744482;5808.303003639506;5809.448102430262;3500.4423031750625;3565.9286814264087;3567.375709250871;3579.3378225028455;3586.3544561978574;6418.967905160444;6478.546501744832;6483.610983341015;6507.577007494498;6534.313897040837;6742.39318461331;6815.863682726318;6844.4182244508775;6875.243723190445;6967.512274140761;6300.747970081237;6355.3644635536075;6404.871902561923;6418.26189988148;6449.7097630605795;6642.335766423319;6650.700718467584;6691.1636045494315;6779.457643388616;6781;6404.039394090923;6545.37818907203;6549.279579246374;6551.770688026087;6588.209414870246;6393.584417012879;6437.163168788027;6471.708773105127;6509.609423434609;6515.869682606416;4922.507749225192;5014.398272207359;5016.322796422436;5059.723124593874;5074.2642316864585;6730.259671436236;6737.32626737342;6758.391744742997;6780.762673306608;6805.455563555002;6500.869982600416;6500.902486462613;6506.544541882212;6526.836829079311;6554.541182117206;6318.462930650946;6483.675816209265;6485.740570377132;6514.837129071811;6559.836004099936;6194.287656919512;6349.365063493614;6386.712597933197;6455.126923845843;6499.870002600016;6387.744490220339;6413.877571425075;6445.16212892321;6529.889918713925;6616.037971521359;6016.368281330398;6195.81412557624;6245.250569931455;6365.14070600463;6399.200099987502 04:08:58 INFO - PID 29052 | |5;yui.html;913.6619450803202;929.1034152043277;932.7295084425513;932.7714709896072;943.9480828554429;19288.3249086282;20317.390478285637;20441.284555040576;20555.897220513896;20563.177472901083;18344;18704.906475467604;18730.53173670659;18738.625227495475;18754.624907501875;932.7621456528576;947.1097168661471;955.2024059909984;958.3100167879115;962.1725316228038;975.0931633580767;978.2223132609593;981.018981018981;981.8232718110737;982.076847763104;997.4763249294142;1023.518946095334;1028.963986260481;1033.4161198922623;1034.0590063042632;1029.9330543514648;1031.7265924530006;1032.886382497921;1035.9015893490107;1038.2835843268122;742.9962850185768;749.711361125965;750.53466850553;752.5860776572918;753.4725692015611;19761.802381976282;19896;20021.699674504893;20067.397978060682;20085.39743807688;21626.35120946374;21713.38925721824;22244.777552224434;22248.77751222483;22273.55452890949;18049;18243.81756182448;18263.908680456647;18273.725894111598;18316.63366732658;3703.703703703697;3712.684421824148;3713.1459764254373;3715.7956312402807;3717.1078941054225;138692;139454;139578;140616;142246.28876855652;16731.247093880804;16925.23836427364;17035;17038.914805425895;17096.145192740314;31769.205769855475;31983;32155.678443215736;32156;32223.67776322207;8803.69187078462;8849.91150088491;8904.59929303183;8928.330375221884;8978.461292322481;4101.692373071972;4187.91624167515;4213.852515161954;4218.050938538866;4260.786960651955;5214.947850521522;5363.865903352447;5423.267858839006;5437.075697131418;5451.509364157245;940.8588711693301;960.0207788056143;962.9518524073768;968.8304546704298;970.6554173268529;700.264722041854;702.2100137345486;720.8125887269243;723.4465633790049;726.6621021225155;11335.716607084889;11822.231554948901;12489.875101249054;12885.291308978096;13219.471221151047;698.2354322017383;702.596007295807;715.8568286342648;719.9992011104569;722.4870342057093;5660.85847853807;5662.518685911744;5666.291713535808;5754.136879468113;5789.2763404574425;117241;118158;118799;120119;122316;102376;104576;105364.47317763515;105720;107502.46248768862;90226.54886725525;91299.54350228206;92694.53652731693;92987;93264.53367733117;10555.94722026385;10584.364938103738;10741.570337186426;10759.246852720235;10968.616098436516;42457.787711061246;42555.7872210637;42883.571164287954;44616.33075503805;44758;55692.44307556873;56273;57240.42759572351;57632.71183644055;58024.709876450346;14199.787003195166;14353.067050641675;14525.128492290496;14557.490487832874;14570.85429145695;16805.663886722443;17157;17299.567510811827;17400.303987840343;17530.298788048847;15837.208139593205;16000;16089.839101608834;16186.919065404598;16378.099204543865;14183;14257.786133208218;14340.498082567061;14398.28008599545;14504.05723628003;14874.776878346616;15080.472183473526;15159;15214;15357.23213839326;11113.777724445628;11190.216684831983;11320.943395282971;11716.472758726048;11805.291682499077;12208.511659533875;12234.75530489403;12324.938375308424;12497.18768280059;12614.243145411305 04:08:58 INFO - PID 29052 | __end_tp_report 04:08:58 INFO - PID 29052 | __start_cc_report 04:08:58 INFO - PID 29052 | _x_x_mozilla_cycle_collect,278 04:08:58 INFO - PID 29052 | __end_cc_report 04:08:58 INFO - PID 29052 | __startTimestamp1506337738821__endTimestamp 04:08:58 INFO - PID 29052 | 04:08:58 INFO - PID 29052 | ------- Summary: start ------- 04:08:58 INFO - PID 29052 | Number of tests: 6 04:08:58 INFO - PID 29052 | 04:08:58 INFO - PID 29052 | [#0] dojo.html Cycles:165 Average:6166.38 Median:6396.07 stddev:743.51 (11.6%) stddev-sans-first:705.79 04:08:58 INFO - PID 29052 | Values: 3099.1 3114.0 3114.5 3133.3 3162.9 6084.7 6226.2 6234.8 6309.3 6319.8 6179.6 6213.5 6227.0 6243.7 6266.3 5666.9 5712.5 5746.9 5755.9 5789.3 5790.3 5836.8 5837.5 5859.2 5890.8 5712.3 5724.1 5740.6 5765.0 5814.4 5165.8 5485.2 5592.2 5731.5 5781.5 5609.9 5626.3 5673.5 5723.1 5736.4 6088.3 6156.0 6164.9 6231.7 6266.1 6709.8 6752.2 6766.4 6775.8 6852.1 6728.3 6795.8 6846.7 6885.5 6894.9 6128.6 6283.3 6313.8 6338.3 6350.9 6844.9 6905.4 6912.2 6931.6 6933.0 6503.6 6523.7 6586.8 6630.7 6632.4 6565.7 6639.4 6659.8 6742.5 6781.0 6490.0 6604.2 6612.1 6634.2 6648.8 6627.3 6692.0 6695.2 6748.9 6761.4 5207.9 5309.8 5333.5 5349.3 5357.0 4586.6 4662.0 4711.1 4714.5 4719.4 5668.0 5770.5 5803.0 5834.1 5841.1 6663.9 6716.2 6720.9 6732.2 6793.5 5789.7 5843.5 5852.3 5875.9 5899.9 5769.0 5820.2 5854.6 5871.3 5885.9 6537.3 6561.1 6637.0 6645.6 6650.2 6554.5 6644.3 6651.2 6653.4 6814.7 6346.7 6362.7 6380.6 6397.8 6465.9 6669.0 6691.2 6712.5 6724.3 6736.4 6720.9 6749.6 6759.9 6849.0 6860.7 6375.3 6506.2 6545.5 6591.6 6599.5 6396.1 6510.3 6568.2 6586.2 6600.0 6290.4 6396.3 6438.9 6458.9 6480.0 6577.9 6580.0 6623.8 6676.9 6698.6 6172.5 6335.4 6435.4 6464.6 6477.9 04:08:58 INFO - PID 29052 | 04:08:58 INFO - PID 29052 | [#1] ext.html Cycles:180 Average:37171.83 Median:3547.03 stddev:51636.19 (1455.8%) stddev-sans-first:51709.16 04:08:58 INFO - PID 29052 | Values: 886.0 887.9 913.3 918.6 925.6 40925.4 42567.4 42579.8 42593.4 42632.6 39522.8 39763.8 39899.2 39949.6 39978.8 7108.1 7245.1 7245.7 7253.9 7277.7 7209.9 7342.9 7348.4 7349.0 7353.9 7315.0 7334.1 7339.0 7913.0 8125.7 8002.6 8086.4 8088.0 8094.0 8095.6 7962.8 8070.6 8115.7 8125.0 8126.3 37880.2 38010.8 38211.4 38450.4 38460.0 3495.6 3529.0 3545.3 3548.8 3566.4 31386.0 31606.8 31714.2 31792.7 31943.8 5155.1 5193.0 5203.3 5210.3 5317.1 186897.0 188502.0 188714.0 189035.0 190175.0 43450.0 44433.8 44437.6 49895.5 50266.5 52482.7 53094.7 53138.5 53254.5 53480.0 16634.4 16745.0 16755.0 16770.9 16780.0 13694.5 13710.8 13726.3 13799.9 13830.2 14451.4 14528.3 14582.8 14585.7 14738.8 5789.2 5792.6 5828.6 5907.8 5983.7 997.4 1002.6 1002.9 1019.8 1022.7 22760.8 22953.9 22976.8 23221.5 23281.3 1087.2 1107.6 1110.9 1119.7 1126.1 12182.7 12312.0 12341.1 12367.3 12476.6 217010.0 218174.0 219167.0 219527.0 219684.0 54224.0 54227.5 54447.7 54598.2 54721.2 1378.6 1452.4 1462.4 1469.7 1480.2 22598.2 22616.5 23205.0 23221.0 23236.9 37415.0 37563.0 37860.6 37918.2 38015.8 188993.0 189111.0 189539.0 190829.0 191165.0 31667.7 34276.5 34634.5 35741.8 35999.0 44279.6 44559.6 44846.0 45110.1 45142.0 32387.2 32411.0 32574.3 32656.3 32657.0 31844.7 31994.0 32193.7 32208.4 32213.0 35108.0 36217.6 36509.0 36683.3 36968.3 31543.4 31757.8 32176.5 32320.0 32543.5 23750.6 24051.0 24070.8 24150.0 24316.8 04:08:58 INFO - PID 29052 | 04:08:58 INFO - PID 29052 | [#2] jquery.html Cycles:180 Average:33177.12 Median:22799.77 stddev:77601.37 (340.4%) stddev-sans-first:77780.49 04:08:58 INFO - PID 29052 | Values: 586.6 598.6 602.2 607.0 613.5 21859.7 22717.9 22765.0 22834.5 22891.8 23176.4 24650.3 24662.9 24772.8 24803.4 6650.4 6785.8 6822.1 6833.4 6878.0 6364.5 6649.4 6746.7 6749.6 6755.5 6620.7 6634.0 6653.5 6676.6 6695.1 6598.6 6620.4 6635.4 6665.7 6696.9 5966.3 6152.8 6205.6 6219.8 6234.3 27950.6 28633.4 28698.3 28726.7 28779.3 2004.0 2004.2 2024.0 2029.5 2031.2 17162.7 18392.8 18818.7 18851.7 18857.5 2237.3 2462.5 2473.2 2483.8 2489.1 125238.4 131036.0 131283.0 133993.0 140002.0 14624.4 14855.9 14903.0 15033.5 15178.3 23338.9 23469.8 23598.9 23620.4 23653.4 9323.0 9407.4 9491.4 9496.8 9514.4 8569.8 8570.4 8593.7 8691.7 8759.2 8802.0 8920.2 9038.6 9195.9 9208.3 2743.8 2763.9 2846.9 2855.6 2951.8 953.8 973.7 983.8 1000.9 1001.4 18376.2 18526.6 18667.1 18795.4 18987.9 1043.4 1046.1 1048.8 1059.8 1061.5 10133.6 10294.9 10297.9 10561.3 10562.1 448606.0 456392.0 458997.0 462898.0 468118.0 110924.0 113016.0 113326.0 114595.4 117043.0 1136.5 1143.5 1144.1 1163.8 1169.3 16664.8 16685.2 16749.2 16768.5 16841.1 54229.0 57017.0 57034.0 57436.0 57639.7 66493.0 66733.7 67990.7 68542.7 68702.3 13621.9 13884.8 13958.4 13970.4 14157.0 21192.4 21292.0 21383.9 21655.8 21660.1 16529.8 16716.2 16923.3 17107.1 17368.3 14963.6 14969.7 14991.7 15211.0 15950.4 17253.7 17456.7 17516.2 17555.5 17580.3 13521.3 13685.0 13692.5 13700.9 13701.0 16581.7 16911.9 16925.7 17163.1 17215.2 04:08:58 INFO - PID 29052 | 04:08:58 INFO - PID 29052 | [#3] mootools.html Cycles:180 Average:9485.67 Median:2675.39 stddev:6776.15 (253.3%) stddev-sans-first:6767.07 04:08:58 INFO - PID 29052 | Values: 1274.6 1317.2 1333.9 1335.6 1338.7 12611.7 13158.9 13249.2 15576.4 16068.3 15549.4 15790.4 15873.9 15876.8 15893.8 2571.9 2787.2 2834.5 2835.1 2854.5 2674.4 2676.4 2855.4 2871.5 2877.6 2774.0 2811.8 2816.7 2834.9 2841.4 2728.3 2760.7 2761.0 2781.5 2784.2 2653.0 2663.9 2668.5 2677.9 2680.6 14903.1 15166.2 15240.2 15267.5 15351.8 8202.2 8487.2 8527.4 8574.6 8582.0 5271.3 5577.8 5603.2 5626.7 5648.7 1875.4 1879.5 1930.2 1960.3 1974.4 26573.3 26818.0 26893.3 26961.7 26993.3 6877.2 6892.0 6893.6 6901.8 7242.9 16756.6 16836.3 16851.7 16860.5 16924.3 8067.2 8160.8 8218.0 8236.5 8263.4 6558.4 7309.0 7386.1 7583.8 7618.1 5086.8 5318.7 5515.3 5598.3 5618.4 1547.4 1555.8 1583.8 1594.1 1600.1 863.1 864.3 878.7 881.2 896.8 8220.0 8289.1 8417.7 8463.7 8476.4 965.6 986.5 992.0 996.2 1005.5 5162.9 5204.2 5222.3 5286.8 5330.2 21309.3 21416.3 22014.2 22379.4 22608.7 21436.4 21817.3 22030.6 22143.7 22579.4 11423.9 11763.5 11833.8 11839.2 11871.0 7964.0 8238.5 8347.1 8353.8 8460.9 18576.8 19214.3 19451.3 19750.8 19774.0 19643.9 19895.4 20031.4 20174.8 20365.3 11452.8 11460.9 11567.5 11568.1 11570.4 13875.9 13908.4 13967.9 13996.1 14103.2 11075.7 11314.5 11375.1 11415.3 11632.5 11282.5 11368.8 11391.3 11465.9 11547.5 9932.3 10197.6 10264.1 10266.7 10273.7 7194.5 7239.9 7297.2 7298.5 7405.9 7491.9 7496.2 7538.3 7690.0 7709.5 04:08:58 INFO - PID 29052 | 04:08:58 INFO - PID 29052 | [#4] prototype.html Cycles:180 Average:5505.83 Median:6118.99 stddev:1527.25 (25.0%) stddev-sans-first:1484.71 04:08:58 INFO - PID 29052 | Values: 505.8 528.4 539.6 550.8 553.2 6081.1 6221.4 6240.3 6275.7 6309.8 6066.0 6089.8 6094.1 6143.9 6178.8 4960.0 5000.0 5065.2 5065.2 5066.5 4814.5 5038.6 5050.8 5058.9 5075.9 4966.1 4968.7 5015.4 5018.5 5054.2 4972.9 5020.5 5032.1 5033.5 5064.5 4510.2 4520.6 4521.9 4524.6 4526.1 6070.5 6158.2 6164.6 6171.0 6218.3 5740.6 5742.9 5743.5 5758.8 5767.8 6444.3 6480.8 6547.9 6595.8 6607.8 4888.3 4918.1 4931.7 4933.7 4945.6 6929.5 6951.5 6989.1 7022.2 7025.7 5046.5 5093.1 5126.2 5133.0 5134.9 5101.8 5108.8 5130.9 5145.6 5147.3 5696.3 5719.6 5726.4 5736.9 5756.1 6333.1 6544.5 6660.8 6675.8 6690.9 1714.4 1720.7 1768.9 1770.0 1787.7 1225.9 1254.0 1273.4 1276.6 1284.6 5470.5 5536.5 5551.8 5558.5 5629.7 6585.7 6602.7 6613.4 6708.3 6835.2 5694.9 5728.2 5799.7 5808.3 5809.4 3500.4 3565.9 3567.4 3579.3 3586.4 6419.0 6478.5 6483.6 6507.6 6534.3 6742.4 6815.9 6844.4 6875.2 6967.5 6300.7 6355.4 6404.9 6418.3 6449.7 6642.3 6650.7 6691.2 6779.5 6781.0 6404.0 6545.4 6549.3 6551.8 6588.2 6393.6 6437.2 6471.7 6509.6 6515.9 4922.5 5014.4 5016.3 5059.7 5074.3 6730.3 6737.3 6758.4 6780.8 6805.5 6500.9 6500.9 6506.5 6526.8 6554.5 6318.5 6483.7 6485.7 6514.8 6559.8 6194.3 6349.4 6386.7 6455.1 6499.9 6387.7 6413.9 6445.2 6529.9 6616.0 6016.4 6195.8 6245.3 6365.1 6399.2 04:08:58 INFO - PID 29052 | 04:08:58 INFO - PID 29052 | [#5] yui.html Cycles:180 Average:24035.36 Median:20379.34 stddev:34644.39 (170.0%) stddev-sans-first:34698.08 04:08:58 INFO - PID 29052 | Values: 913.7 929.1 932.7 932.8 943.9 19288.3 20317.4 20441.3 20555.9 20563.2 18344.0 18704.9 18730.5 18738.6 18754.6 932.8 947.1 955.2 958.3 962.2 975.1 978.2 981.0 981.8 982.1 997.5 1023.5 1029.0 1033.4 1034.1 1029.9 1031.7 1032.9 1035.9 1038.3 743.0 749.7 750.5 752.6 753.5 19761.8 19896.0 20021.7 20067.4 20085.4 21626.4 21713.4 22244.8 22248.8 22273.6 18049.0 18243.8 18263.9 18273.7 18316.6 3703.7 3712.7 3713.1 3715.8 3717.1 138692.0 139454.0 139578.0 140616.0 142246.3 16731.2 16925.2 17035.0 17038.9 17096.1 31769.2 31983.0 32155.7 32156.0 32223.7 8803.7 8849.9 8904.6 8928.3 8978.5 4101.7 4187.9 4213.9 4218.1 4260.8 5214.9 5363.9 5423.3 5437.1 5451.5 940.9 960.0 963.0 968.8 970.7 700.3 702.2 720.8 723.4 726.7 11335.7 11822.2 12489.9 12885.3 13219.5 698.2 702.6 715.9 720.0 722.5 5660.9 5662.5 5666.3 5754.1 5789.3 117241.0 118158.0 118799.0 120119.0 122316.0 102376.0 104576.0 105364.5 105720.0 107502.5 90226.5 91299.5 92694.5 92987.0 93264.5 10555.9 10584.4 10741.6 10759.2 10968.6 42457.8 42555.8 42883.6 44616.3 44758.0 55692.4 56273.0 57240.4 57632.7 58024.7 14199.8 14353.1 14525.1 14557.5 14570.9 16805.7 17157.0 17299.6 17400.3 17530.3 15837.2 16000.0 16089.8 16186.9 16378.1 14183.0 14257.8 14340.5 14398.3 14504.1 14874.8 15080.5 15159.0 15214.0 15357.2 11113.8 11190.2 11320.9 11716.5 11805.3 12208.5 12234.8 12324.9 12497.2 12614.2 04:08:58 INFO - PID 29052 | -------- Summary: end -------- 04:08:58 INFO - PID 29052 | 04:08:59 INFO - TEST-INFO | 29052: exit 0 04:08:59 INFO - TEST-OK | dromaeo_css | took 1113132ms 04:08:59 INFO - TEST-START | kraken 04:08:59 INFO - Initialising browser for kraken test... 04:08:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35315/getInfo.html -profile /tmp/tmpDiwhK_/profile 04:08:59 INFO - TEST-INFO | started process 29438 (/builds/slave/test/build/application/firefox/firefox http://localhost:35315/getInfo.html) 04:09:05 INFO - TEST-INFO | 29438: exit 0 04:09:05 INFO - Browser initialized. 04:09:05 INFO - Running cycle 1/1 for kraken test... 04:09:05 INFO - Using env: {'DISPLAY': ':0', 04:09:05 INFO - 'HOME': '/home/cltbld', 04:09:05 INFO - 'JSGC_DISABLE_POISONING': '1', 04:09:05 INFO - 'LANG': 'en_US.UTF-8', 04:09:05 INFO - 'LANGUAGE': 'en_US:en', 04:09:05 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:09:05 INFO - 'LOGNAME': 'cltbld', 04:09:05 INFO - 'MAIL': '/var/mail/cltbld', 04:09:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:09:05 INFO - 'MOZ_ACCELERATED': '1', 04:09:05 INFO - 'MOZ_CRASHREPORTER': '1', 04:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:05 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:09:05 INFO - 'MOZ_NO_REMOTE': '1', 04:09:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:05 INFO - 'MOZ_WEBRENDER': '1', 04:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:05 INFO - 'NO_EM_RESTART': '1', 04:09:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:05 INFO - 'PWD': '/builds/slave/test', 04:09:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:05 INFO - 'RUST_BACKTRACE': 'full', 04:09:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:09:05 INFO - 'SHELL': '/bin/bash', 04:09:05 INFO - 'SHLVL': '1', 04:09:05 INFO - 'TERM': 'linux', 04:09:05 INFO - 'TMOUT': '86400', 04:09:05 INFO - 'USER': 'cltbld', 04:09:05 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506336406.831786-777331707', 04:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:05 INFO - '_': '/tools/buildbot/bin/python'} 04:09:05 INFO - TEST-INFO | started process 29685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDiwhK_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:06 INFO - PID 29685 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:09:06 INFO - PID 29685 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:09:06 INFO - PID 29685 | 04:09:06 INFO - PID 29685 | (/builds/slave/test/build/application/firefox/firefox:29744): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:09:06 INFO - PID 29685 | 04:09:17 INFO - PID 29685 | RSS: Main: 187858944 04:09:17 INFO - PID 29685 | 04:09:19 INFO - PID 29685 | Cycle 1(1): loaded http://localhost:35315/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35315/tests/kraken/driver.html?testName=audio-beat-detection) 04:09:20 INFO - PID 29685 | RSS: Main: 186650624 04:09:20 INFO - PID 29685 | 04:09:23 INFO - PID 29685 | Cycle 1(1): loaded http://localhost:35315/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35315/tests/kraken/driver.html?testName=audio-dft) 04:09:24 INFO - PID 29685 | RSS: Main: 187289600 04:09:24 INFO - PID 29685 | 04:09:27 INFO - PID 29685 | Cycle 1(1): loaded http://localhost:35315/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35315/tests/kraken/driver.html?testName=audio-fft) 04:09:27 INFO - PID 29685 | RSS: Main: 184545280 04:09:27 INFO - PID 29685 | 04:09:29 INFO - PID 29685 | Cycle 1(1): loaded http://localhost:35315/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35315/tests/kraken/driver.html?testName=audio-oscillator) 04:09:30 INFO - PID 29685 | RSS: Main: 184422400 04:09:30 INFO - PID 29685 | 04:09:32 INFO - PID 29685 | Cycle 1(1): loaded http://localhost:35315/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35315/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:09:33 INFO - PID 29685 | RSS: Main: 185769984 04:09:33 INFO - PID 29685 | 04:09:36 INFO - PID 29685 | Cycle 1(1): loaded http://localhost:35315/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35315/tests/kraken/driver.html?testName=imaging-darkroom) 04:09:37 INFO - PID 29685 | RSS: Main: 187572224 04:09:37 INFO - PID 29685 | 04:09:40 INFO - PID 29685 | Cycle 1(1): loaded http://localhost:35315/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35315/tests/kraken/driver.html?testName=imaging-desaturate) 04:09:41 INFO - PID 29685 | RSS: Main: 187539456 04:09:41 INFO - PID 29685 | 04:09:44 INFO - PID 29685 | Cycle 1(1): loaded http://localhost:35315/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35315/tests/kraken/driver.html?testName=json-parse-financial) 04:09:45 INFO - PID 29685 | RSS: Main: 187490304 04:09:45 INFO - PID 29685 | 04:09:46 INFO - PID 29685 | Cycle 1(1): loaded http://localhost:35315/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35315/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:09:47 INFO - PID 29685 | RSS: Main: 188141568 04:09:47 INFO - PID 29685 | 04:09:49 INFO - PID 29685 | Cycle 1(1): loaded http://localhost:35315/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35315/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:09:49 INFO - PID 29685 | RSS: Main: 187908096 04:09:49 INFO - PID 29685 | 04:09:51 INFO - PID 29685 | Cycle 1(1): loaded http://localhost:35315/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35315/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:09:52 INFO - PID 29685 | RSS: Main: 186875904 04:09:52 INFO - PID 29685 | 04:09:55 INFO - PID 29685 | Cycle 1(1): loaded http://localhost:35315/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:09:55 INFO - PID 29685 | RSS: Main: 188063744 04:09:55 INFO - PID 29685 | 04:09:58 INFO - PID 29685 | Cycle 1(1): loaded http://localhost:35315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:09:59 INFO - PID 29685 | RSS: Main: 188616704 04:09:59 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | Cycle 1(1): loaded http://localhost:35315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35315/tests/kraken/driver.html?testName=ai-astar) 04:10:01 INFO - PID 29685 | RSS: Main: 189632512 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | __start_tp_report 04:10:01 INFO - PID 29685 | _x_x_mozilla_page_load 04:10:01 INFO - PID 29685 | _x_x_mozilla_page_load_details 04:10:01 INFO - PID 29685 | |i|pagename|runs| 04:10:01 INFO - PID 29685 | |0;ai-astar;107;108;106;108;115;116;113;107;113;110 04:10:01 INFO - PID 29685 | |1;audio-beat-detection;132;115;124;121;139;128;132;125;119;123 04:10:01 INFO - PID 29685 | |2;audio-dft;167;163;163;163;176;169;169;172;162;170 04:10:01 INFO - PID 29685 | |3;audio-fft;78;79;74;80;75;85;74;74;81;79 04:10:01 INFO - PID 29685 | |4;audio-oscillator;82;85;88;80;87;83;90;80;82;84 04:10:01 INFO - PID 29685 | |5;imaging-gaussian-blur;120;116;114;111;118;119;115;127;115;119 04:10:01 INFO - PID 29685 | |6;imaging-darkroom;156;147;151;148;158;148;155;150;149;147 04:10:01 INFO - PID 29685 | |7;imaging-desaturate;102;106;94;100;95;99;96;99;95;95 04:10:01 INFO - PID 29685 | |8;json-parse-financial;55;53;59;54;55;59;55;64;54;53 04:10:01 INFO - PID 29685 | |9;json-stringify-tinderbox;45;46;47;44;43;45;39;42;43;37 04:10:01 INFO - PID 29685 | |10;stanford-crypto-aes;78;77;73;79;82;77;76;78;73;78 04:10:01 INFO - PID 29685 | |11;stanford-crypto-ccm;127;113;117;129;114;118;123;117;111;117 04:10:01 INFO - PID 29685 | |12;stanford-crypto-pbkdf2;173;171;170;164;168;174;167;170;172;179 04:10:01 INFO - PID 29685 | |13;stanford-crypto-sha256-iterative;66;67;65;69;65;62;63;64;64;64 04:10:01 INFO - PID 29685 | __end_tp_report 04:10:01 INFO - PID 29685 | __start_cc_report 04:10:01 INFO - PID 29685 | _x_x_mozilla_cycle_collect,731 04:10:01 INFO - PID 29685 | __end_cc_report 04:10:01 INFO - PID 29685 | __startTimestamp1506337801528__endTimestamp 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | ------- Summary: start ------- 04:10:01 INFO - PID 29685 | Number of tests: 14 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.65 (3.3%) stddev-sans-first:3.67 04:10:01 INFO - PID 29685 | Values: 107.0 108.0 106.0 108.0 115.0 116.0 113.0 107.0 113.0 110.0 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | [#1] audio-beat-detection Cycles:10 Average:125.80 Median:126.50 stddev:7.10 (5.6%) stddev-sans-first:7.17 04:10:01 INFO - PID 29685 | Values: 132.0 115.0 124.0 121.0 139.0 128.0 132.0 125.0 119.0 123.0 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | [#2] audio-dft Cycles:10 Average:167.40 Median:169.00 stddev:4.65 (2.8%) stddev-sans-first:4.93 04:10:01 INFO - PID 29685 | Values: 167.0 163.0 163.0 163.0 176.0 169.0 169.0 172.0 162.0 170.0 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | [#3] audio-fft Cycles:10 Average:77.90 Median:79.00 stddev:3.67 (4.6%) stddev-sans-first:3.89 04:10:01 INFO - PID 29685 | Values: 78.0 79.0 74.0 80.0 75.0 85.0 74.0 74.0 81.0 79.0 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | [#4] audio-oscillator Cycles:10 Average:84.10 Median:84.50 stddev:3.38 (4.0%) stddev-sans-first:3.50 04:10:01 INFO - PID 29685 | Values: 82.0 85.0 88.0 80.0 87.0 83.0 90.0 80.0 82.0 84.0 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.50 stddev:4.35 (3.7%) stddev-sans-first:4.51 04:10:01 INFO - PID 29685 | Values: 120.0 116.0 114.0 111.0 118.0 119.0 115.0 127.0 115.0 119.0 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:150.50 stddev:4.01 (2.7%) stddev-sans-first:3.81 04:10:01 INFO - PID 29685 | Values: 156.0 147.0 151.0 148.0 158.0 148.0 155.0 150.0 149.0 147.0 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | [#7] imaging-desaturate Cycles:10 Average:98.10 Median:95.00 stddev:3.84 (4.0%) stddev-sans-first:3.81 04:10:01 INFO - PID 29685 | Values: 102.0 106.0 94.0 100.0 95.0 99.0 96.0 99.0 95.0 95.0 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.00 stddev:3.51 (6.4%) stddev-sans-first:3.70 04:10:01 INFO - PID 29685 | Values: 55.0 53.0 59.0 54.0 55.0 59.0 55.0 64.0 54.0 53.0 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | [#9] json-stringify-tinderbox Cycles:10 Average:43.10 Median:44.50 stddev:3.11 (7.0%) stddev-sans-first:3.22 04:10:01 INFO - PID 29685 | Values: 45.0 46.0 47.0 44.0 43.0 45.0 39.0 42.0 43.0 37.0 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:78.00 stddev:2.69 (3.4%) stddev-sans-first:2.83 04:10:01 INFO - PID 29685 | Values: 78.0 77.0 73.0 79.0 82.0 77.0 76.0 78.0 73.0 78.0 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:117.50 stddev:5.93 (5.0%) stddev-sans-first:5.45 04:10:01 INFO - PID 29685 | Values: 127.0 113.0 117.0 129.0 114.0 118.0 123.0 117.0 111.0 117.0 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:171.50 stddev:4.13 (2.4%) stddev-sans-first:4.30 04:10:01 INFO - PID 29685 | Values: 173.0 171.0 170.0 164.0 168.0 174.0 167.0 170.0 172.0 179.0 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:2.02 (3.1%) stddev-sans-first:2.11 04:10:01 INFO - PID 29685 | Values: 66.0 67.0 65.0 69.0 65.0 62.0 63.0 64.0 64.0 64.0 04:10:01 INFO - PID 29685 | -------- Summary: end -------- 04:10:01 INFO - PID 29685 | 04:10:01 INFO - PID 29685 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:10:02 INFO - TEST-INFO | 29685: exit 0 04:10:02 INFO - TEST-OK | kraken | took 62649ms 04:10:02 INFO - SUITE-END | took 1175s 04:10:02 INFO - Completed test suite (00:19:36) 04:10:02 INFO - javascript benchmark 04:10:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8494.808423372573, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.132242971968, 3113.968860311397, 3114.486109791886, 3133.279345750476, 3162.873485060598, 6084.695765211733, 6226.221722284715, 6234.84412889678, 6309.3375195604485, 6319.810405687826, 6179.5674302798825, 6213.502919766419, 6227.034809604518, 6243.71903264353, 6266.342034086424, 5666.9433305667035, 5712.485876271135, 5746.942530574683, 5755.856103597413, 5789.2763404574425, 5790.276215473066, 5836.824895253128, 5837.50381217597, 5859.238299021121, 5890.764369425217, 5712.257406537145, 5724.055530837407, 5740.569457290699, 5765.0, 5814.4185581441725, 5165.845024649267, 5485.232067510552, 5592.217089607459, 5731.484166425042, 5781.479666830005, 5609.915851262234, 5626.324841019063, 5673.461021202979, 5723.112917497794, 5736.397678243766, 6088.299845517734, 6155.984262596666, 6164.907526387108, 6231.688415579203, 6266.091416744592, 6709.832254193684, 6752.2234942981695, 6766.391024807791, 6775.796726098225, 6852.109225800664, 6728.259891411941, 6795.7961261162245, 6846.691898864513, 6885.483588730815, 6894.862102757967, 6128.601640893327, 6283.3088360280335, 6313.779017734403, 6338.334474880164, 6350.904736428957, 6844.931550684529, 6905.37851593359, 6912.205096413977, 6931.584104953618, 6933.0, 6503.642299673564, 6523.7064332105165, 6586.769463068769, 6630.734770609218, 6632.369924857131, 6565.67171641416, 6639.43564796988, 6659.833504162338, 6742.5280230383405, 6780.966095169492, 6490.0, 6604.240512341046, 6612.140421745143, 6634.23706273775, 6648.767293144813, 6627.271000189975, 6691.966540167366, 6695.230048544479, 6748.865022699519, 6761.357671021246, 5207.947920520746, 5309.787608495617, 5333.466653334713, 5349.304590403222, 5356.973215133899, 4586.633069354443, 4662.020975595163, 4711.081339138835, 4714.481407045222, 4719.38647975761, 5667.971660141673, 5770.480656740913, 5803.0, 5834.066549352084, 5841.094630332305, 6663.900041499382, 6716.227633822075, 6720.932790672128, 6732.192136943598, 6793.524453288322, 5789.710514474259, 5843.474087332161, 5852.297724273115, 5875.853103672443, 5899.882002359929, 5769.0, 5820.214271073351, 5854.619449735838, 5871.266091738533, 5885.882282354329, 6537.346265373425, 6561.1142495763415, 6636.966815165893, 6645.634490102994, 6650.20197576294, 6554.541182117397, 6644.335566443317, 6651.235107962646, 6653.434458071119, 6814.727410903508, 6346.682665866781, 6362.681865906594, 6380.617162970237, 6397.808065758035, 6465.870682586416, 6669.0, 6691.1636045494315, 6712.463002959849, 6724.327567243236, 6736.360045795642, 6720.865582688221, 6749.628770417674, 6759.898601521079, 6849.0, 6860.656967151723, 6375.330590287953, 6506.186726659168, 6545.541812073109, 6591.6374599397495, 6599.4720422365135, 6396.072569477493, 6510.283868774336, 6568.1789776277965, 6586.176727909012, 6600.0, 6290.370962903673, 6396.29640739509, 6438.903416448663, 6458.903116453163, 6480.027995800668, 6577.868442631217, 6579.967100164468, 6623.768168114093, 6676.89984650221, 6698.5980841149685, 6172.506199504119, 6335.429811317003, 6435.420812126931, 6464.644444555594, 6477.902831457438], "value": 6109.513624853308, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [885.991140088599, 887.9067697891722, 913.2876356441977, 918.5866360137937, 925.5603588295564, 40925.38611920823, 42567.36148957764, 42579.78710106449, 42593.36109958353, 42632.57367426325, 39522.8023859881, 39763.80118099406, 39899.202015959665, 39949.60050399495, 39978.8001059995, 7108.0759501264765, 7245.130584329861, 7245.710171593157, 7253.891191632129, 7277.672504737299, 7209.89185162223, 7342.926570734277, 7348.3753880920185, 7349.0, 7353.852922941538, 7314.963425182867, 7334.119905611334, 7338.9633051834935, 7912.960435197816, 8125.674973001072, 8002.559859207741, 8086.353091752704, 8087.959560202161, 8094.0, 8095.5952202389935, 7962.761117166494, 8070.596470176526, 8115.715949941783, 8124.959375203086, 8126.268635822746, 37880.242395151945, 38010.809945950095, 38211.42682859759, 38450.42324365137, 38460.0, 3495.5805303363504, 3529.047157267549, 3545.308664810363, 3548.7515873888838, 3566.3937130687846, 31386.0, 31606.841965790252, 31714.207144821332, 31792.682073179203, 31943.84028079868, 5155.097857874857, 5193.013327467769, 5203.271541984125, 5210.296609957645, 5317.096093664087, 186897.0, 188502.0, 188714.0, 189035.0, 190175.04912475488, 43450.0, 44433.77783111064, 44437.55562444399, 49895.50104498908, 50266.48667566607, 52482.73758631182, 53094.73452632789, 53138.46861531412, 53254.46745532573, 53480.0, 16634.417795377347, 16745.0, 16755.0, 16770.916145419196, 16780.0, 13694.52069177574, 13710.794338084937, 13726.313684315945, 13799.931000344934, 13830.23933683657, 14451.421943122368, 14528.273586320642, 14582.76046536035, 14585.708285834224, 14738.778918316233, 5789.247397838254, 5792.565557583198, 5828.621139625996, 5907.822765317047, 5983.670898100646, 997.3666721631671, 1002.6490728245055, 1002.9398236105857, 1019.8062368150028, 1022.7443139215196, 22760.772392276198, 22953.885230574073, 22976.770232297797, 23221.53556928886, 23281.301560953198, 1087.1846115413439, 1107.645553422913, 1110.9444527773578, 1119.6641007697658, 1126.0822429719751, 12182.695432614255, 12312.0, 12341.13612047166, 12367.319797411048, 12476.625701228797, 217010.0, 218174.0, 219167.0, 219527.0, 219684.0, 54224.0, 54227.45772542224, 54447.72776136173, 54598.18102728462, 54721.1791823123, 1378.6070969773566, 1452.3609611770787, 1462.3711803924202, 1469.7134058858633, 1480.156310902775, 22598.209062682727, 22616.547669046857, 23205.0, 23221.0, 23236.883815580815, 37415.0, 37563.0, 37860.62139378681, 37918.241635167695, 38015.80992095022, 188993.0, 189111.0, 189539.0, 190829.0, 191165.0, 31667.683323166475, 34276.48585271273, 34634.48048279227, 35741.82129089338, 35999.0, 44279.55720442755, 44559.55440445684, 44846.0, 45110.09779804451, 45142.0, 32387.19032024218, 32411.0, 32574.34851303008, 32656.34687306193, 32657.0, 31844.68155318417, 31994.0, 32193.678063219068, 32208.355832882742, 32213.03360899177, 35108.0, 36217.63782362143, 36509.0, 36683.266334672626, 36968.26063478662, 31543.369132617678, 31757.8412107938, 32176.517352239265, 32320.0, 32543.51184732278, 23750.643740343563, 24051.0, 24070.75929240755, 24150.033998639858, 24316.75683243216], "value": 17251.73750192482, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.6392168816177, 598.6228675934161, 602.1539736669979, 606.9848253793657, 613.4724137241972, 21859.67210491842, 22717.886410567946, 22764.999999999978, 22834.54330913385, 22891.77108228917, 23176.42058948527, 24650.260492185218, 24662.876685616593, 24772.752272477315, 24803.379915502075, 6650.401463868251, 6785.76249831256, 6822.147231596051, 6833.350831670983, 6878.0, 6364.49084073273, 6649.368310010541, 6746.730130794763, 6749.561278516905, 6755.4933379996455, 6620.735170593171, 6633.966830165842, 6653.53425260232, 6676.632785196813, 6695.129633147684, 6598.604083754966, 6620.371064748865, 6635.435987941007, 6665.666716664147, 6696.8995465068065, 5966.254218222723, 6152.78465253714, 6205.596636218631, 6219.782307619257, 6234.251889773211, 27950.580741288693, 28633.427331453255, 28698.282542936595, 28726.712732872613, 28779.28051798701, 2004.0280463974962, 2004.2183548416128, 2024.0, 2029.4723371923258, 2031.1672214392177, 17162.742558861628, 18392.816071839377, 18818.717719234224, 18851.71722424165, 18857.528561785926, 2237.3176181264707, 2462.4705688276927, 2473.245660073677, 2483.801295896324, 2489.0790407549143, 125238.37380813129, 131036.0, 131283.0, 133993.0, 140001.99999999898, 14624.435109792614, 14855.92572037133, 14903.0, 15033.548993529992, 15178.31697573612, 23338.883305583364, 23469.7653023471, 23598.88200558986, 23620.409489762893, 23653.408664783517, 9322.953385233166, 9407.43555386679, 9491.38306010107, 9496.762580935394, 9514.38156519824, 8569.828603427897, 8570.357223208284, 8593.742187734379, 8691.739247822576, 8759.211670949646, 8802.0, 8920.24177944882, 9038.559588911088, 9195.862062069074, 9208.26333893287, 2743.7942154338502, 2763.903263385772, 2846.8576571171357, 2855.614492043589, 2951.778616603763, 953.8092381523722, 973.732223638505, 983.8327484327682, 1000.8798944126752, 1001.4041645221082, 18376.173072211783, 18526.629467410847, 18667.066646667885, 18795.436136915916, 18987.860728356343, 1043.410473082706, 1046.0585473074293, 1048.8479170520231, 1059.8251288537306, 1061.532925512772, 10133.594656213669, 10294.948525257476, 10297.94851025755, 10561.260711750258, 10562.102221311121, 448606.0, 456392.0, 458997.0, 462898.0, 468118.0, 110924.0, 113016.0, 113326.0, 114595.42702286436, 117043.0, 1136.4885801389573, 1143.4511434511314, 1144.079016391796, 1163.8486996690376, 1169.2692067457838, 16664.83335166633, 16685.249163787415, 16749.162541872614, 16768.496945091665, 16841.073740944365, 54229.0, 57017.0, 57034.0, 57436.0, 57639.711801440724, 66493.0, 66733.66633166804, 67990.66004669946, 68542.65728671524, 68702.3129768696, 13621.863781362059, 13884.791728123884, 13958.441662333393, 13970.441182352999, 14157.0, 21192.36422907315, 21292.0, 21383.89308053512, 21655.783442165375, 21660.133594656036, 16529.752053719443, 16716.164191790605, 16923.323067077177, 17107.14464276806, 17368.305267789146, 14963.551093467213, 14969.700605988037, 14991.700165996837, 15211.011284266488, 15950.361985520449, 17253.74119388185, 17456.650866982844, 17516.211770470614, 17555.473335799947, 17580.296788128333, 13521.256330901895, 13685.0, 13692.45230190821, 13700.862991370357, 13700.97242706781, 16581.668366632843, 16911.91544042272, 16925.746113808058, 17163.141842908055, 17215.225314861113], "value": 11653.652664744737, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1274.6430999320191, 1317.2425855133301, 1333.926634035128, 1335.5993202039385, 1338.698792771626, 12611.747765044694, 13158.868411315883, 13249.205047697145, 15576.376944922218, 16068.27692753826, 15549.378024879019, 15790.4473343433, 15873.92063039686, 15876.841231587681, 15893.761593576077, 2571.90998315059, 2787.1917144028207, 2834.54647256439, 2835.050258163518, 2854.4861924853517, 2674.371522692166, 2676.411189538308, 2855.3718181999925, 2871.511842986687, 2877.553979133227, 2774.0429551804596, 2811.7610003149757, 2816.6760822505366, 2834.9433011339866, 2841.4317136572663, 2728.2633688904084, 2760.6687197536326, 2761.047438633668, 2781.5132351838447, 2784.1786672931535, 2653.0165116418043, 2663.933401664974, 2668.546347120994, 2677.8928842846262, 2680.584509401046, 14903.105813651217, 15166.24168791567, 15240.161791101486, 15267.541973740805, 15351.769723454157, 8202.179782021809, 8487.193716596914, 8527.445716028438, 8574.571271436465, 8581.95709021451, 5271.262023316739, 5577.776888924438, 5603.159526071122, 5626.746796394172, 5648.6893220872835, 1875.3623767918973, 1879.52072221584, 1930.1954012722313, 1960.2746983616012, 1974.3780709076739, 26573.33566660849, 26818.0, 26893.32766680829, 26961.730382696314, 26993.32516687079, 6877.209120951155, 6892.0, 6893.620850853251, 6901.764717506784, 7242.891356629655, 16756.581085472717, 16836.32654693823, 16851.74722379165, 16860.494185174466, 16924.323027079026, 8067.193280671886, 8160.755177344689, 8217.95891020541, 8236.50580965132, 8263.380246481538, 6558.442532384705, 7309.0, 7386.113666359964, 7583.7724868254045, 7618.085829700472, 5086.847394578169, 5318.7074710891275, 5515.25544051556, 5598.272224610774, 5618.353889302701, 1547.3810475809767, 1555.844415558435, 1583.8099428068706, 1594.131198496822, 1600.0719582642039, 863.0937515608585, 864.3085531574715, 878.7188099808128, 881.2201201936333, 896.7623579751371, 8220.0, 8289.129641387688, 8417.70538031166, 8463.66145354179, 8476.449030812977, 965.5558443116245, 986.541258314887, 991.9752006199758, 996.1881066930429, 1005.5374527717186, 5162.896742065138, 5204.193350030751, 5222.268882356473, 5286.788528458896, 5330.200469929541, 21309.25417610407, 21416.250431234832, 22014.229501967355, 22379.44051398728, 22608.660870086962, 21436.356909292434, 21817.345479635635, 22030.559388812453, 22143.667844982338, 22579.43551411195, 11423.942880285545, 11763.470643821049, 11833.822492662617, 11839.171258011856, 11871.0, 7963.960180199062, 8238.50568965864, 8347.081820999563, 8353.791155221168, 8460.873086903579, 18576.81423185805, 19214.327498537485, 19451.3192038278, 19750.80249197547, 19774.0, 19643.901780491007, 19895.403137905887, 20031.39905802828, 20174.79825201729, 20365.287214948, 11452.770944581229, 11460.885391145981, 11567.537298507965, 11568.13239007061, 11570.421478926188, 13875.861241387456, 13908.37412316428, 13967.860321396656, 13996.090254133449, 14103.224322662352, 11075.667729968114, 11314.490847911698, 11375.089992800722, 11415.258008229439, 11632.476538555617, 11282.548698051985, 11368.772624547628, 11391.316521008766, 11465.885341146815, 11547.538098475967, 9932.304738668225, 10197.592096316064, 10264.127549158406, 10266.691999240034, 10273.691789246335, 7194.532355396883, 7239.8914016288745, 7297.16082650502, 7298.452616053711, 7405.925940740739, 7491.913672517346, 7496.1754207038275, 7538.295620219411, 7690.038745156856, 7709.4603377763015], "value": 6783.237614852149, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.84571705629793, 528.3554064041869, 539.6222644149092, 550.7934524553292, 553.239295968044, 6081.148639190511, 6221.408966148214, 6240.251169859612, 6275.686215689215, 6309.810705678826, 6065.969670151654, 6089.817305480831, 6094.052779830996, 6143.931256713207, 6178.752849885999, 4959.950400495994, 5000.0, 5065.1642478990925, 5065.214891691794, 5066.493350664941, 4814.470408255089, 5038.598945711648, 5050.838307189349, 5058.873528161807, 5075.949240507584, 4966.106100901836, 4968.677035992667, 5015.423226328982, 5018.498150184971, 5054.1660625996665, 4972.8508144755715, 5020.468757029104, 5032.119379108678, 5033.471485494026, 5064.518870707277, 4510.233260345716, 4520.621210530787, 4521.932171017437, 4524.5927866492175, 4526.117407105616, 6070.453659170652, 6158.230221222348, 6164.599301045418, 6171.0, 6218.347073557256, 5740.56945729072, 5742.856428589277, 5743.4543718346695, 5758.827235182951, 5767.769289228426, 6444.258910225337, 6480.773172938972, 6547.9017814732815, 6595.8021259362295, 6607.8017659469815, 4888.340074089988, 4918.090153321611, 4931.67944083637, 4933.703977761345, 4945.629077819142, 6929.549579277331, 6951.478639102037, 6989.078003549064, 7022.1573411190475, 7025.683844227022, 5046.47012063728, 5093.1087059764395, 5126.2054381570915, 5133.0, 5134.922976155361, 5101.821436249787, 5108.795648174106, 5130.897382052338, 5145.639805213599, 5147.3308469898675, 5696.259486266842, 5719.628224165499, 5726.398728133569, 5736.885262294814, 5756.079027355603, 6333.068414133733, 6544.509161812788, 6660.800175994728, 6675.7997260082275, 6690.899636505456, 1714.3970387687552, 1720.6644704282794, 1768.9027103509172, 1769.9645707261395, 1787.6692811829853, 1225.8835410635975, 1253.9623811285676, 1273.4396865379204, 1276.5914907229783, 1284.6274580371587, 5470.507654311052, 5536.474034966672, 5551.833444996657, 5558.471945165203, 5629.746661400247, 6585.703643336062, 6602.735890564323, 6613.404793568602, 6708.3291670833505, 6835.179778426621, 5694.946434909555, 5728.1694154348215, 5799.739011744482, 5808.303003639506, 5809.448102430262, 3500.4423031750625, 3565.9286814264087, 3567.375709250871, 3579.3378225028455, 3586.3544561978574, 6418.967905160444, 6478.546501744832, 6483.610983341015, 6507.577007494498, 6534.313897040837, 6742.39318461331, 6815.863682726318, 6844.4182244508775, 6875.243723190445, 6967.512274140761, 6300.747970081237, 6355.3644635536075, 6404.871902561923, 6418.26189988148, 6449.7097630605795, 6642.335766423319, 6650.700718467584, 6691.1636045494315, 6779.457643388616, 6781.0, 6404.039394090923, 6545.37818907203, 6549.279579246374, 6551.770688026087, 6588.209414870246, 6393.584417012879, 6437.163168788027, 6471.708773105127, 6509.609423434609, 6515.869682606416, 4922.507749225192, 5014.398272207359, 5016.322796422436, 5059.723124593874, 5074.2642316864585, 6730.259671436236, 6737.32626737342, 6758.391744742997, 6780.762673306608, 6805.455563555002, 6500.869982600416, 6500.902486462613, 6506.544541882212, 6526.836829079311, 6554.541182117206, 6318.462930650946, 6483.675816209265, 6485.740570377132, 6514.837129071811, 6559.836004099936, 6194.287656919512, 6349.365063493614, 6386.712597933197, 6455.126923845843, 6499.870002600016, 6387.744490220339, 6413.877571425075, 6445.16212892321, 6529.889918713925, 6616.037971521359, 6016.368281330398, 6195.81412557624, 6245.250569931455, 6365.14070600463, 6399.200099987502], "value": 5063.407289449986, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [913.6619450803202, 929.1034152043277, 932.7295084425513, 932.7714709896072, 943.9480828554429, 19288.3249086282, 20317.390478285637, 20441.284555040576, 20555.897220513896, 20563.177472901083, 18344.0, 18704.906475467604, 18730.53173670659, 18738.625227495475, 18754.624907501875, 932.7621456528576, 947.1097168661471, 955.2024059909984, 958.3100167879115, 962.1725316228038, 975.0931633580767, 978.2223132609593, 981.018981018981, 981.8232718110737, 982.076847763104, 997.4763249294142, 1023.518946095334, 1028.963986260481, 1033.4161198922623, 1034.0590063042632, 1029.9330543514648, 1031.7265924530006, 1032.886382497921, 1035.9015893490107, 1038.2835843268122, 742.9962850185768, 749.711361125965, 750.53466850553, 752.5860776572918, 753.4725692015611, 19761.802381976282, 19896.0, 20021.699674504893, 20067.397978060682, 20085.39743807688, 21626.35120946374, 21713.38925721824, 22244.777552224434, 22248.77751222483, 22273.55452890949, 18049.0, 18243.81756182448, 18263.908680456647, 18273.725894111598, 18316.63366732658, 3703.703703703697, 3712.684421824148, 3713.1459764254373, 3715.7956312402807, 3717.1078941054225, 138692.0, 139454.0, 139578.0, 140616.0, 142246.28876855652, 16731.247093880804, 16925.23836427364, 17035.0, 17038.914805425895, 17096.145192740314, 31769.205769855475, 31983.0, 32155.678443215736, 32156.0, 32223.67776322207, 8803.69187078462, 8849.91150088491, 8904.59929303183, 8928.330375221884, 8978.461292322481, 4101.692373071972, 4187.91624167515, 4213.852515161954, 4218.050938538866, 4260.786960651955, 5214.947850521522, 5363.865903352447, 5423.267858839006, 5437.075697131418, 5451.509364157245, 940.8588711693301, 960.0207788056143, 962.9518524073768, 968.8304546704298, 970.6554173268529, 700.264722041854, 702.2100137345486, 720.8125887269243, 723.4465633790049, 726.6621021225155, 11335.716607084889, 11822.231554948901, 12489.875101249054, 12885.291308978096, 13219.471221151047, 698.2354322017383, 702.596007295807, 715.8568286342648, 719.9992011104569, 722.4870342057093, 5660.85847853807, 5662.518685911744, 5666.291713535808, 5754.136879468113, 5789.2763404574425, 117241.0, 118158.0, 118799.0, 120119.0, 122316.0, 102376.0, 104576.0, 105364.47317763515, 105720.0, 107502.46248768862, 90226.54886725525, 91299.54350228206, 92694.53652731693, 92987.0, 93264.53367733117, 10555.94722026385, 10584.364938103738, 10741.570337186426, 10759.246852720235, 10968.616098436516, 42457.787711061246, 42555.7872210637, 42883.571164287954, 44616.33075503805, 44758.0, 55692.44307556873, 56273.0, 57240.42759572351, 57632.71183644055, 58024.709876450346, 14199.787003195166, 14353.067050641675, 14525.128492290496, 14557.490487832874, 14570.85429145695, 16805.663886722443, 17157.0, 17299.567510811827, 17400.303987840343, 17530.298788048847, 15837.208139593205, 16000.0, 16089.839101608834, 16186.919065404598, 16378.099204543865, 14183.0, 14257.786133208218, 14340.498082567061, 14398.28008599545, 14504.05723628003, 14874.776878346616, 15080.472183473526, 15159.0, 15214.0, 15357.23213839326, 11113.777724445628, 11190.216684831983, 11320.943395282971, 11716.472758726048, 11805.291682499077, 12208.511659533875, 12234.75530489403, 12324.938375308424, 12497.18768280059, 12614.243145411305], "value": 8906.657745599232, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1462.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 108.0, 106.0, 108.0, 115.0, 116.0, 113.0, 107.0, 113.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 115.0, 124.0, 121.0, 139.0, 128.0, 132.0, 125.0, 119.0, 123.0], "value": 125.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 163.0, 163.0, 176.0, 169.0, 169.0, 172.0, 162.0, 170.0], "value": 167.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 74.0, 80.0, 75.0, 85.0, 74.0, 74.0, 81.0, 79.0], "value": 77.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 88.0, 80.0, 87.0, 83.0, 90.0, 80.0, 82.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 116.0, 114.0, 111.0, 118.0, 119.0, 115.0, 127.0, 115.0, 119.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 147.0, 151.0, 148.0, 158.0, 148.0, 155.0, 150.0, 149.0, 147.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 106.0, 94.0, 100.0, 95.0, 99.0, 96.0, 99.0, 95.0, 95.0], "value": 98.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 59.0, 54.0, 55.0, 59.0, 55.0, 64.0, 54.0, 53.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 46.0, 47.0, 44.0, 43.0, 45.0, 39.0, 42.0, 43.0, 37.0], "value": 43.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 73.0, 79.0, 82.0, 77.0, 76.0, 78.0, 73.0, 78.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 113.0, 117.0, 129.0, 114.0, 118.0, 123.0, 117.0, 111.0, 117.0], "value": 118.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 170.0, 164.0, 168.0, 174.0, 167.0, 170.0, 172.0, 179.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 69.0, 65.0, 62.0, 63.0, 64.0, 64.0, 64.0], "value": 64.9, "unit": "score"}]}]} 04:10:02 INFO - Return code: 0 04:10:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:10:02 INFO - # TBPL SUCCESS # 04:10:02 INFO - Running post-action listener: _package_coverage_data 04:10:02 INFO - Running post-action listener: _resource_record_post_action 04:10:02 INFO - [mozharness: 2017-09-25 11:10:02.787453Z] Finished run-tests step (success) 04:10:02 INFO - Running post-run listener: _resource_record_post_run 04:10:02 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 349106176; Read time: 188; Write time: 206872 04:10:02 INFO - TinderboxPrint: CPU usage
13.3% 04:10:02 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 188 04:10:02 INFO - TinderboxPrint: I/O write bytes / time
349,106,176 / 206,872 04:10:02 INFO - TinderboxPrint: CPU idle
8,250.5 (86.7%) 04:10:02 INFO - TinderboxPrint: CPU user
1,201.5 (12.6%) 04:10:02 INFO - TinderboxPrint: Swap in / out
0 / 0 04:10:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12558336; Read time: 0; Write time: 2272 04:10:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:10:02 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 335523840; Read time: 172; Write time: 204580 04:10:03 INFO - Running post-run listener: _upload_blobber_files 04:10:03 INFO - Blob upload gear active. 04:10:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:10:03 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 04:10:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:10:03 INFO - (blobuploader) - INFO - Open directory for files ... 04:10:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:10:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:10:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:07 INFO - (blobuploader) - INFO - Done attempting. 04:10:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:10:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:10:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:08 INFO - (blobuploader) - INFO - Done attempting. 04:10:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:10:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:10:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:09 INFO - (blobuploader) - INFO - Done attempting. 04:10:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:10:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:10:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:10 INFO - (blobuploader) - INFO - Done attempting. 04:10:10 INFO - (blobuploader) - INFO - Iteration through files over. 04:10:10 INFO - Return code: 0 04:10:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:10:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:10:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ef1986563bec728bc72dc8c0f0bed57cf48b5e363898f8b86f0136041d10faf9ec2864293bef458fc752d9a5cbd1c04cb7fa263d078026ec6bb33c61cf05a40", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4501deabd61debfbe12cc3eff345d27cc38c0e58c0c0b08a5f041243cc862ed40e8f104d7b4da537f8c84ce8d7eba242ca1826f4046007c7a2421de9b07a752", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b63c420d12e97af7282af8a05f61c87cdb333070062b09be095b9097183a7a6d1ff47acd285a7b597284cc002ba08ee557fcb68e18a0f23e2dc62590643bf9e7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/100c534e117e81cf5f8d9ec3e28fd5a425f94294608f5ff3524b6bb58d1eb53b704eeb1623b269ea35aea9dbae5858d2484740198b2a88a2248b6a4c95202b95"} 04:10:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:10:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:10:10 INFO - Contents: 04:10:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ef1986563bec728bc72dc8c0f0bed57cf48b5e363898f8b86f0136041d10faf9ec2864293bef458fc752d9a5cbd1c04cb7fa263d078026ec6bb33c61cf05a40", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4501deabd61debfbe12cc3eff345d27cc38c0e58c0c0b08a5f041243cc862ed40e8f104d7b4da537f8c84ce8d7eba242ca1826f4046007c7a2421de9b07a752", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b63c420d12e97af7282af8a05f61c87cdb333070062b09be095b9097183a7a6d1ff47acd285a7b597284cc002ba08ee557fcb68e18a0f23e2dc62590643bf9e7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/100c534e117e81cf5f8d9ec3e28fd5a425f94294608f5ff3524b6bb58d1eb53b704eeb1623b269ea35aea9dbae5858d2484740198b2a88a2248b6a4c95202b95"} 04:10:10 INFO - Running post-run listener: copy_logs_to_upload_dir 04:10:10 INFO - Copying logs to upload dir... 04:10:10 INFO - mkdir: /builds/slave/test/build/upload/logs 04:10:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.572168 ========= master_lag: 0.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-25 04:10:10.040323) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 04:10:10.044959) ========= 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-1506336406.831786-777331707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ef1986563bec728bc72dc8c0f0bed57cf48b5e363898f8b86f0136041d10faf9ec2864293bef458fc752d9a5cbd1c04cb7fa263d078026ec6bb33c61cf05a40", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4501deabd61debfbe12cc3eff345d27cc38c0e58c0c0b08a5f041243cc862ed40e8f104d7b4da537f8c84ce8d7eba242ca1826f4046007c7a2421de9b07a752", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b63c420d12e97af7282af8a05f61c87cdb333070062b09be095b9097183a7a6d1ff47acd285a7b597284cc002ba08ee557fcb68e18a0f23e2dc62590643bf9e7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/100c534e117e81cf5f8d9ec3e28fd5a425f94294608f5ff3524b6bb58d1eb53b704eeb1623b269ea35aea9dbae5858d2484740198b2a88a2248b6a4c95202b95"} build_url:https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ef1986563bec728bc72dc8c0f0bed57cf48b5e363898f8b86f0136041d10faf9ec2864293bef458fc752d9a5cbd1c04cb7fa263d078026ec6bb33c61cf05a40", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4501deabd61debfbe12cc3eff345d27cc38c0e58c0c0b08a5f041243cc862ed40e8f104d7b4da537f8c84ce8d7eba242ca1826f4046007c7a2421de9b07a752", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b63c420d12e97af7282af8a05f61c87cdb333070062b09be095b9097183a7a6d1ff47acd285a7b597284cc002ba08ee557fcb68e18a0f23e2dc62590643bf9e7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/100c534e117e81cf5f8d9ec3e28fd5a425f94294608f5ff3524b6bb58d1eb53b704eeb1623b269ea35aea9dbae5858d2484740198b2a88a2248b6a4c95202b95"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 04:10:10.072817) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 04:10:10.073133) ========= 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-1506336406.831786-777331707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004681 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 04:10:10.126715) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 04:10:10.127019) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 04:10:10.127337) ========= ========= Total master_lag: 0.88 =========