builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-086 starttime: 1504257504.72 results: success (0) revision: 583e73fb8e3c734dbf3a5e13913df7617f5c492c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.719849) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.720351) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.720663) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.743696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.744092) ========= 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=438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-01 02:18:24-- 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% 23.1M=0.001s 2017-09-01 02:18:24 (23.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094398 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.856894) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.857210) ========= 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=438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022005 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.906526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-01 02:18:24.907877) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 583e73fb8e3c734dbf3a5e13913df7617f5c492c --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 583e73fb8e3c734dbf3a5e13913df7617f5c492c --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=438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-01 02:18:24,963 truncating revision to first 12 chars 2017-09-01 02:18:24,963 Setting DEBUG logging. 2017-09-01 02:18:24,963 attempt 1/10 2017-09-01 02:18:24,963 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/583e73fb8e3c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-01 02:18:26,318 unpacking tar archive at: mozilla-central-583e73fb8e3c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.709869 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-01 02:18:26.635307) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:26.635628) ========= script_repo_revision: 583e73fb8e3c734dbf3a5e13913df7617f5c492c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:26.636032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:26.636304) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:26.648225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-09-01 02:18:26.648496) ========= /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=438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:18:26 INFO - MultiFileLogger online at 20170901 02:18:26 in /builds/slave/test 02:18:26 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 02:18:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:18:26 INFO - {'append_to_log': False, 02:18:26 INFO - 'base_work_dir': '/builds/slave/test', 02:18:26 INFO - 'blob_upload_branch': 'Firefox', 02:18:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:18:26 INFO - 'branch': 'Firefox', 02:18:26 INFO - 'buildbot_json_path': 'buildprops.json', 02:18:26 INFO - 'code_coverage': False, 02:18:26 INFO - 'config_files': ('talos/linux_config.py',), 02:18:26 INFO - 'default_actions': ('clobber', 02:18:26 INFO - 'read-buildbot-config', 02:18:26 INFO - 'download-and-extract', 02:18:26 INFO - 'populate-webroot', 02:18:26 INFO - 'create-virtualenv', 02:18:26 INFO - 'install', 02:18:26 INFO - 'setup-mitmproxy', 02:18:26 INFO - 'run-tests'), 02:18:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:18:26 INFO - 'disable_ccov_upload': False, 02:18:26 INFO - 'disable_stylo': False, 02:18:26 INFO - 'download_minidump_stackwalk': True, 02:18:26 INFO - 'download_symbols': 'ondemand', 02:18:26 INFO - 'enable_stylo': False, 02:18:26 INFO - 'enable_webrender': False, 02:18:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:18:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:18:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:18:26 INFO - 'gecko_profile': False, 02:18:26 INFO - 'gecko_profile_interval': 0, 02:18:26 INFO - 'installer_path': 'installer.exe', 02:18:26 INFO - 'log_level': 'info', 02:18:26 INFO - 'log_name': 'talos', 02:18:26 INFO - 'log_to_console': True, 02:18:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:18:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:18:26 INFO - 'opt_config_files': (), 02:18:26 INFO - 'pip_index': False, 02:18:26 INFO - 'suite': 'dromaeojs-e10s', 02:18:26 INFO - 'system_bits': '32', 02:18:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:18:26 INFO - 'title': 'talos-linux64-ix-086', 02:18:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:18:26 INFO - 'use_talos_json': True, 02:18:26 INFO - 'verify': 'False', 02:18:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:18:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:18:26 INFO - 'work_dir': 'build'} 02:18:26 INFO - [mozharness: 2017-09-01 09:18:26.840720Z] Running clobber step. 02:18:26 INFO - Running pre-action listener: _resource_record_pre_action 02:18:26 INFO - Running main action method: clobber 02:18:26 INFO - rmtree: /builds/slave/test/build 02:18:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:18:28 INFO - Running post-action listener: _resource_record_post_action 02:18:28 INFO - [mozharness: 2017-09-01 09:18:28.359025Z] Finished clobber step (success) 02:18:28 INFO - [mozharness: 2017-09-01 09:18:28.359123Z] Running read-buildbot-config step. 02:18:28 INFO - Running pre-action listener: _resource_record_pre_action 02:18:28 INFO - Running main action method: read_buildbot_config 02:18:28 INFO - Using buildbot properties: 02:18:28 INFO - { 02:18:28 INFO - "project": "", 02:18:28 INFO - "product": "firefox", 02:18:28 INFO - "who": "archaeopteryx@coole-files.de", 02:18:28 INFO - "installer_path": "public/build/target.tar.bz2", 02:18:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 02:18:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:18:28 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 02:18:28 INFO - "stage_platform": "linux64-stylo", 02:18:28 INFO - "basedir": "/builds/slave/test", 02:18:28 INFO - "buildnumber": 112, 02:18:28 INFO - "platform": "ubuntu64_hw_stylo", 02:18:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:18:28 INFO - "slavebuilddir": "test", 02:18:28 INFO - "taskId": "fn7G3Uw8TbaY4ZFDZ9qW1Q", 02:18:28 INFO - "branch": "mozilla-central", 02:18:28 INFO - "script_repo_revision": "production", 02:18:28 INFO - "revision": "583e73fb8e3c734dbf3a5e13913df7617f5c492c", 02:18:28 INFO - "slavename": "talos-linux64-ix-086", 02:18:28 INFO - "repo_path": "mozilla-central" 02:18:28 INFO - } 02:18:28 INFO - Finding installer, test and symbols from parent task. 02:18:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fn7G3Uw8TbaY4ZFDZ9qW1Q'}, attempt #1 02:18:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fn7G3Uw8TbaY4ZFDZ9qW1Q'}, attempt #1 02:18:29 INFO - Task dependencies: EVBwkXv4QIqaI8RoA8-sCA 02:18:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA'}, attempt #1 02:18:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2 02:18:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.test_packages.json 02:18:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.crashreporter-symbols.zip 02:18:29 INFO - Running post-action listener: _resource_record_post_action 02:18:29 INFO - [mozharness: 2017-09-01 09:18:29.686204Z] Finished read-buildbot-config step (success) 02:18:29 INFO - [mozharness: 2017-09-01 09:18:29.686422Z] Running download-and-extract step. 02:18:29 INFO - Running pre-action listener: _resource_record_pre_action 02:18:29 INFO - Running main action method: download_and_extract 02:18:29 INFO - mkdir: /builds/slave/test/build/tests 02:18:29 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')]} 02:18:29 INFO - trying https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.test_packages.json 02:18:29 INFO - Downloading https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:18:30 INFO - Downloaded 989 bytes. 02:18:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:18:30 INFO - Using the following test package requirements: 02:18:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:18:30 INFO - u'common': [u'target.common.tests.zip'], 02:18:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:18:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:18:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:18:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:18:30 INFO - u'mozbase': [u'target.common.tests.zip'], 02:18:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:18:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:18:30 INFO - u'web-platform': [u'target.common.tests.zip', 02:18:30 INFO - u'target.web-platform.tests.tar.gz'], 02:18:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:18:30 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:18:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.common.tests.zip 02:18:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:18:30 INFO - Fetch https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.common.tests.zip into memory 02:18:31 INFO - Content-Length response header: 54933742 02:18:31 INFO - Bytes received: 54933742 02:18:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:18:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.common.tests.zip 02:18:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:18:42 INFO - Fetch https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.common.tests.zip into memory 02:18:44 INFO - Content-Length response header: 54933742 02:18:44 INFO - Bytes received: 54933742 02:18:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.talos.tests.zip 02:18:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:18:58 INFO - Fetch https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.talos.tests.zip into memory 02:18:59 INFO - Content-Length response header: 14496650 02:18:59 INFO - Bytes received: 14496650 02:18: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')]} 02:18:59 INFO - trying https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2 02:18:59 INFO - Downloading https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:18:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:19:02 INFO - Downloaded 62501484 bytes. 02:19:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2 02:19:02 INFO - mkdir: /builds/slave/test/properties 02:19:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:19:02 INFO - Writing to file /builds/slave/test/properties/build_url 02:19:02 INFO - Contents: 02:19:02 INFO - build_url:https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2 02:19:02 INFO - Running post-action listener: _resource_record_post_action 02:19:02 INFO - Running post-action listener: find_tests_for_verification 02:19:02 INFO - Running post-action listener: set_extra_try_arguments 02:19:02 INFO - [mozharness: 2017-09-01 09:19:02.329727Z] Finished download-and-extract step (success) 02:19:02 INFO - [mozharness: 2017-09-01 09:19:02.329953Z] Running populate-webroot step. 02:19:02 INFO - Running pre-action listener: _resource_record_pre_action 02:19:02 INFO - Running main action method: populate_webroot 02:19:02 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:19:02 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:19:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:19:02 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:19:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:02 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'tests': ['damp', 'tps']}, 02:19:02 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['damp', 'tps']}, 02:19:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:19:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:19:02 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:19:02 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:19:02 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:19:02 INFO - 'other-e10s': {'tests': ['a11yr', 02:19:02 INFO - 'ts_paint', 02:19:02 INFO - 'tpaint', 02:19:02 INFO - 'sessionrestore', 02:19:02 INFO - 'sessionrestore_many_windows', 02:19:02 INFO - 'sessionrestore_no_auto_restore', 02:19:02 INFO - 'tabpaint']}, 02:19:02 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['a11yr', 02:19:02 INFO - 'ts_paint', 02:19:02 INFO - 'tpaint', 02:19:02 INFO - 'sessionrestore', 02:19:02 INFO - 'sessionrestore_many_windows', 02:19:02 INFO - 'sessionrestore_no_auto_restore', 02:19:02 INFO - 'tabpaint']}, 02:19:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:19:02 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:19:02 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['bloom_basic_singleton']}, 02:19:02 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['bloom_basic']}, 02:19:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:19:02 INFO - 'tsvgr_opacity', 02:19:02 INFO - 'tart', 02:19:02 INFO - 'tscrollx', 02:19:02 INFO - 'tsvg_static']}, 02:19:02 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['tsvgx', 02:19:02 INFO - 'tsvgr_opacity', 02:19:02 INFO - 'tart', 02:19:02 INFO - 'tscrollx', 02:19:02 INFO - 'tsvg_static']}, 02:19:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:19:02 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['tp5o']}, 02:19:02 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:19:02 INFO - 'talos_options': ['--mitmproxy', 02:19:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:19:02 INFO - '--firstNonBlankPaint'], 02:19:02 INFO - 'tests': ['tp6_google', 02:19:02 INFO - 'tp6_youtube', 02:19:02 INFO - 'tp6_amazon', 02:19:02 INFO - 'tp6_facebook']}, 02:19:02 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:19:02 INFO - 'talos_options': ['--enable-stylo', 02:19:02 INFO - '--mitmproxy', 02:19:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:19:02 INFO - '--firstNonBlankPaint'], 02:19:02 INFO - 'tests': ['tp6_google', 02:19:02 INFO - 'tp6_youtube', 02:19:02 INFO - 'tp6_amazon', 02:19:02 INFO - 'tp6_facebook']}, 02:19:02 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:19:02 INFO - 'talos_options': ['--enable-stylo', 02:19:02 INFO - '--stylo-threads=1', 02:19:02 INFO - '--mitmproxy', 02:19:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:19:02 INFO - '--firstNonBlankPaint'], 02:19:02 INFO - 'tests': ['tp6_google', 02:19:02 INFO - 'tp6_youtube', 02:19:02 INFO - 'tp6_amazon', 02:19:02 INFO - 'tp6_facebook']}, 02:19:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'talos_options': ['--xperf_path', 02:19:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:02 INFO - 'tests': ['tp5n']}, 02:19:02 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'talos_options': ['--enable-stylo', 02:19:02 INFO - '--xperf_path', 02:19:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:02 INFO - 'tests': ['tp5n']}}} 02:19:02 INFO - Running post-action listener: _resource_record_post_action 02:19:02 INFO - [mozharness: 2017-09-01 09:19:02.345974Z] Finished populate-webroot step (success) 02:19:02 INFO - [mozharness: 2017-09-01 09:19:02.346063Z] Running create-virtualenv step. 02:19:02 INFO - Running pre-action listener: _resource_record_pre_action 02:19:02 INFO - Running main action method: create_virtualenv 02:19:02 INFO - Creating virtualenv /builds/slave/test/build/venv 02:19:02 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:19:02 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:19:02 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:19:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:19:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:19:02 INFO - Installing distribute.............................................................................................................................................................................................done. 02:19:03 INFO - Installing pip...............done. 02:19:03 INFO - Return code: 0 02:19:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:19:03 INFO - Reading from file tmpfile_stdout 02:19:03 INFO - Output received: 02:19:03 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:19:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:03 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 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1888090>, '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 0x1888d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1882f90>, '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': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', '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 02:19:03 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 02:19:03 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 02:19:03 INFO - Using env: {'DISPLAY': ':0', 02:19:03 INFO - 'HOME': '/home/cltbld', 02:19:03 INFO - 'LANG': 'en_US.UTF-8', 02:19:03 INFO - 'LANGUAGE': 'en_US:en', 02:19:03 INFO - 'LOGNAME': 'cltbld', 02:19:03 INFO - 'MAIL': '/var/mail/cltbld', 02:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:03 INFO - 'MOZ_NO_REMOTE': '1', 02:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:03 INFO - 'NO_EM_RESTART': '1', 02:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:03 INFO - 'PWD': '/builds/slave/test', 02:19:03 INFO - 'SHELL': '/bin/bash', 02:19:03 INFO - 'SHLVL': '1', 02:19:03 INFO - 'TERM': 'linux', 02:19:03 INFO - 'TMOUT': '86400', 02:19:03 INFO - 'USER': 'cltbld', 02:19:03 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', 02:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:03 INFO - '_': '/tools/buildbot/bin/python'} 02:19:04 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:19:04 INFO - Downloading/unpacking pip>=1.5 02:19:04 INFO - Running setup.py egg_info for package pip 02:19:04 INFO - warning: no files found matching 'pip/cacert.pem' 02:19:04 INFO - warning: no files found matching '*.html' under directory 'docs' 02:19:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:19:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:19:04 INFO - Installing collected packages: pip 02:19:04 INFO - Found existing installation: pip 1.1 02:19:04 INFO - Uninstalling pip: 02:19:04 INFO - Successfully uninstalled pip 02:19:04 INFO - Running setup.py install for pip 02:19:04 INFO - warning: no files found matching 'pip/cacert.pem' 02:19:04 INFO - warning: no files found matching '*.html' under directory 'docs' 02:19:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:19:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:19:04 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:19:04 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:19:04 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:19:04 INFO - Successfully installed pip 02:19:04 INFO - Cleaning up... 02:19:04 INFO - Return code: 0 02:19:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1888090>, '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 0x1888d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1882f90>, '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': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', '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 02:19:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:19:04 INFO - Using env: {'DISPLAY': ':0', 02:19:04 INFO - 'HOME': '/home/cltbld', 02:19:04 INFO - 'LANG': 'en_US.UTF-8', 02:19:04 INFO - 'LANGUAGE': 'en_US:en', 02:19:04 INFO - 'LOGNAME': 'cltbld', 02:19:04 INFO - 'MAIL': '/var/mail/cltbld', 02:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:04 INFO - 'MOZ_NO_REMOTE': '1', 02:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:04 INFO - 'NO_EM_RESTART': '1', 02:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:04 INFO - 'PWD': '/builds/slave/test', 02:19:04 INFO - 'SHELL': '/bin/bash', 02:19:04 INFO - 'SHLVL': '1', 02:19:04 INFO - 'TERM': 'linux', 02:19:04 INFO - 'TMOUT': '86400', 02:19:04 INFO - 'USER': 'cltbld', 02:19:04 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', 02:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:04 INFO - '_': '/tools/buildbot/bin/python'} 02:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:04 INFO - Downloading/unpacking psutil>=3.1.1 02:19:04 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 02:19:04 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 02:19:04 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 02:19:04 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 02:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:19:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:05 INFO - Installing collected packages: psutil 02:19:05 INFO - Running setup.py install for psutil 02:19:06 INFO - building 'psutil._psutil_linux' extension 02:19:06 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 02:19:06 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 02:19:06 INFO - building 'psutil._psutil_posix' extension 02:19:06 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 02:19:06 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 02:19:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:06 INFO - Successfully installed psutil 02:19:06 INFO - Cleaning up... 02:19:06 INFO - Return code: 0 02:19:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1888090>, '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 0x1888d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1882f90>, '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': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', '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 02:19:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:19:06 INFO - Using env: {'DISPLAY': ':0', 02:19:06 INFO - 'HOME': '/home/cltbld', 02:19:06 INFO - 'LANG': 'en_US.UTF-8', 02:19:06 INFO - 'LANGUAGE': 'en_US:en', 02:19:06 INFO - 'LOGNAME': 'cltbld', 02:19:06 INFO - 'MAIL': '/var/mail/cltbld', 02:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:06 INFO - 'MOZ_NO_REMOTE': '1', 02:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:06 INFO - 'NO_EM_RESTART': '1', 02:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:06 INFO - 'PWD': '/builds/slave/test', 02:19:06 INFO - 'SHELL': '/bin/bash', 02:19:06 INFO - 'SHLVL': '1', 02:19:06 INFO - 'TERM': 'linux', 02:19:06 INFO - 'TMOUT': '86400', 02:19:06 INFO - 'USER': 'cltbld', 02:19:06 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', 02:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:06 INFO - '_': '/tools/buildbot/bin/python'} 02:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:19:06 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 02:19:06 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 02:19:06 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 02:19:06 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 02:19:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:19:07 INFO - Installing collected packages: mozsystemmonitor 02:19:07 INFO - Running setup.py install for mozsystemmonitor 02:19:07 INFO - Successfully installed mozsystemmonitor 02:19:07 INFO - Cleaning up... 02:19:07 INFO - Return code: 0 02:19:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:19: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')]} 02:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19: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')]} 02:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1888090>, '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 0x1888d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1882f90>, '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': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', '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 02:19: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==2.5.1'] in /builds/slave/test/build 02:19: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==2.5.1 02:19:07 INFO - Using env: {'DISPLAY': ':0', 02:19:07 INFO - 'HOME': '/home/cltbld', 02:19:07 INFO - 'LANG': 'en_US.UTF-8', 02:19:07 INFO - 'LANGUAGE': 'en_US:en', 02:19:07 INFO - 'LOGNAME': 'cltbld', 02:19:08 INFO - 'MAIL': '/var/mail/cltbld', 02:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:08 INFO - 'MOZ_NO_REMOTE': '1', 02:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:08 INFO - 'NO_EM_RESTART': '1', 02:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:08 INFO - 'PWD': '/builds/slave/test', 02:19:08 INFO - 'SHELL': '/bin/bash', 02:19:08 INFO - 'SHLVL': '1', 02:19:08 INFO - 'TERM': 'linux', 02:19:08 INFO - 'TMOUT': '86400', 02:19:08 INFO - 'USER': 'cltbld', 02:19:08 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', 02:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:08 INFO - '_': '/tools/buildbot/bin/python'} 02:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:08 INFO - Downloading/unpacking jsonschema==2.5.1 02:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:19:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:19:09 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 02:19:09 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 02:19:09 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 02:19:09 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 02:19:09 INFO - Downloading functools32-3.2.3-2.tar.gz 02:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:19:09 INFO - warning: no files found matching '*.txt' 02:19:09 INFO - no previously-included directories found matching 'build' 02:19:09 INFO - no previously-included directories found matching 'dist' 02:19:09 INFO - no previously-included directories found matching '.git*' 02:19:09 INFO - Installing collected packages: jsonschema, functools32 02:19:09 INFO - Running setup.py install for functools32 02:19:09 INFO - warning: no files found matching '*.txt' 02:19:09 INFO - no previously-included directories found matching 'build' 02:19:09 INFO - no previously-included directories found matching 'dist' 02:19:09 INFO - no previously-included directories found matching '.git*' 02:19:09 INFO - Successfully installed jsonschema functools32 02:19:09 INFO - Cleaning up... 02:19:09 INFO - Return code: 0 02:19:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:19:09 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')]} 02:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:09 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')]} 02:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:09 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 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1888090>, '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 0x1888d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1882f90>, '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': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', '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 02:19:09 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 02:19:09 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 02:19:09 INFO - Using env: {'DISPLAY': ':0', 02:19:09 INFO - 'HOME': '/home/cltbld', 02:19:09 INFO - 'LANG': 'en_US.UTF-8', 02:19:09 INFO - 'LANGUAGE': 'en_US:en', 02:19:09 INFO - 'LOGNAME': 'cltbld', 02:19:09 INFO - 'MAIL': '/var/mail/cltbld', 02:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:09 INFO - 'MOZ_NO_REMOTE': '1', 02:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:09 INFO - 'NO_EM_RESTART': '1', 02:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:09 INFO - 'PWD': '/builds/slave/test', 02:19:09 INFO - 'SHELL': '/bin/bash', 02:19:09 INFO - 'SHLVL': '1', 02:19:09 INFO - 'TERM': 'linux', 02:19:09 INFO - 'TMOUT': '86400', 02:19:09 INFO - 'USER': 'cltbld', 02:19:09 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', 02:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:09 INFO - '_': '/tools/buildbot/bin/python'} 02:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:19:09 INFO - Cleaning up... 02:19:09 INFO - Return code: 0 02:19:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:19:09 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')]} 02:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:09 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')]} 02:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:09 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 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1888090>, '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 0x1888d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1882f90>, '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': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', '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 02:19:09 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 02:19:09 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 02:19:09 INFO - Using env: {'DISPLAY': ':0', 02:19:09 INFO - 'HOME': '/home/cltbld', 02:19:09 INFO - 'LANG': 'en_US.UTF-8', 02:19:09 INFO - 'LANGUAGE': 'en_US:en', 02:19:09 INFO - 'LOGNAME': 'cltbld', 02:19:09 INFO - 'MAIL': '/var/mail/cltbld', 02:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:09 INFO - 'MOZ_NO_REMOTE': '1', 02:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:09 INFO - 'NO_EM_RESTART': '1', 02:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:09 INFO - 'PWD': '/builds/slave/test', 02:19:09 INFO - 'SHELL': '/bin/bash', 02:19:09 INFO - 'SHLVL': '1', 02:19:09 INFO - 'TERM': 'linux', 02:19:09 INFO - 'TMOUT': '86400', 02:19:09 INFO - 'USER': 'cltbld', 02:19:09 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', 02:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:09 INFO - '_': '/tools/buildbot/bin/python'} 02:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:10 INFO - Downloading/unpacking blobuploader==1.2.4 02:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:11 INFO - Downloading blobuploader-1.2.4.tar.gz 02:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:19:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:19:11 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 02:19:11 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 02:19:11 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 02:19:11 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 02:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:19:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:19:11 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 02:19:11 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 02:19:11 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 02:19:11 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 02:19:11 INFO - Downloading docopt-0.6.1.tar.gz 02:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:19:11 INFO - Installing collected packages: blobuploader, requests, docopt 02:19:11 INFO - Running setup.py install for blobuploader 02:19:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:19:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:19:11 INFO - Running setup.py install for requests 02:19:12 INFO - Running setup.py install for docopt 02:19:12 INFO - Successfully installed blobuploader requests docopt 02:19:12 INFO - Cleaning up... 02:19:12 INFO - Return code: 0 02:19:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:12 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 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1888090>, '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 0x1888d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1882f90>, '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': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', '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 02:19:12 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 02:19:12 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 02:19:12 INFO - Using env: {'DISPLAY': ':0', 02:19:12 INFO - 'HOME': '/home/cltbld', 02:19:12 INFO - 'LANG': 'en_US.UTF-8', 02:19:12 INFO - 'LANGUAGE': 'en_US:en', 02:19:12 INFO - 'LOGNAME': 'cltbld', 02:19:12 INFO - 'MAIL': '/var/mail/cltbld', 02:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:12 INFO - 'MOZ_NO_REMOTE': '1', 02:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:12 INFO - 'NO_EM_RESTART': '1', 02:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:12 INFO - 'PWD': '/builds/slave/test', 02:19:12 INFO - 'SHELL': '/bin/bash', 02:19:12 INFO - 'SHLVL': '1', 02:19:12 INFO - 'TERM': 'linux', 02:19:12 INFO - 'TMOUT': '86400', 02:19:12 INFO - 'USER': 'cltbld', 02:19:12 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', 02:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:12 INFO - '_': '/tools/buildbot/bin/python'} 02:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:12 INFO - Running setup.py (path:/tmp/pip-ybEoOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:12 INFO - Running setup.py (path:/tmp/pip-FeXJxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:12 INFO - Running setup.py (path:/tmp/pip-S5bPc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:12 INFO - Running setup.py (path:/tmp/pip-JYvpsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:12 INFO - Running setup.py (path:/tmp/pip-uGRqqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:12 INFO - Running setup.py (path:/tmp/pip-xUC8DQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:19:13 INFO - Running setup.py (path:/tmp/pip-2Zy51O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:19:13 INFO - Running setup.py (path:/tmp/pip-suCMAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:19:13 INFO - Running setup.py (path:/tmp/pip-5Z7kWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:19:13 INFO - Running setup.py (path:/tmp/pip-ocwDr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:19:13 INFO - Running setup.py (path:/tmp/pip-ju2zu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:13 INFO - Running setup.py (path:/tmp/pip-hHSH7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:13 INFO - Running setup.py (path:/tmp/pip-aOUcly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:13 INFO - Running setup.py (path:/tmp/pip-hSIWGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:13 INFO - Running setup.py (path:/tmp/pip-tpyatk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:13 INFO - Running setup.py (path:/tmp/pip-1oHD0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:13 INFO - Running setup.py (path:/tmp/pip-iuYVsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:19:13 INFO - Running setup.py install for manifestparser 02:19:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:19:13 INFO - Running setup.py install for mozcrash 02:19:14 INFO - Running setup.py install for mozdebug 02:19:14 INFO - Running setup.py install for mozdevice 02:19:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:19:14 INFO - Running setup.py install for mozfile 02:19:14 INFO - Running setup.py install for mozhttpd 02:19:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:19:14 INFO - Running setup.py install for mozinfo 02:19:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:19:14 INFO - Running setup.py install for mozInstall 02:19:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:19:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:19:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:19:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:19:14 INFO - Running setup.py install for mozleak 02:19:14 INFO - Running setup.py install for mozlog 02:19:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:19:14 INFO - Running setup.py install for moznetwork 02:19:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:19:14 INFO - Running setup.py install for mozprocess 02:19:15 INFO - Running setup.py install for mozprofile 02:19:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:19:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:19:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:19:15 INFO - Running setup.py install for mozrunner 02:19:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:19:15 INFO - Running setup.py install for mozscreenshot 02:19:15 INFO - Running setup.py install for moztest 02:19:15 INFO - Running setup.py install for mozversion 02:19:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:19:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:19:15 INFO - Cleaning up... 02:19:15 INFO - Return code: 0 02:19:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:15 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 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1888090>, '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 0x1888d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1882f90>, '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': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', '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 02:19:15 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 02:19:15 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 02:19:15 INFO - Using env: {'DISPLAY': ':0', 02:19:15 INFO - 'HOME': '/home/cltbld', 02:19:15 INFO - 'LANG': 'en_US.UTF-8', 02:19:15 INFO - 'LANGUAGE': 'en_US:en', 02:19:15 INFO - 'LOGNAME': 'cltbld', 02:19:15 INFO - 'MAIL': '/var/mail/cltbld', 02:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:15 INFO - 'MOZ_NO_REMOTE': '1', 02:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:15 INFO - 'NO_EM_RESTART': '1', 02:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:15 INFO - 'PWD': '/builds/slave/test', 02:19:15 INFO - 'SHELL': '/bin/bash', 02:19:15 INFO - 'SHLVL': '1', 02:19:15 INFO - 'TERM': 'linux', 02:19:15 INFO - 'TMOUT': '86400', 02:19:15 INFO - 'USER': 'cltbld', 02:19:15 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', 02:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:15 INFO - '_': '/tools/buildbot/bin/python'} 02:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:15 INFO - Running setup.py (path:/tmp/pip-LGv1nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:15 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)) 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:15 INFO - Running setup.py (path:/tmp/pip-g90kCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:15 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)) 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:15 INFO - Running setup.py (path:/tmp/pip-3ntIDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:15 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)) 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:15 INFO - Running setup.py (path:/tmp/pip-mEJtWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:16 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)) 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:16 INFO - Running setup.py (path:/tmp/pip-LE8cL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:16 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)) 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:16 INFO - Running setup.py (path:/tmp/pip-ofvyL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:19:16 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)) 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:19:16 INFO - Running setup.py (path:/tmp/pip-5cQk91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:19:16 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)) 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:19:16 INFO - Running setup.py (path:/tmp/pip-vSty8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:19:16 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)) 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:19:16 INFO - Running setup.py (path:/tmp/pip-cnpmUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:19:16 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)) 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:19:16 INFO - Running setup.py (path:/tmp/pip-8FjwqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:19:16 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)) 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:19:16 INFO - Running setup.py (path:/tmp/pip-EMCsjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:16 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)) 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:16 INFO - Running setup.py (path:/tmp/pip-pxgOzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:16 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)) 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:16 INFO - Running setup.py (path:/tmp/pip-7qoOm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:16 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)) 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:16 INFO - Running setup.py (path:/tmp/pip-mApGKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:16 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)) 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:16 INFO - Running setup.py (path:/tmp/pip-bUe4fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:16 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)) 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:16 INFO - Running setup.py (path:/tmp/pip-C3H7fZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:16 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)) 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:16 INFO - Running setup.py (path:/tmp/pip-7Upypw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:17 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)) 02:19:17 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)) 02:19:17 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)) 02:19:17 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)) 02:19:17 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)) 02:19:17 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)) 02:19:17 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)) 02:19:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:18 INFO - Downloading blessings-1.6.tar.gz 02:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:19:18 INFO - Installing collected packages: blessings 02:19:18 INFO - Running setup.py install for blessings 02:19:18 INFO - Successfully installed blessings 02:19:18 INFO - Cleaning up... 02:19:18 INFO - Return code: 0 02:19:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:19:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:19:18 INFO - Reading from file tmpfile_stdout 02:19:18 INFO - Current package versions: 02:19:18 INFO - argparse == 1.2.1 02:19:18 INFO - blessings == 1.6 02:19:18 INFO - blobuploader == 1.2.4 02:19:18 INFO - docopt == 0.6.1 02:19:18 INFO - functools32 == 3.2.3-2 02:19:18 INFO - jsonschema == 2.5.1 02:19:18 INFO - manifestparser == 1.1 02:19:18 INFO - mozInstall == 1.13 02:19:18 INFO - mozcrash == 1.0 02:19:18 INFO - mozdebug == 0.1 02:19:18 INFO - mozdevice == 0.51 02:19:18 INFO - mozfile == 1.2 02:19:18 INFO - mozhttpd == 0.7 02:19:18 INFO - mozinfo == 0.10 02:19:18 INFO - mozleak == 0.1 02:19:18 INFO - mozlog == 3.5 02:19:18 INFO - moznetwork == 0.27 02:19:18 INFO - mozprocess == 0.25 02:19:18 INFO - mozprofile == 0.28 02:19:18 INFO - mozrunner == 6.13 02:19:18 INFO - mozscreenshot == 0.1 02:19:18 INFO - mozsystemmonitor == 0.3 02:19:18 INFO - moztest == 0.8 02:19:18 INFO - mozversion == 1.4 02:19:18 INFO - psutil == 3.1.1 02:19:18 INFO - requests == 1.2.3 02:19:18 INFO - wsgiref == 0.1.2 02:19:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:18 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 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1888090>, '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 0x1888d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1882f90>, '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': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', '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 02:19:18 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 02:19:18 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 02:19:18 INFO - Using env: {'DISPLAY': ':0', 02:19:18 INFO - 'HOME': '/home/cltbld', 02:19:18 INFO - 'LANG': 'en_US.UTF-8', 02:19:18 INFO - 'LANGUAGE': 'en_US:en', 02:19:18 INFO - 'LOGNAME': 'cltbld', 02:19:18 INFO - 'MAIL': '/var/mail/cltbld', 02:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:18 INFO - 'MOZ_NO_REMOTE': '1', 02:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:18 INFO - 'NO_EM_RESTART': '1', 02:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:18 INFO - 'PWD': '/builds/slave/test', 02:19:18 INFO - 'SHELL': '/bin/bash', 02:19:18 INFO - 'SHLVL': '1', 02:19:18 INFO - 'TERM': 'linux', 02:19:18 INFO - 'TMOUT': '86400', 02:19:18 INFO - 'USER': 'cltbld', 02:19:18 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', 02:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:18 INFO - '_': '/tools/buildbot/bin/python'} 02:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:18 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)) 02:19:18 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)) 02:19:18 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)) 02:19:18 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)) 02:19:18 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)) 02:19:18 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)) 02:19:18 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)) 02:19:18 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)) 02:19:18 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)) 02:19:18 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:19:18 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 02:19:18 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 02:19:18 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 02:19:18 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 02:19:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:19:19 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)) 02:19:19 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)) 02:19:19 INFO - Installing collected packages: simplejson 02:19:19 INFO - Running setup.py install for simplejson 02:19:20 INFO - building 'simplejson._speedups' extension 02:19:20 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 02:19:20 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 02:19:20 INFO - Successfully installed simplejson 02:19:20 INFO - Cleaning up... 02:19:21 INFO - Return code: 0 02:19:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:21 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 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1888090>, '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 0x1888d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1882f90>, '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': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', '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 02:19:21 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 02:19:21 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 02:19:21 INFO - Using env: {'DISPLAY': ':0', 02:19:21 INFO - 'HOME': '/home/cltbld', 02:19:21 INFO - 'LANG': 'en_US.UTF-8', 02:19:21 INFO - 'LANGUAGE': 'en_US:en', 02:19:21 INFO - 'LOGNAME': 'cltbld', 02:19:21 INFO - 'MAIL': '/var/mail/cltbld', 02:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:21 INFO - 'MOZ_NO_REMOTE': '1', 02:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:21 INFO - 'NO_EM_RESTART': '1', 02:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:21 INFO - 'PWD': '/builds/slave/test', 02:19:21 INFO - 'SHELL': '/bin/bash', 02:19:21 INFO - 'SHLVL': '1', 02:19:21 INFO - 'TERM': 'linux', 02:19:21 INFO - 'TMOUT': '86400', 02:19:21 INFO - 'USER': 'cltbld', 02:19:21 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', 02:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:21 INFO - '_': '/tools/buildbot/bin/python'} 02:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:19:21 INFO - Cleaning up... 02:19:21 INFO - Return code: 0 02:19:21 INFO - Running post-action listener: _resource_record_post_action 02:19:21 INFO - Running post-action listener: _start_resource_monitoring 02:19:21 INFO - Starting resource monitoring. 02:19:21 INFO - [mozharness: 2017-09-01 09:19:21.274024Z] Finished create-virtualenv step (success) 02:19:21 INFO - [mozharness: 2017-09-01 09:19:21.274549Z] Running install step. 02:19:21 INFO - Running pre-action listener: _resource_record_pre_action 02:19:21 INFO - Running main action method: install 02:19:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:19:21 INFO - Reading from file tmpfile_stdout 02:19:21 INFO - Detecting whether we're running mozinstall >=1.0... 02:19:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:19:21 INFO - Reading from file tmpfile_stdout 02:19:21 INFO - Output received: 02:19:21 INFO - Usage: mozinstall [options] installer 02:19:21 INFO - Options: 02:19:21 INFO - -h, --help show this help message and exit 02:19:21 INFO - -d DEST, --destination=DEST 02:19:21 INFO - Directory to install application into. [default: 02:19:21 INFO - "/builds/slave/test"] 02:19:21 INFO - --app=APP Application being installed. [default: firefox] 02:19:21 INFO - mkdir: /builds/slave/test/build/application 02:19:21 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'] 02:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:19:38 INFO - Reading from file tmpfile_stdout 02:19:38 INFO - Output received: 02:19:38 INFO - /builds/slave/test/build/application/firefox/firefox 02:19:38 INFO - Running post-action listener: _resource_record_post_action 02:19:38 INFO - [mozharness: 2017-09-01 09:19:38.142105Z] Finished install step (success) 02:19:38 INFO - [mozharness: 2017-09-01 09:19:38.142446Z] Running setup-mitmproxy step. 02:19:38 INFO - Running pre-action listener: _resource_record_pre_action 02:19:38 INFO - Running main action method: setup_mitmproxy 02:19:38 INFO - Skipping: mitmproxy is not required 02:19:38 INFO - Running post-action listener: _resource_record_post_action 02:19:38 INFO - [mozharness: 2017-09-01 09:19:38.144065Z] Finished setup-mitmproxy step (success) 02:19:38 INFO - [mozharness: 2017-09-01 09:19:38.144376Z] Running run-tests step. 02:19:38 INFO - Running pre-action listener: _resource_record_pre_action 02:19:38 INFO - Running pre-action listener: _set_gcov_prefix 02:19:38 INFO - Running main action method: run_tests 02:19:38 WARNING - Try message not found. 02:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:19:38 INFO - Python 2.7.3 02:19:38 INFO - Return code: 0 02:19:38 INFO - grabbing minidump binary from tooltool 02:19:38 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')]} 02:19:38 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 0x1888090>, '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 0x1888d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1882f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:19:38 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 02:19:38 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 02:19:38 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 02:19:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:19:38 INFO - Return code: 0 02:19:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:19:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:19:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:19:38 INFO - ENV: RUST_BACKTRACE is now full 02:19:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:19:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:19:38 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/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--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 02:19:38 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/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-086 --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 02:19:38 INFO - Using env: {'DISPLAY': ':0', 02:19:38 INFO - 'HOME': '/home/cltbld', 02:19:38 INFO - 'LANG': 'en_US.UTF-8', 02:19:38 INFO - 'LANGUAGE': 'en_US:en', 02:19:38 INFO - 'LOGNAME': 'cltbld', 02:19:38 INFO - 'MAIL': '/var/mail/cltbld', 02:19:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:19:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:38 INFO - 'MOZ_NO_REMOTE': '1', 02:19:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:38 INFO - 'NO_EM_RESTART': '1', 02:19:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:38 INFO - 'PWD': '/builds/slave/test', 02:19:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:19:38 INFO - 'RUST_BACKTRACE': 'full', 02:19:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:19:38 INFO - 'SHELL': '/bin/bash', 02:19:38 INFO - 'SHLVL': '1', 02:19:38 INFO - 'STYLO_FORCE_ENABLED': '1', 02:19:38 INFO - 'TERM': 'linux', 02:19:38 INFO - 'TMOUT': '86400', 02:19:38 INFO - 'USER': 'cltbld', 02:19:38 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', 02:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:38 INFO - '_': '/tools/buildbot/bin/python'} 02:19:38 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/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--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 02:19:38 INFO - mozversion application_buildid: 20170901083126 02:19:38 INFO - mozversion application_changeset: 583e73fb8e3c734dbf3a5e13913df7617f5c492c 02:19:38 INFO - mozversion application_display_name: Nightly 02:19:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:19:38 INFO - mozversion application_name: Firefox 02:19:38 INFO - mozversion application_remotingname: firefox 02:19:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:19:38 INFO - mozversion application_vendor: Mozilla 02:19:38 INFO - mozversion application_version: 57.0a1 02:19:38 INFO - mozversion platform_buildid: 20170901083126 02:19:38 INFO - mozversion platform_changeset: 583e73fb8e3c734dbf3a5e13913df7617f5c492c 02:19:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:19:38 INFO - mozversion platform_version: 57.0a1 02:19:38 INFO - using testdate: 1504257578 02:19:38 INFO - actual date: 1504257578 02:19:38 INFO - starting webserver on 'localhost:53703' 02:19:38 INFO - SUITE-START | Running 2 tests 02:19:38 INFO - TEST-START | dromaeo_css 02:19:38 INFO - Initialising browser for dromaeo_css test... 02:19:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53703/getInfo.html -profile /tmp/tmpiISkrC/profile 02:19:38 INFO - TEST-INFO | started process 15838 (/builds/slave/test/build/application/firefox/firefox http://localhost:53703/getInfo.html) 02:19:43 INFO - TEST-INFO | 15838: exit 0 02:19:43 INFO - Browser initialized. 02:19:43 INFO - Running cycle 1/1 for dromaeo_css test... 02:19:43 INFO - Using env: {'DISPLAY': ':0', 02:19:43 INFO - 'HOME': '/home/cltbld', 02:19:43 INFO - 'JSGC_DISABLE_POISONING': '1', 02:19:43 INFO - 'LANG': 'en_US.UTF-8', 02:19:43 INFO - 'LANGUAGE': 'en_US:en', 02:19:43 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:19:43 INFO - 'LOGNAME': 'cltbld', 02:19:43 INFO - 'MAIL': '/var/mail/cltbld', 02:19:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:19:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:19:43 INFO - 'MOZ_CRASHREPORTER': '1', 02:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:43 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:19:43 INFO - 'MOZ_NO_REMOTE': '1', 02:19:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:43 INFO - 'NO_EM_RESTART': '1', 02:19:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:43 INFO - 'PWD': '/builds/slave/test', 02:19:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:19:43 INFO - 'RUST_BACKTRACE': 'full', 02:19:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:19:43 INFO - 'SHELL': '/bin/bash', 02:19:43 INFO - 'SHLVL': '1', 02:19:43 INFO - 'STYLO_FORCE_ENABLED': '1', 02:19:43 INFO - 'TERM': 'linux', 02:19:43 INFO - 'TMOUT': '86400', 02:19:43 INFO - 'USER': 'cltbld', 02:19:43 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', 02:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:43 INFO - '_': '/tools/buildbot/bin/python'} 02:19:43 INFO - TEST-INFO | started process 16034 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiISkrC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:19:44 INFO - PID 16034 | 02:19:44 INFO - PID 16034 | (/builds/slave/test/build/application/firefox/firefox:16085): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:19:44 INFO - PID 16034 | 02:19:55 INFO - PID 16034 | RSS: Main: 172462080 02:19:55 INFO - PID 16034 | 02:22:53 INFO - PID 16034 | Cycle 1(1): loaded http://localhost:53703/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53703/tests/dromaeo/cssquery-ext.html) 02:22:55 INFO - PID 16034 | RSS: Main: 174080000 02:22:55 INFO - PID 16034 | 02:25:57 INFO - PID 16034 | Cycle 1(1): loaded http://localhost:53703/tests/dromaeo/cssquery-ext.html (next: http://localhost:53703/tests/dromaeo/cssquery-jquery.html) 02:25:58 INFO - PID 16034 | RSS: Main: 170766336 02:25:58 INFO - PID 16034 | 02:28:59 INFO - PID 16034 | Cycle 1(1): loaded http://localhost:53703/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53703/tests/dromaeo/cssquery-mootools.html) 02:29:00 INFO - PID 16034 | RSS: Main: 173047808 02:29:00 INFO - PID 16034 | 02:32:02 INFO - PID 16034 | Cycle 1(1): loaded http://localhost:53703/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53703/tests/dromaeo/cssquery-prototype.html) 02:32:02 INFO - PID 16034 | RSS: Main: 171560960 02:32:02 INFO - PID 16034 | 02:35:06 INFO - PID 16034 | Cycle 1(1): loaded http://localhost:53703/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53703/tests/dromaeo/cssquery-yui.html) 02:35:07 INFO - PID 16034 | RSS: Main: 170942464 02:35:07 INFO - PID 16034 | 02:38:08 INFO - PID 16034 | Cycle 1(1): loaded http://localhost:53703/tests/dromaeo/cssquery-yui.html (next: http://localhost:53703/tests/dromaeo/cssquery-dojo.html) 02:38:09 INFO - PID 16034 | RSS: Main: 175050752 02:38:09 INFO - PID 16034 | 02:38:09 INFO - PID 16034 | __start_tp_report 02:38:09 INFO - PID 16034 | _x_x_mozilla_page_load 02:38:09 INFO - PID 16034 | _x_x_mozilla_page_load_details 02:38:09 INFO - PID 16034 | |i|pagename|runs| 02:38:09 INFO - PID 16034 | |0;dojo.html;3296.2418643711962;3318.1372843060803;3322.103032181311;3334.5665063541737;3351.48052051932;6373.649449280299;6416.230052393714;6418.743250269995;6459.5478316517865;6530.934690653092;6188.938110618892;6274.372562743723;6289.119523266746;6289.1824062871765;6319.241690997087;5730.570207234464;5740.167675687023;5899.056151015839;5903.675297858616;5951.375105613914;5905.4980326672285;5919.319278283009;5967.582269241155;5995.370486098962;6006;1105.2010679470986;5689.089745640677;5727.513161381287;5865.384134665863;5986.10208468731;5706.115552089433;5844.649321040709;5887.470127688529;5923.407659234085;5925.111233315038;5806.506446952014;5820.722925052208;5873.735681894325;5887.234659494281;5887.558433117533;6344.587601805868;6353.650549219791;6363.8409039773915;6368.649724265164;6468.514861385368;6771.8984215236815;6793.116894803644;6798.422134118606;6891.069705589732;6906.654667266666;6593.868122637568;6707.631080290582;6741.359570840811;6832.487563432713;6939.306069393071;6173.753049878044;6231.688415579249;6234.3453937336835;6241.65670888101;6246.6252024878195;6898.068760717239;6906.171259448898;6972.651367431608;7057.0472986146215;7071.858562828715;6827.52207345481;6852.554583952027;6873.072135261776;6881.208661003949;6894.00036994633;6903.792886213321;6904.965475172692;6994.790156295319;7004.159500859828;7008.719651213996;6668.766593169215;6770.187577490733;6817.216020157646;6862.142232220973;6898.206706228748;6752.81825680504;6801;6852.143482064742;6933.445324374038;6935.479839012094;5356.517913387814;5400.243965844785;5404.486573775485;5410.594205434608;5423.728813559306;4724.692894961817;4753.786079626425;4800.447948485899;4806.663533552688;4819.156647586658;5778.8266352009505;6011.09833524966;6016;6091.9695401523595;6092.482139018233;6712.160979877515;6862.279460656659;6936.34104760047;6949.93050069503;6954.3393377629045;5909.881802364014;6037.72830222641;6058.242719660043;6077.453029227391;6080.726367313481;5891.587588868738;5899.882002359929;5958.821235362946;5988.101784732325;5989.401059893976;6466.515011374166;6570.277269500351;6674.5327827052615;6739.696713647898;6780.525363224527;6913.10129683138;6972.30276972319;6986.930130698831;6987.510874238755;6988.755393561201;6692.966535167293;6702.798916032527;6726.562773419712;6761.86476270462;6780.966095169492;6768;6810.897836532356;6847.760328388483;6866.553674011173;6918.238993710587;6688.230853451915;6711.765088222084;6914.0666010088;6938;7028.191757947697;6714.026466162281;6722.361375669304;6725.19297684281;6725.39471447572;6750.527463077734;6340.619562826245;6514.022896565553;6517.022446633043;6543.149390579194;6755.256921738506;6461.483081353575;6474.805755827333;6479.254885688018;6479.838004049937;6481.935180648322;6534.477241820738;6600.1089852869245;6693.397594216349;6810.046593476818;6816.897746533707;6457.5479716419395;6579.80260592183;6602.3397660233595;6607.07500949877;6617.07360969455 02:38:09 INFO - PID 16034 | |1;ext.html;794.3406972213064;838.2581415447328;858.2533196119377;881.4755220643718;881.546003808039;40546.18907621849;41068.79465602668;41113.17773644533;41148.58851411485;41385.37921931173;36159.81920090402;36228.2754344913;36411.817940910325;36444.27111457776;36537.45193822095;6809.1148150740455;6914.274001229874;6917.930820691804;6922.757703480379;6923.20383155936;6874.037634731141;6950.304969503035;6956.860862782742;6957.304269573053;6960.651967401635;6925.722971081151;7596.12644545876;7771.300582947533;7780.377569794431;7790;7659.540427574363;7709.653065612061;7710.113336966265;7713.460057795928;7715.151333353327;7374.741884034087;7550.471466997313;7574.621268936531;7649.847003059963;7670.654820533089;36710;37073.25853482942;37105.628943710755;37175.81412092949;37179.62820371816;3425.1779572902324;3480.477928310748;3480.8085555294447;3483.216276337829;3484.181217413906;30271.394572108653;30278.697213027808;30362;30371.088867333794;30372.392552148835;5108.66793658411;5124.205748109049;5125.641205115643;5127.48725127488;5136.460671629462;170550;172024;181459;183163;195908;46473.30290045652;46680.299795503095;47082.529174707815;47083;47102.76448617735;48428.27357589639;48477.27284090741;48576.27135592969;48582.75708621434;48597.75701121543;15648.608784780472;15730.134842583768;15783.684326313409;15791.526254212393;16031;13177.341132943315;13193.670158246121;13194.736105277841;13196.14225075367;13218.339083045808;13596.932015340059;13617.455301788015;13670.658233544242;13777.242251676054;13823.377947992365;5560.582956278296;5578.86052848682;5631.155326701028;5679;5710;999.93000489965;1024.0476356988072;1025.74869157057;1035;1036.5542816588938;22629.2079777207;22631.88684056602;22734.317970460583;23021.769782302297;23278.883605581865;1119.5521791283552;1120.8262719278525;1123.6067376418189;1126.707056165403;1138.7779383020397;12242.143049986593;15678.372865085497;15806.525804225892;15849.286782094834;16390.0165990041;240121;242473;242510;242863;242878;55444.445555544735;55556;55701.44298556963;55930.44069559334;56113.438865611635;1435.397133204057;1452.2738630684446;1463.239115659851;1470.713210923881;1482.199612209395;26100.608490873034;26876.865615671795;27078.458430831666;27222.591661125494;27352;37111.81444092762;37389.25221495609;37423.812880935424;37458.25083498369;37462.250754985296;210036;210395;210611;211006;211276;32420.35159296848;36179;37409.25181496409;37416.251674966894;37804.2439151221;44815.77592112149;45368.31947520856;45633.771831140635;45889.770551147034;45919;32833;33158.83420582882;33496.330073397905;33587.83206083954;34070.14824629404;32414.189645259055;32679.836600816845;32821.17947051343;33234.50148247826;33720.83139584286;36751.816240918626;37721.62278377181;37818.43272350862;37944.430833536964;38563.22873542457;31963.680363196072;32014.67985320117;32144.19639509031;32418.35163296768;32727.18182045468;23764.405889852893;23881.761182387952;24260.87869560641;24358.26925192247;24438.633420499064 02:38:09 INFO - PID 16034 | |2;jquery.html;570.4922618869207;571.1119209629026;573.6672729816706;587.3392433512297;592.5170985646697;22308.107675692972;23027.42431439215;23261.767382326194;23292.06831726731;23296.767032329673;24784.380390490245;25608;25609.35976600581;25617.87191064042;25628.23115306539;6590.439812615921;6732.326767323278;6754.729810807562;6763.323667633246;6764.661766911635;6268.279147897982;6500.707468163944;6515.967420162916;6525.151730275057;6525.673716314189;6498.805035848932;6505.284418713962;6506.577072490297;6506.577072490297;6507.05647681086;6486.675666216694;6496.285408605073;6500.869982600345;6502.089707440962;6518.771842985473;6067.453929146354;6078.149059131725;6078.574499785017;6084.756609735606;6088.238970128734;29141.85429072841;29223.415531689247;29695.70304296951;30493.69506304931;30528.236794080105;2032.7357443532394;2064.298138632872;2080.5006798368436;2086.4366621012396;2087.6972838938423;19859.50351241216;20628;20675.379738607866;20680;20772.065257063317;2428.6357046443177;2460.126655037454;2502.674652295208;2581.819272650915;2590.9481810363686;135592.32203839015;138941;139381.30309348388;139565;139710;13769.655758605915;14459.13245205291;14646.560603181922;14672.633184170481;14955.40178392852;23161.3051608452;23177.18879839231;23197.072117115466;23226.187083451998;23282.06871725112;9436;9456.385334953206;9506.667266645634;9586.66446674363;9691.70924872255;8251;8557;8573.871391929126;8678.652853885775;8794.34042446819;8840.292776577859;9009.864852027225;9122.042185570552;9373.437593744397;9389.10803473669;2553.9872300638376;2605.59613259945;2634.868256587163;2667.1865081150436;2742.7120152384114;962.8363178259713;965.7199412170532;978.3054031637474;993.7863458934067;994.3636072913341;19135.521611959535;19555.413337599894;19763.703544446846;19882.304119355755;19891.900540497496;1029.809485245232;1048.4495639789172;1055.6674647486018;1058.2803693488502;1062.8724553053528;11017.1186305097;11051.72370690739;11131.387773672364;11138.721531961766;11172.664820055412;439015;445391;445869;452413;453138;107317;107898;107986;109644;110067;1172.7068232941765;1193.4748710567324;1205.8070708686744;1220.8107743299802;1222.2299951030793;17205.655886882443;17410.912945435193;17420.825791742427;17796.55508612295;17864.374746883797;52018;52795.47204527906;52844.73577632087;53116.73441632767;53952.46047539474;62907.370926290154;63666.3633363679;63852.68073659602;64165.67917160384;66177.66911165413;14221.64445888861;14422.927885360927;14591.124532528082;14600.634984125481;14605.92697036508;21299.68050479213;21470.355889323346;21588.67616985715;21766;21821;18336.541586459913;18438.907805460887;18464.26142954267;18728.344507942158;18757.53106172302;16246.268917898959;16447.424340148038;16780.32878684839;16883.577910552336;17014.57463563421;17368;17996.820031799514;18774.15516301797;18983.620327593646;19139.71290430617;14228.786568201278;14437;14446.711065778416;14449.133052016912;14451.78322325187;17522.561935951195;17547.56131096733;17684.204210810287;17691.026993514966;17708.114594270493 02:38:09 INFO - PID 16034 | |3;mootools.html;1296.6174978381378;1351.3310911099009;1356.1524047470332;1367.986320136799;1370.1368138073015;14767.778483322745;14887.18120503372;15322.770158447618;15355.155466449341;15408.07551546908;15648.530544083667;15906.284217210225;15920;15925.92037039816;15933.044017358967;2774.7225277472294;2831.079899032812;2833.461642287969;2836.7872409569263;2843.4313137372505;2596.4028273497106;2683.3425810676313;2756.1180422264883;2767.266674331304;2799.8040137190405;2780.2215379693716;2800.705925877784;2807.2560771395492;2808.0593001344573;2815.81697189682;2670.3724624713177;2692.824966377189;2718.3068317579086;2719.252205643444;2719.4425142845867;2616.3197568632104;2646.735326467357;2647.721989191146;2648.596243990688;2648.9072882449022;14888.851111488855;15242.161681107535;15259;15259.847401525954;15298;7948.801279967989;8206.671733130728;8226.588670566507;8233.17668233178;8236.217559331853;4930.704157750511;5272;5285.920711189336;5313.123334649778;5401.189821526802;1828.9451316460527;1901.0969789350086;1908.1031914999928;1948.2401863273335;1963.185278109583;26787;26887.731122688914;26990.46019079627;27080;27107.1867843965;6566.212054553484;6752.696128674222;6753.189617245962;6868.416184624263;6902.240753517109;16677.583060423345;16682.416115435903;16689;16692.74960875588;16722.414715484898;7626.504277221963;7812.84374312522;7854.1753115922;7857.842843143105;7871.212878712083;7215.963920180366;7274.927250727425;7305.853882922312;7369.6315184240575;7379.963100184465;4770.141374552614;4980.327655766498;4993.7503124843615;5020.7740651670765;5022.7990880365105;1269.9428525716364;1313.3958379145508;1326.9535566255136;1397.4689617945116;1434.978475322871;899.8335307967916;912.5802131019673;917.8944421391492;922.8338898998111;925.9583318750672;7418.295261950106;7536.547807131589;7579.962100189574;7594.924050759532;7600.543967361976;987.4519641598981;990.5938565188238;998.3361064891766;1003.6788227767045;1010.545254635417;4517;4605.424321959755;4618.584327410482;4648.140094082605;4657.371254880615;21163;21349.35951921445;21817.23639672604;22099.889500552716;22115.44711382196;21135.837528936056;21714.457138571663;21816.127354905628;21890;22015.559688806134;11471.426428678533;11636;11706.1220408468;11758;11761.647150585497;8250.587470626324;8785.648574056966;9134.086591340812;9163.77090572741;9170.312226582899;18656.253749849853;18713.345032923782;18833.6233275331;18960.525986849887;19152.329668461538;19539;19572.217111315957;19592.510187245432;19605.901970490057;19727.60544789125;10683.732906677395;10983.780324393627;11057.668269951915;11059.059979901798;11077.889221108007;13660.180389176681;13664.795028074786;13800;13812.585622431343;13833.30833458303;11010.119190464904;11024.062954648945;11356.659300221007;11370.31778093317;11469.139814513777;10767.676969690921;11040.061594764535;11074.335539867634;11125.554977800797;11132;9376.203022743142;9552.23582113443;9558.139767420966;9568.904310956801;9582.760430989281;6848.2124555674745;6875.4155896749335;6900.516963812685;6954.826129346807;6961.025456436204;7229.674664640209;7233;7306.744263950736;7332.120145582351;7388.852222955618 02:38:09 INFO - PID 16034 | |4;prototype.html;494.1666417590739;504.16308927180864;534.3961323704214;537.9569634429243;538.6471860931086;6385.968070159648;6439.0741083071425;6491.448226900708;6530.183727034121;6562.901556476645;6153.415425534578;6309.5392796809165;6310.507349596906;6326.936730632692;6331.493480521559;5011.373578302712;5019.171836646949;5027.321311622939;5059.873503162423;5076.695398276115;5039.874003149914;5040.697558146523;5084.186530155176;5104.923426148611;5105.310783044297;4890.266460030988;4990.550850423461;5033.54698077173;5037.974810125944;5046.192609182532;5053.4946505349535;5053.772580233898;5058.128492457778;5058.974705126469;5059.974700126494;4527.298268768346;4548.385967894358;4555.339475775994;4569.977150114261;4582.15230182414;6337.493000559944;6350.809475715736;6370.299267080617;6385.169927909388;6410.61536307823;5783.624064435799;5788.913166302509;5790.594658373915;5804.738786754606;5833.32916714579;6641.933580664228;6717.764878229287;6725.663716814189;6752.493562982796;6832.931670683329;4813.352656039165;4885.413750349945;4911.484294149099;4913.901721965576;4928.137575924235;7013.544119632259;7025.683844227022;7030.296970303031;7140.928590714078;7164;5073.797048118034;5084.46613105626;5094.337736094358;5114.43741188469;5124.666896651705;5118.61610379223;5127.333446651912;5130.769115389817;5143.922841157386;5146.125158723026;5754.683492407874;5768.653880767168;5782.392848750905;5796.391378905154;5798.333191682926;6804.897926531106;6839.794806155724;6843.726250949906;6853.760118395832;6880.58716477013;1644.761509581104;1697.2447260968997;1712.332190445727;1742.5033865348569;1769.3364988129451;1199.6041306368877;1231.2120243044458;1232.4515590562294;1241.6652098993618;1246.4702501436852;5911.379305172981;5967.16459695643;5968.940310596839;5976.9402305977255;5995.5803093783015;6811.591304521745;6847.828804279933;6894.207166175954;6912.688928998207;6935.895961560581;5842.182094506772;5898.14476900847;5902.704864756831;5952.523798096142;5976.970115149396;3671.2840996006057;3688.723345749026;3699;3703.8703195525623;3718.4794128821986;6693.431058360094;6714.630695311707;6719.529632925648;6748.730050798012;6763;7072.115985501812;7091.468139889529;7102.254263302279;7153.4992550522;7158.498905076699;6643.236027856762;6649.470621757023;6668.933310666928;6676.732930682912;6686.364795344434;6893.276205998298;6918.654067296515;6943.3683084476115;6945.826354341182;6983.650817459208;6891.173059232724;6914.0666010088;6922.61925594077;6933.514653974174;6936.41040511542;6711.63086030273;6725.361090696376;6746.9325306746305;6760.898586521108;6767.526273161028;5071.264666623245;5074.594032477319;5083.949160508496;5101.183810590288;5108.948910510847;6960.962641667922;6977.33715297046;6988.091548098715;6994.685239164148;7016.6491675415;6637.701303441453;6661.134052573135;6699.3872389769;6722.159730033746;6746.4265537429865;6103.816885493442;6716.899246511404;6732.764353247613;6776.525643204928;6805.081314022742;6646.268910419946;6698.990302909206;6724.394804467622;6727.293634168342;6734.461243100638;6665.200175978914;6687.598744075371;6721.731130754715;6776.93223067763;6852.760153394607;6363.840903977252;6443.613383197023;6498.805035848932;6526.608403495806;6576.210854697467 02:38:09 INFO - PID 16034 | |5;yui.html;912.197266405563;914.9268058555316;927.3647551427268;936.7798567336674;949.6676163342831;18146.818531814693;19048.714269285956;19063.142158602863;19070.61858762824;21167.57664846702;20728.68906966393;21190.682139767916;21255.6811647825;21257;21317.147314107417;912.6668765900448;930.1070971866982;931.7391130483476;932.5430539035891;933.8972713001565;952.4618590496348;967.7483854197889;968.9224862011022;970.0784254957783;970.9805803883918;1026.984595231072;1029.9897001030006;1032.463119178027;1033.2715435617872;1035.2339268941005;1019.7093828258911;1020.7856350166437;1022.0086516079429;1024.0118285854148;1025.5948900184385;758.3213024343237;759.5366826235992;761.090496856257;762.2073044034198;763.290140169642;17987.73018404725;18248;18407.171677274553;18421.26314947414;20267.087981040888;21066.683999740017;21237;21376.46558836026;21761.673574896387;21796.237131700473;16124.677506449923;16288.755668664979;16543.91728041352;16594.6681066378;16601.252943617565;3713.6100709425664;3749.793761343125;3751.1184871555433;3754.155315054118;3754.2866855297407;117479;119405;119419.40290298493;120429;121846;15647.608809779847;16146.434874779326;16243.51269461918;16244.350225990827;16256.43102491407;28707.56938645922;29779.40441191164;29864.40271194564;29908.401831963674;29915;8067.3142782864115;8530.402871798915;8558.272546833588;8564.957175214084;8608;4432.955670443254;4514.6388288936805;4519.118771839459;4528.637708983273;4536.637069034469;5387.164989426645;5421.566274698014;5508.118701007819;5531.9723401382735;5553.055980483327;1077.5151181968147;1111.2110401614943;1114.6934592986831;1115.4311301236428;1125.291066628019;622.7415622516695;632.3771085480797;633.2401118657538;638.2564312575797;653.1019847709399;11206.38364889939;11265.191415573434;11362.431878406047;11454.713632159095;11627.476763545661;675.4562577125363;680.8638272345551;692.7609974558769;695.5826504097602;696.2376198063113;5171.97414012935;5318.627696061239;5451.155070964007;5496.945030549723;5633.774649014075;116920;119594.40202799105;119748;120556;122027.3898630519;102063;102936.48531757294;106576.46711766547;108518;109281.45359273153;92342;96224.51887740516;96618.99999999859;98869.0226195472;98964;11556.653300401002;11707.824382634097;11794;11924.70188245266;12010.339431331011;42194;42681.57318426776;42957;42986.57013429826;43388;54562.454375457324;54841;55026.17460738012;55159.72420137873;57856.13215801682;17316.653666926843;17555.82444175542;17709.38017169393;17799.644007120045;17927.282908683508;16742.162891855114;16821.243044063292;16920.915395422944;17018.74471882898;17164.485065448058;16417.097059661355;16497.91751041237;16548.75176872372;16636.58408539796;16641.66716665684;15634.687306254038;17026.404075857285;17166.82833171702;17356.305747769948;17378.739318909975;17912.91043544774;18126.456206313833;18166.636667266845;18198.363057292932;18385.356512521998;12722.554710585086;12724.236545807282;12952.222866628032;12966.481340746643;12973.351332433529;13567;13746.518871839438;13822.86177138256;13916.095453795471;14255.287235638383 02:38:09 INFO - PID 16034 | __end_tp_report 02:38:09 INFO - PID 16034 | __start_cc_report 02:38:09 INFO - PID 16034 | _x_x_mozilla_cycle_collect,356 02:38:09 INFO - PID 16034 | __end_cc_report 02:38:09 INFO - PID 16034 | __startTimestamp1504258689108__endTimestamp 02:38:09 INFO - PID 16034 | 02:38:09 INFO - PID 16034 | ------- Summary: start ------- 02:38:09 INFO - PID 16034 | Number of tests: 6 02:38:09 INFO - PID 16034 | 02:38:09 INFO - PID 16034 | [#0] dojo.html Cycles:165 Average:6278.30 Median:6514.02 stddev:841.52 (12.9%) stddev-sans-first:810.93 02:38:09 INFO - PID 16034 | Values: 3296.2 3318.1 3322.1 3334.6 3351.5 6373.6 6416.2 6418.7 6459.5 6530.9 6188.9 6274.4 6289.1 6289.2 6319.2 5730.6 5740.2 5899.1 5903.7 5951.4 5905.5 5919.3 5967.6 5995.4 6006.0 1105.2 5689.1 5727.5 5865.4 5986.1 5706.1 5844.6 5887.5 5923.4 5925.1 5806.5 5820.7 5873.7 5887.2 5887.6 6344.6 6353.7 6363.8 6368.6 6468.5 6771.9 6793.1 6798.4 6891.1 6906.7 6593.9 6707.6 6741.4 6832.5 6939.3 6173.8 6231.7 6234.3 6241.7 6246.6 6898.1 6906.2 6972.7 7057.0 7071.9 6827.5 6852.6 6873.1 6881.2 6894.0 6903.8 6905.0 6994.8 7004.2 7008.7 6668.8 6770.2 6817.2 6862.1 6898.2 6752.8 6801.0 6852.1 6933.4 6935.5 5356.5 5400.2 5404.5 5410.6 5423.7 4724.7 4753.8 4800.4 4806.7 4819.2 5778.8 6011.1 6016.0 6092.0 6092.5 6712.2 6862.3 6936.3 6949.9 6954.3 5909.9 6037.7 6058.2 6077.5 6080.7 5891.6 5899.9 5958.8 5988.1 5989.4 6466.5 6570.3 6674.5 6739.7 6780.5 6913.1 6972.3 6986.9 6987.5 6988.8 6693.0 6702.8 6726.6 6761.9 6781.0 6768.0 6810.9 6847.8 6866.6 6918.2 6688.2 6711.8 6914.1 6938.0 7028.2 6714.0 6722.4 6725.2 6725.4 6750.5 6340.6 6514.0 6517.0 6543.1 6755.3 6461.5 6474.8 6479.3 6479.8 6481.9 6534.5 6600.1 6693.4 6810.0 6816.9 6457.5 6579.8 6602.3 6607.1 6617.1 02:38:09 INFO - PID 16034 | 02:38:09 INFO - PID 16034 | [#1] ext.html Cycles:180 Average:38115.01 Median:36169.41 stddev:55147.03 (152.5%) stddev-sans-first:55230.53 02:38:09 INFO - PID 16034 | Values: 794.3 838.3 858.3 881.5 881.5 40546.2 41068.8 41113.2 41148.6 41385.4 36159.8 36228.3 36411.8 36444.3 36537.5 6809.1 6914.3 6917.9 6922.8 6923.2 6874.0 6950.3 6956.9 6957.3 6960.7 6925.7 7596.1 7771.3 7780.4 7790.0 7659.5 7709.7 7710.1 7713.5 7715.2 7374.7 7550.5 7574.6 7649.8 7670.7 36710.0 37073.3 37105.6 37175.8 37179.6 3425.2 3480.5 3480.8 3483.2 3484.2 30271.4 30278.7 30362.0 30371.1 30372.4 5108.7 5124.2 5125.6 5127.5 5136.5 170550.0 172024.0 181459.0 183163.0 195908.0 46473.3 46680.3 47082.5 47083.0 47102.8 48428.3 48477.3 48576.3 48582.8 48597.8 15648.6 15730.1 15783.7 15791.5 16031.0 13177.3 13193.7 13194.7 13196.1 13218.3 13596.9 13617.5 13670.7 13777.2 13823.4 5560.6 5578.9 5631.2 5679.0 5710.0 999.9 1024.0 1025.7 1035.0 1036.6 22629.2 22631.9 22734.3 23021.8 23278.9 1119.6 1120.8 1123.6 1126.7 1138.8 12242.1 15678.4 15806.5 15849.3 16390.0 240121.0 242473.0 242510.0 242863.0 242878.0 55444.4 55556.0 55701.4 55930.4 56113.4 1435.4 1452.3 1463.2 1470.7 1482.2 26100.6 26876.9 27078.5 27222.6 27352.0 37111.8 37389.3 37423.8 37458.3 37462.3 210036.0 210395.0 210611.0 211006.0 211276.0 32420.4 36179.0 37409.3 37416.3 37804.2 44815.8 45368.3 45633.8 45889.8 45919.0 32833.0 33158.8 33496.3 33587.8 34070.1 32414.2 32679.8 32821.2 33234.5 33720.8 36751.8 37721.6 37818.4 37944.4 38563.2 31963.7 32014.7 32144.2 32418.4 32727.2 23764.4 23881.8 24260.9 24358.3 24438.6 02:38:09 INFO - PID 16034 | 02:38:09 INFO - PID 16034 | [#2] jquery.html Cycles:180 Average:33018.18 Median:23243.98 stddev:75738.82 (325.8%) stddev-sans-first:75912.10 02:38:09 INFO - PID 16034 | Values: 570.5 571.1 573.7 587.3 592.5 22308.1 23027.4 23261.8 23292.1 23296.8 24784.4 25608.0 25609.4 25617.9 25628.2 6590.4 6732.3 6754.7 6763.3 6764.7 6268.3 6500.7 6516.0 6525.2 6525.7 6498.8 6505.3 6506.6 6506.6 6507.1 6486.7 6496.3 6500.9 6502.1 6518.8 6067.5 6078.1 6078.6 6084.8 6088.2 29141.9 29223.4 29695.7 30493.7 30528.2 2032.7 2064.3 2080.5 2086.4 2087.7 19859.5 20628.0 20675.4 20680.0 20772.1 2428.6 2460.1 2502.7 2581.8 2590.9 135592.3 138941.0 139381.3 139565.0 139710.0 13769.7 14459.1 14646.6 14672.6 14955.4 23161.3 23177.2 23197.1 23226.2 23282.1 9436.0 9456.4 9506.7 9586.7 9691.7 8251.0 8557.0 8573.9 8678.7 8794.3 8840.3 9009.9 9122.0 9373.4 9389.1 2554.0 2605.6 2634.9 2667.2 2742.7 962.8 965.7 978.3 993.8 994.4 19135.5 19555.4 19763.7 19882.3 19891.9 1029.8 1048.4 1055.7 1058.3 1062.9 11017.1 11051.7 11131.4 11138.7 11172.7 439015.0 445391.0 445869.0 452413.0 453138.0 107317.0 107898.0 107986.0 109644.0 110067.0 1172.7 1193.5 1205.8 1220.8 1222.2 17205.7 17410.9 17420.8 17796.6 17864.4 52018.0 52795.5 52844.7 53116.7 53952.5 62907.4 63666.4 63852.7 64165.7 66177.7 14221.6 14422.9 14591.1 14600.6 14605.9 21299.7 21470.4 21588.7 21766.0 21821.0 18336.5 18438.9 18464.3 18728.3 18757.5 16246.3 16447.4 16780.3 16883.6 17014.6 17368.0 17996.8 18774.2 18983.6 19139.7 14228.8 14437.0 14446.7 14449.1 14451.8 17522.6 17547.6 17684.2 17691.0 17708.1 02:38:09 INFO - PID 16034 | 02:38:09 INFO - PID 16034 | [#3] mootools.html Cycles:180 Average:9324.54 Median:14785.54 stddev:6768.79 (45.8%) stddev-sans-first:6760.91 02:38:09 INFO - PID 16034 | Values: 1296.6 1351.3 1356.2 1368.0 1370.1 14767.8 14887.2 15322.8 15355.2 15408.1 15648.5 15906.3 15920.0 15925.9 15933.0 2774.7 2831.1 2833.5 2836.8 2843.4 2596.4 2683.3 2756.1 2767.3 2799.8 2780.2 2800.7 2807.3 2808.1 2815.8 2670.4 2692.8 2718.3 2719.3 2719.4 2616.3 2646.7 2647.7 2648.6 2648.9 14888.9 15242.2 15259.0 15259.8 15298.0 7948.8 8206.7 8226.6 8233.2 8236.2 4930.7 5272.0 5285.9 5313.1 5401.2 1828.9 1901.1 1908.1 1948.2 1963.2 26787.0 26887.7 26990.5 27080.0 27107.2 6566.2 6752.7 6753.2 6868.4 6902.2 16677.6 16682.4 16689.0 16692.7 16722.4 7626.5 7812.8 7854.2 7857.8 7871.2 7216.0 7274.9 7305.9 7369.6 7380.0 4770.1 4980.3 4993.8 5020.8 5022.8 1269.9 1313.4 1327.0 1397.5 1435.0 899.8 912.6 917.9 922.8 926.0 7418.3 7536.5 7580.0 7594.9 7600.5 987.5 990.6 998.3 1003.7 1010.5 4517.0 4605.4 4618.6 4648.1 4657.4 21163.0 21349.4 21817.2 22099.9 22115.4 21135.8 21714.5 21816.1 21890.0 22015.6 11471.4 11636.0 11706.1 11758.0 11761.6 8250.6 8785.6 9134.1 9163.8 9170.3 18656.3 18713.3 18833.6 18960.5 19152.3 19539.0 19572.2 19592.5 19605.9 19727.6 10683.7 10983.8 11057.7 11059.1 11077.9 13660.2 13664.8 13800.0 13812.6 13833.3 11010.1 11024.1 11356.7 11370.3 11469.1 10767.7 11040.1 11074.3 11125.6 11132.0 9376.2 9552.2 9558.1 9568.9 9582.8 6848.2 6875.4 6900.5 6954.8 6961.0 7229.7 7233.0 7306.7 7332.1 7388.9 02:38:09 INFO - PID 16034 | 02:38:09 INFO - PID 16034 | [#4] prototype.html Cycles:180 Average:5654.87 Median:6334.49 stddev:1611.81 (25.4%) stddev-sans-first:1569.10 02:38:09 INFO - PID 16034 | Values: 494.2 504.2 534.4 538.0 538.6 6386.0 6439.1 6491.4 6530.2 6562.9 6153.4 6309.5 6310.5 6326.9 6331.5 5011.4 5019.2 5027.3 5059.9 5076.7 5039.9 5040.7 5084.2 5104.9 5105.3 4890.3 4990.6 5033.5 5038.0 5046.2 5053.5 5053.8 5058.1 5059.0 5060.0 4527.3 4548.4 4555.3 4570.0 4582.2 6337.5 6350.8 6370.3 6385.2 6410.6 5783.6 5788.9 5790.6 5804.7 5833.3 6641.9 6717.8 6725.7 6752.5 6832.9 4813.4 4885.4 4911.5 4913.9 4928.1 7013.5 7025.7 7030.3 7140.9 7164.0 5073.8 5084.5 5094.3 5114.4 5124.7 5118.6 5127.3 5130.8 5143.9 5146.1 5754.7 5768.7 5782.4 5796.4 5798.3 6804.9 6839.8 6843.7 6853.8 6880.6 1644.8 1697.2 1712.3 1742.5 1769.3 1199.6 1231.2 1232.5 1241.7 1246.5 5911.4 5967.2 5968.9 5976.9 5995.6 6811.6 6847.8 6894.2 6912.7 6935.9 5842.2 5898.1 5902.7 5952.5 5977.0 3671.3 3688.7 3699.0 3703.9 3718.5 6693.4 6714.6 6719.5 6748.7 6763.0 7072.1 7091.5 7102.3 7153.5 7158.5 6643.2 6649.5 6668.9 6676.7 6686.4 6893.3 6918.7 6943.4 6945.8 6983.7 6891.2 6914.1 6922.6 6933.5 6936.4 6711.6 6725.4 6746.9 6760.9 6767.5 5071.3 5074.6 5083.9 5101.2 5108.9 6961.0 6977.3 6988.1 6994.7 7016.6 6637.7 6661.1 6699.4 6722.2 6746.4 6103.8 6716.9 6732.8 6776.5 6805.1 6646.3 6699.0 6724.4 6727.3 6734.5 6665.2 6687.6 6721.7 6776.9 6852.8 6363.8 6443.6 6498.8 6526.6 6576.2 02:38:09 INFO - PID 16034 | 02:38:09 INFO - PID 16034 | [#5] yui.html Cycles:180 Average:23745.50 Median:19055.93 stddev:33082.39 (173.6%) stddev-sans-first:33130.77 02:38:09 INFO - PID 16034 | Values: 912.2 914.9 927.4 936.8 949.7 18146.8 19048.7 19063.1 19070.6 21167.6 20728.7 21190.7 21255.7 21257.0 21317.1 912.7 930.1 931.7 932.5 933.9 952.5 967.7 968.9 970.1 971.0 1027.0 1030.0 1032.5 1033.3 1035.2 1019.7 1020.8 1022.0 1024.0 1025.6 758.3 759.5 761.1 762.2 763.3 17987.7 18248.0 18407.2 18421.3 20267.1 21066.7 21237.0 21376.5 21761.7 21796.2 16124.7 16288.8 16543.9 16594.7 16601.3 3713.6 3749.8 3751.1 3754.2 3754.3 117479.0 119405.0 119419.4 120429.0 121846.0 15647.6 16146.4 16243.5 16244.4 16256.4 28707.6 29779.4 29864.4 29908.4 29915.0 8067.3 8530.4 8558.3 8565.0 8608.0 4433.0 4514.6 4519.1 4528.6 4536.6 5387.2 5421.6 5508.1 5532.0 5553.1 1077.5 1111.2 1114.7 1115.4 1125.3 622.7 632.4 633.2 638.3 653.1 11206.4 11265.2 11362.4 11454.7 11627.5 675.5 680.9 692.8 695.6 696.2 5172.0 5318.6 5451.2 5496.9 5633.8 116920.0 119594.4 119748.0 120556.0 122027.4 102063.0 102936.5 106576.5 108518.0 109281.5 92342.0 96224.5 96619.0 98869.0 98964.0 11556.7 11707.8 11794.0 11924.7 12010.3 42194.0 42681.6 42957.0 42986.6 43388.0 54562.5 54841.0 55026.2 55159.7 57856.1 17316.7 17555.8 17709.4 17799.6 17927.3 16742.2 16821.2 16920.9 17018.7 17164.5 16417.1 16497.9 16548.8 16636.6 16641.7 15634.7 17026.4 17166.8 17356.3 17378.7 17912.9 18126.5 18166.6 18198.4 18385.4 12722.6 12724.2 12952.2 12966.5 12973.4 13567.0 13746.5 13822.9 13916.1 14255.3 02:38:09 INFO - PID 16034 | -------- Summary: end -------- 02:38:09 INFO - PID 16034 | 02:38:09 INFO - TEST-INFO | 16034: exit 0 02:38:09 INFO - TEST-OK | dromaeo_css | took 1111355ms 02:38:09 INFO - TEST-START | kraken 02:38:09 INFO - Initialising browser for kraken test... 02:38:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53703/getInfo.html -profile /tmp/tmpeoaSJn/profile 02:38:09 INFO - TEST-INFO | started process 16410 (/builds/slave/test/build/application/firefox/firefox http://localhost:53703/getInfo.html) 02:38:15 INFO - TEST-INFO | 16410: exit 0 02:38:15 INFO - Browser initialized. 02:38:15 INFO - Running cycle 1/1 for kraken test... 02:38:15 INFO - Using env: {'DISPLAY': ':0', 02:38:15 INFO - 'HOME': '/home/cltbld', 02:38:15 INFO - 'JSGC_DISABLE_POISONING': '1', 02:38:15 INFO - 'LANG': 'en_US.UTF-8', 02:38:15 INFO - 'LANGUAGE': 'en_US:en', 02:38:15 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:38:15 INFO - 'LOGNAME': 'cltbld', 02:38:15 INFO - 'MAIL': '/var/mail/cltbld', 02:38:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:38:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:38:15 INFO - 'MOZ_CRASHREPORTER': '1', 02:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:15 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:38:15 INFO - 'MOZ_NO_REMOTE': '1', 02:38:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:15 INFO - 'NO_EM_RESTART': '1', 02:38:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:15 INFO - 'PWD': '/builds/slave/test', 02:38:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:38:15 INFO - 'RUST_BACKTRACE': 'full', 02:38:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:38:15 INFO - 'SHELL': '/bin/bash', 02:38:15 INFO - 'SHLVL': '1', 02:38:15 INFO - 'STYLO_FORCE_ENABLED': '1', 02:38:15 INFO - 'TERM': 'linux', 02:38:15 INFO - 'TMOUT': '86400', 02:38:15 INFO - 'USER': 'cltbld', 02:38:15 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064', 02:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:15 INFO - '_': '/tools/buildbot/bin/python'} 02:38:15 INFO - TEST-INFO | started process 16605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeoaSJn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:38:16 INFO - PID 16605 | 02:38:16 INFO - PID 16605 | (/builds/slave/test/build/application/firefox/firefox:16656): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:38:16 INFO - PID 16605 | 02:38:26 INFO - PID 16605 | RSS: Main: 173162496 02:38:26 INFO - PID 16605 | 02:38:29 INFO - PID 16605 | Cycle 1(1): loaded http://localhost:53703/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53703/tests/kraken/driver.html?testName=audio-beat-detection) 02:38:30 INFO - PID 16605 | RSS: Main: 178814976 02:38:30 INFO - PID 16605 | 02:38:32 INFO - PID 16605 | Cycle 1(1): loaded http://localhost:53703/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53703/tests/kraken/driver.html?testName=audio-dft) 02:38:33 INFO - PID 16605 | RSS: Main: 182976512 02:38:33 INFO - PID 16605 | 02:38:36 INFO - PID 16605 | Cycle 1(1): loaded http://localhost:53703/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53703/tests/kraken/driver.html?testName=audio-fft) 02:38:36 INFO - PID 16605 | RSS: Main: 174833664 02:38:36 INFO - PID 16605 | 02:38:39 INFO - PID 16605 | Cycle 1(1): loaded http://localhost:53703/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53703/tests/kraken/driver.html?testName=audio-oscillator) 02:38:39 INFO - PID 16605 | RSS: Main: 175628288 02:38:39 INFO - PID 16605 | 02:38:41 INFO - PID 16605 | Cycle 1(1): loaded http://localhost:53703/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53703/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:38:42 INFO - PID 16605 | RSS: Main: 175775744 02:38:42 INFO - PID 16605 | 02:38:45 INFO - PID 16605 | Cycle 1(1): loaded http://localhost:53703/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53703/tests/kraken/driver.html?testName=imaging-darkroom) 02:38:46 INFO - PID 16605 | RSS: Main: 176640000 02:38:46 INFO - PID 16605 | 02:38:49 INFO - PID 16605 | Cycle 1(1): loaded http://localhost:53703/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53703/tests/kraken/driver.html?testName=imaging-desaturate) 02:38:50 INFO - PID 16605 | RSS: Main: 176979968 02:38:50 INFO - PID 16605 | 02:38:53 INFO - PID 16605 | Cycle 1(1): loaded http://localhost:53703/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53703/tests/kraken/driver.html?testName=json-parse-financial) 02:38:53 INFO - PID 16605 | RSS: Main: 177467392 02:38:53 INFO - PID 16605 | 02:38:55 INFO - PID 16605 | Cycle 1(1): loaded http://localhost:53703/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53703/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:38:56 INFO - PID 16605 | RSS: Main: 177553408 02:38:56 INFO - PID 16605 | 02:38:57 INFO - PID 16605 | Cycle 1(1): loaded http://localhost:53703/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53703/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:38:58 INFO - PID 16605 | RSS: Main: 177106944 02:38:58 INFO - PID 16605 | 02:39:00 INFO - PID 16605 | Cycle 1(1): loaded http://localhost:53703/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53703/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:39:01 INFO - PID 16605 | RSS: Main: 173686784 02:39:01 INFO - PID 16605 | 02:39:03 INFO - PID 16605 | Cycle 1(1): loaded http://localhost:53703/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53703/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:39:04 INFO - PID 16605 | RSS: Main: 173772800 02:39:04 INFO - PID 16605 | 02:39:07 INFO - PID 16605 | Cycle 1(1): loaded http://localhost:53703/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53703/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:39:08 INFO - PID 16605 | RSS: Main: 174088192 02:39:08 INFO - PID 16605 | 02:39:09 INFO - PID 16605 | Cycle 1(1): loaded http://localhost:53703/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53703/tests/kraken/driver.html?testName=ai-astar) 02:39:10 INFO - PID 16605 | RSS: Main: 175587328 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | __start_tp_report 02:39:10 INFO - PID 16605 | _x_x_mozilla_page_load 02:39:10 INFO - PID 16605 | _x_x_mozilla_page_load_details 02:39:10 INFO - PID 16605 | |i|pagename|runs| 02:39:10 INFO - PID 16605 | |0;ai-astar;105;110;95;107;110;108;109;107;108;111 02:39:10 INFO - PID 16605 | |1;audio-beat-detection;136;116;151;170;118;139;147;120;175;117 02:39:10 INFO - PID 16605 | |2;audio-dft;163;162;161;161;160;162;165;166;169;163 02:39:10 INFO - PID 16605 | |3;audio-fft;74;74;73;172;78;76;73;73;158;75 02:39:10 INFO - PID 16605 | |4;audio-oscillator;79;80;135;81;83;80;128;80;79;130 02:39:10 INFO - PID 16605 | |5;imaging-gaussian-blur;114;115;114;114;114;114;114;115;115;115 02:39:10 INFO - PID 16605 | |6;imaging-darkroom;147;149;148;148;148;149;148;149;148;148 02:39:10 INFO - PID 16605 | |7;imaging-desaturate;93;94;94;94;95;95;96;94;94;94 02:39:10 INFO - PID 16605 | |8;json-parse-financial;53;53;52;53;53;53;53;52;52;53 02:39:10 INFO - PID 16605 | |9;json-stringify-tinderbox;38;38;38;38;38;38;37;38;37;38 02:39:10 INFO - PID 16605 | |10;stanford-crypto-aes;75;76;78;74;73;77;75;79;80;76 02:39:10 INFO - PID 16605 | |11;stanford-crypto-ccm;120;117;124;125;126;123;118;116;123;166 02:39:10 INFO - PID 16605 | |12;stanford-crypto-pbkdf2;181;170;171;173;182;169;170;167;167;172 02:39:10 INFO - PID 16605 | |13;stanford-crypto-sha256-iterative;65;64;65;64;64;66;66;70;65;67 02:39:10 INFO - PID 16605 | __end_tp_report 02:39:10 INFO - PID 16605 | __start_cc_report 02:39:10 INFO - PID 16605 | _x_x_mozilla_cycle_collect,902 02:39:10 INFO - PID 16605 | __end_cc_report 02:39:10 INFO - PID 16605 | __startTimestamp1504258750122__endTimestamp 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | ------- Summary: start ------- 02:39:10 INFO - PID 16605 | Number of tests: 14 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | [#0] ai-astar Cycles:10 Average:107.00 Median:109.50 stddev:4.57 (4.2%) stddev-sans-first:4.79 02:39:10 INFO - PID 16605 | Values: 105.0 110.0 95.0 107.0 110.0 108.0 109.0 107.0 108.0 111.0 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:143.00 stddev:21.83 (15.3%) stddev-sans-first:23.13 02:39:10 INFO - PID 16605 | Values: 136.0 116.0 151.0 170.0 118.0 139.0 147.0 120.0 175.0 117.0 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.74 (1.7%) stddev-sans-first:2.91 02:39:10 INFO - PID 16605 | Values: 163.0 162.0 161.0 161.0 160.0 162.0 165.0 166.0 169.0 163.0 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | [#3] audio-fft Cycles:10 Average:92.60 Median:74.00 stddev:38.33 (51.8%) stddev-sans-first:40.06 02:39:10 INFO - PID 16605 | Values: 74.0 74.0 73.0 172.0 78.0 76.0 73.0 73.0 158.0 75.0 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:80.00 stddev:24.58 (30.7%) stddev-sans-first:25.34 02:39:10 INFO - PID 16605 | Values: 79.0 80.0 135.0 81.0 83.0 80.0 128.0 80.0 79.0 130.0 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:39:10 INFO - PID 16605 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 114.0 115.0 115.0 115.0 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 02:39:10 INFO - PID 16605 | Values: 147.0 149.0 148.0 148.0 148.0 149.0 148.0 149.0 148.0 148.0 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 02:39:10 INFO - PID 16605 | Values: 93.0 94.0 94.0 94.0 95.0 95.0 96.0 94.0 94.0 94.0 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 02:39:10 INFO - PID 16605 | Values: 53.0 53.0 52.0 53.0 53.0 53.0 53.0 52.0 52.0 53.0 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 02:39:10 INFO - PID 16605 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 37.0 38.0 37.0 38.0 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.50 stddev:2.21 (2.9%) stddev-sans-first:2.30 02:39:10 INFO - PID 16605 | Values: 75.0 76.0 78.0 74.0 73.0 77.0 75.0 79.0 80.0 76.0 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:123.50 stddev:14.54 (11.8%) stddev-sans-first:15.27 02:39:10 INFO - PID 16605 | Values: 120.0 117.0 124.0 125.0 126.0 123.0 118.0 116.0 123.0 166.0 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:171.50 stddev:5.27 (3.1%) stddev-sans-first:4.52 02:39:10 INFO - PID 16605 | Values: 181.0 170.0 171.0 173.0 182.0 169.0 170.0 167.0 167.0 172.0 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:1.84 (2.8%) stddev-sans-first:1.94 02:39:10 INFO - PID 16605 | Values: 65.0 64.0 65.0 64.0 64.0 66.0 66.0 70.0 65.0 67.0 02:39:10 INFO - PID 16605 | -------- Summary: end -------- 02:39:10 INFO - PID 16605 | 02:39:10 INFO - PID 16605 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 02:39:10 INFO - TEST-INFO | 16605: exit 0 02:39:10 INFO - TEST-OK | kraken | took 60956ms 02:39:10 INFO - SUITE-END | took 1172s 02:39:11 INFO - Completed test suite (00:19:32) 02:39:11 INFO - javascript benchmark 02:39:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8550.034061715656, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.2418643711962, 3318.1372843060803, 3322.103032181311, 3334.5665063541737, 3351.48052051932, 6373.649449280299, 6416.230052393714, 6418.743250269995, 6459.5478316517865, 6530.934690653092, 6188.938110618892, 6274.372562743723, 6289.119523266746, 6289.1824062871765, 6319.241690997087, 5730.570207234464, 5740.167675687023, 5899.056151015839, 5903.675297858616, 5951.375105613914, 5905.4980326672285, 5919.319278283009, 5967.582269241155, 5995.370486098962, 6006.0, 1105.2010679470986, 5689.089745640677, 5727.513161381287, 5865.384134665863, 5986.10208468731, 5706.115552089433, 5844.649321040709, 5887.470127688529, 5923.407659234085, 5925.111233315038, 5806.506446952014, 5820.722925052208, 5873.735681894325, 5887.234659494281, 5887.558433117533, 6344.587601805868, 6353.650549219791, 6363.8409039773915, 6368.649724265164, 6468.514861385368, 6771.8984215236815, 6793.116894803644, 6798.422134118606, 6891.069705589732, 6906.654667266666, 6593.868122637568, 6707.631080290582, 6741.359570840811, 6832.487563432713, 6939.306069393071, 6173.753049878044, 6231.688415579249, 6234.3453937336835, 6241.65670888101, 6246.6252024878195, 6898.068760717239, 6906.171259448898, 6972.651367431608, 7057.0472986146215, 7071.858562828715, 6827.52207345481, 6852.554583952027, 6873.072135261776, 6881.208661003949, 6894.00036994633, 6903.792886213321, 6904.965475172692, 6994.790156295319, 7004.159500859828, 7008.719651213996, 6668.766593169215, 6770.187577490733, 6817.216020157646, 6862.142232220973, 6898.206706228748, 6752.81825680504, 6801.0, 6852.143482064742, 6933.445324374038, 6935.479839012094, 5356.517913387814, 5400.243965844785, 5404.486573775485, 5410.594205434608, 5423.728813559306, 4724.692894961817, 4753.786079626425, 4800.447948485899, 4806.663533552688, 4819.156647586658, 5778.8266352009505, 6011.09833524966, 6016.0, 6091.9695401523595, 6092.482139018233, 6712.160979877515, 6862.279460656659, 6936.34104760047, 6949.93050069503, 6954.3393377629045, 5909.881802364014, 6037.72830222641, 6058.242719660043, 6077.453029227391, 6080.726367313481, 5891.587588868738, 5899.882002359929, 5958.821235362946, 5988.101784732325, 5989.401059893976, 6466.515011374166, 6570.277269500351, 6674.5327827052615, 6739.696713647898, 6780.525363224527, 6913.10129683138, 6972.30276972319, 6986.930130698831, 6987.510874238755, 6988.755393561201, 6692.966535167293, 6702.798916032527, 6726.562773419712, 6761.86476270462, 6780.966095169492, 6768.0, 6810.897836532356, 6847.760328388483, 6866.553674011173, 6918.238993710587, 6688.230853451915, 6711.765088222084, 6914.0666010088, 6938.0, 7028.191757947697, 6714.026466162281, 6722.361375669304, 6725.19297684281, 6725.39471447572, 6750.527463077734, 6340.619562826245, 6514.022896565553, 6517.022446633043, 6543.149390579194, 6755.256921738506, 6461.483081353575, 6474.805755827333, 6479.254885688018, 6479.838004049937, 6481.935180648322, 6534.477241820738, 6600.1089852869245, 6693.397594216349, 6810.046593476818, 6816.897746533707, 6457.5479716419395, 6579.80260592183, 6602.3397660233595, 6607.07500949877, 6617.07360969455], "value": 6219.605240115368, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.3406972213064, 838.2581415447328, 858.2533196119377, 881.4755220643718, 881.546003808039, 40546.18907621849, 41068.79465602668, 41113.17773644533, 41148.58851411485, 41385.37921931173, 36159.81920090402, 36228.2754344913, 36411.817940910325, 36444.27111457776, 36537.45193822095, 6809.1148150740455, 6914.274001229874, 6917.930820691804, 6922.757703480379, 6923.20383155936, 6874.037634731141, 6950.304969503035, 6956.860862782742, 6957.304269573053, 6960.651967401635, 6925.722971081151, 7596.12644545876, 7771.300582947533, 7780.377569794431, 7790.0, 7659.540427574363, 7709.653065612061, 7710.113336966265, 7713.460057795928, 7715.151333353327, 7374.741884034087, 7550.471466997313, 7574.621268936531, 7649.847003059963, 7670.654820533089, 36710.0, 37073.25853482942, 37105.628943710755, 37175.81412092949, 37179.62820371816, 3425.1779572902324, 3480.477928310748, 3480.8085555294447, 3483.216276337829, 3484.181217413906, 30271.394572108653, 30278.697213027808, 30362.0, 30371.088867333794, 30372.392552148835, 5108.66793658411, 5124.205748109049, 5125.641205115643, 5127.48725127488, 5136.460671629462, 170550.0, 172024.0, 181459.0, 183163.0, 195908.0, 46473.30290045652, 46680.299795503095, 47082.529174707815, 47083.0, 47102.76448617735, 48428.27357589639, 48477.27284090741, 48576.27135592969, 48582.75708621434, 48597.75701121543, 15648.608784780472, 15730.134842583768, 15783.684326313409, 15791.526254212393, 16031.0, 13177.341132943315, 13193.670158246121, 13194.736105277841, 13196.14225075367, 13218.339083045808, 13596.932015340059, 13617.455301788015, 13670.658233544242, 13777.242251676054, 13823.377947992365, 5560.582956278296, 5578.86052848682, 5631.155326701028, 5679.0, 5710.0, 999.93000489965, 1024.0476356988072, 1025.74869157057, 1035.0, 1036.5542816588938, 22629.2079777207, 22631.88684056602, 22734.317970460583, 23021.769782302297, 23278.883605581865, 1119.5521791283552, 1120.8262719278525, 1123.6067376418189, 1126.707056165403, 1138.7779383020397, 12242.143049986593, 15678.372865085497, 15806.525804225892, 15849.286782094834, 16390.0165990041, 240121.0, 242473.0, 242510.0, 242863.0, 242878.0, 55444.445555544735, 55556.0, 55701.44298556963, 55930.44069559334, 56113.438865611635, 1435.397133204057, 1452.2738630684446, 1463.239115659851, 1470.713210923881, 1482.199612209395, 26100.608490873034, 26876.865615671795, 27078.458430831666, 27222.591661125494, 27352.0, 37111.81444092762, 37389.25221495609, 37423.812880935424, 37458.25083498369, 37462.250754985296, 210036.0, 210395.0, 210611.0, 211006.0, 211276.0, 32420.35159296848, 36179.0, 37409.25181496409, 37416.251674966894, 37804.2439151221, 44815.77592112149, 45368.31947520856, 45633.771831140635, 45889.770551147034, 45919.0, 32833.0, 33158.83420582882, 33496.330073397905, 33587.83206083954, 34070.14824629404, 32414.189645259055, 32679.836600816845, 32821.17947051343, 33234.50148247826, 33720.83139584286, 36751.816240918626, 37721.62278377181, 37818.43272350862, 37944.430833536964, 38563.22873542457, 31963.680363196072, 32014.67985320117, 32144.19639509031, 32418.35163296768, 32727.18182045468, 23764.405889852893, 23881.761182387952, 24260.87869560641, 24358.26925192247, 24438.633420499064], "value": 17226.25035678242, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.4922618869207, 571.1119209629026, 573.6672729816706, 587.3392433512297, 592.5170985646697, 22308.107675692972, 23027.42431439215, 23261.767382326194, 23292.06831726731, 23296.767032329673, 24784.380390490245, 25608.0, 25609.35976600581, 25617.87191064042, 25628.23115306539, 6590.439812615921, 6732.326767323278, 6754.729810807562, 6763.323667633246, 6764.661766911635, 6268.279147897982, 6500.707468163944, 6515.967420162916, 6525.151730275057, 6525.673716314189, 6498.805035848932, 6505.284418713962, 6506.577072490297, 6506.577072490297, 6507.05647681086, 6486.675666216694, 6496.285408605073, 6500.869982600345, 6502.089707440962, 6518.771842985473, 6067.453929146354, 6078.149059131725, 6078.574499785017, 6084.756609735606, 6088.238970128734, 29141.85429072841, 29223.415531689247, 29695.70304296951, 30493.69506304931, 30528.236794080105, 2032.7357443532394, 2064.298138632872, 2080.5006798368436, 2086.4366621012396, 2087.6972838938423, 19859.50351241216, 20628.0, 20675.379738607866, 20680.0, 20772.065257063317, 2428.6357046443177, 2460.126655037454, 2502.674652295208, 2581.819272650915, 2590.9481810363686, 135592.32203839015, 138941.0, 139381.30309348388, 139565.0, 139710.0, 13769.655758605915, 14459.13245205291, 14646.560603181922, 14672.633184170481, 14955.40178392852, 23161.3051608452, 23177.18879839231, 23197.072117115466, 23226.187083451998, 23282.06871725112, 9436.0, 9456.385334953206, 9506.667266645634, 9586.66446674363, 9691.70924872255, 8251.0, 8557.0, 8573.871391929126, 8678.652853885775, 8794.34042446819, 8840.292776577859, 9009.864852027225, 9122.042185570552, 9373.437593744397, 9389.10803473669, 2553.9872300638376, 2605.59613259945, 2634.868256587163, 2667.1865081150436, 2742.7120152384114, 962.8363178259713, 965.7199412170532, 978.3054031637474, 993.7863458934067, 994.3636072913341, 19135.521611959535, 19555.413337599894, 19763.703544446846, 19882.304119355755, 19891.900540497496, 1029.809485245232, 1048.4495639789172, 1055.6674647486018, 1058.2803693488502, 1062.8724553053528, 11017.1186305097, 11051.72370690739, 11131.387773672364, 11138.721531961766, 11172.664820055412, 439015.0, 445391.0, 445869.0, 452413.0, 453138.0, 107317.0, 107898.0, 107986.0, 109644.0, 110067.0, 1172.7068232941765, 1193.4748710567324, 1205.8070708686744, 1220.8107743299802, 1222.2299951030793, 17205.655886882443, 17410.912945435193, 17420.825791742427, 17796.55508612295, 17864.374746883797, 52018.0, 52795.47204527906, 52844.73577632087, 53116.73441632767, 53952.46047539474, 62907.370926290154, 63666.3633363679, 63852.68073659602, 64165.67917160384, 66177.66911165413, 14221.64445888861, 14422.927885360927, 14591.124532528082, 14600.634984125481, 14605.92697036508, 21299.68050479213, 21470.355889323346, 21588.67616985715, 21766.0, 21821.0, 18336.541586459913, 18438.907805460887, 18464.26142954267, 18728.344507942158, 18757.53106172302, 16246.268917898959, 16447.424340148038, 16780.32878684839, 16883.577910552336, 17014.57463563421, 17368.0, 17996.820031799514, 18774.15516301797, 18983.620327593646, 19139.71290430617, 14228.786568201278, 14437.0, 14446.711065778416, 14449.133052016912, 14451.78322325187, 17522.561935951195, 17547.56131096733, 17684.204210810287, 17691.026993514966, 17708.114594270493], "value": 11807.19948205931, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.6174978381378, 1351.3310911099009, 1356.1524047470332, 1367.986320136799, 1370.1368138073015, 14767.778483322745, 14887.18120503372, 15322.770158447618, 15355.155466449341, 15408.07551546908, 15648.530544083667, 15906.284217210225, 15920.0, 15925.92037039816, 15933.044017358967, 2774.7225277472294, 2831.079899032812, 2833.461642287969, 2836.7872409569263, 2843.4313137372505, 2596.4028273497106, 2683.3425810676313, 2756.1180422264883, 2767.266674331304, 2799.8040137190405, 2780.2215379693716, 2800.705925877784, 2807.2560771395492, 2808.0593001344573, 2815.81697189682, 2670.3724624713177, 2692.824966377189, 2718.3068317579086, 2719.252205643444, 2719.4425142845867, 2616.3197568632104, 2646.735326467357, 2647.721989191146, 2648.596243990688, 2648.9072882449022, 14888.851111488855, 15242.161681107535, 15259.0, 15259.847401525954, 15298.0, 7948.801279967989, 8206.671733130728, 8226.588670566507, 8233.17668233178, 8236.217559331853, 4930.704157750511, 5272.0, 5285.920711189336, 5313.123334649778, 5401.189821526802, 1828.9451316460527, 1901.0969789350086, 1908.1031914999928, 1948.2401863273335, 1963.185278109583, 26787.0, 26887.731122688914, 26990.46019079627, 27080.0, 27107.1867843965, 6566.212054553484, 6752.696128674222, 6753.189617245962, 6868.416184624263, 6902.240753517109, 16677.583060423345, 16682.416115435903, 16689.0, 16692.74960875588, 16722.414715484898, 7626.504277221963, 7812.84374312522, 7854.1753115922, 7857.842843143105, 7871.212878712083, 7215.963920180366, 7274.927250727425, 7305.853882922312, 7369.6315184240575, 7379.963100184465, 4770.141374552614, 4980.327655766498, 4993.7503124843615, 5020.7740651670765, 5022.7990880365105, 1269.9428525716364, 1313.3958379145508, 1326.9535566255136, 1397.4689617945116, 1434.978475322871, 899.8335307967916, 912.5802131019673, 917.8944421391492, 922.8338898998111, 925.9583318750672, 7418.295261950106, 7536.547807131589, 7579.962100189574, 7594.924050759532, 7600.543967361976, 987.4519641598981, 990.5938565188238, 998.3361064891766, 1003.6788227767045, 1010.545254635417, 4517.0, 4605.424321959755, 4618.584327410482, 4648.140094082605, 4657.371254880615, 21163.0, 21349.35951921445, 21817.23639672604, 22099.889500552716, 22115.44711382196, 21135.837528936056, 21714.457138571663, 21816.127354905628, 21890.0, 22015.559688806134, 11471.426428678533, 11636.0, 11706.1220408468, 11758.0, 11761.647150585497, 8250.587470626324, 8785.648574056966, 9134.086591340812, 9163.77090572741, 9170.312226582899, 18656.253749849853, 18713.345032923782, 18833.6233275331, 18960.525986849887, 19152.329668461538, 19539.0, 19572.217111315957, 19592.510187245432, 19605.901970490057, 19727.60544789125, 10683.732906677395, 10983.780324393627, 11057.668269951915, 11059.059979901798, 11077.889221108007, 13660.180389176681, 13664.795028074786, 13800.0, 13812.585622431343, 13833.30833458303, 11010.119190464904, 11024.062954648945, 11356.659300221007, 11370.31778093317, 11469.139814513777, 10767.676969690921, 11040.061594764535, 11074.335539867634, 11125.554977800797, 11132.0, 9376.203022743142, 9552.23582113443, 9558.139767420966, 9568.904310956801, 9582.760430989281, 6848.2124555674745, 6875.4155896749335, 6900.516963812685, 6954.826129346807, 6961.025456436204, 7229.674664640209, 7233.0, 7306.744263950736, 7332.120145582351, 7388.852222955618], "value": 6629.104157377469, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.1666417590739, 504.16308927180864, 534.3961323704214, 537.9569634429243, 538.6471860931086, 6385.968070159648, 6439.0741083071425, 6491.448226900708, 6530.183727034121, 6562.901556476645, 6153.415425534578, 6309.5392796809165, 6310.507349596906, 6326.936730632692, 6331.493480521559, 5011.373578302712, 5019.171836646949, 5027.321311622939, 5059.873503162423, 5076.695398276115, 5039.874003149914, 5040.697558146523, 5084.186530155176, 5104.923426148611, 5105.310783044297, 4890.266460030988, 4990.550850423461, 5033.54698077173, 5037.974810125944, 5046.192609182532, 5053.4946505349535, 5053.772580233898, 5058.128492457778, 5058.974705126469, 5059.974700126494, 4527.298268768346, 4548.385967894358, 4555.339475775994, 4569.977150114261, 4582.15230182414, 6337.493000559944, 6350.809475715736, 6370.299267080617, 6385.169927909388, 6410.61536307823, 5783.624064435799, 5788.913166302509, 5790.594658373915, 5804.738786754606, 5833.32916714579, 6641.933580664228, 6717.764878229287, 6725.663716814189, 6752.493562982796, 6832.931670683329, 4813.352656039165, 4885.413750349945, 4911.484294149099, 4913.901721965576, 4928.137575924235, 7013.544119632259, 7025.683844227022, 7030.296970303031, 7140.928590714078, 7164.0, 5073.797048118034, 5084.46613105626, 5094.337736094358, 5114.43741188469, 5124.666896651705, 5118.61610379223, 5127.333446651912, 5130.769115389817, 5143.922841157386, 5146.125158723026, 5754.683492407874, 5768.653880767168, 5782.392848750905, 5796.391378905154, 5798.333191682926, 6804.897926531106, 6839.794806155724, 6843.726250949906, 6853.760118395832, 6880.58716477013, 1644.761509581104, 1697.2447260968997, 1712.332190445727, 1742.5033865348569, 1769.3364988129451, 1199.6041306368877, 1231.2120243044458, 1232.4515590562294, 1241.6652098993618, 1246.4702501436852, 5911.379305172981, 5967.16459695643, 5968.940310596839, 5976.9402305977255, 5995.5803093783015, 6811.591304521745, 6847.828804279933, 6894.207166175954, 6912.688928998207, 6935.895961560581, 5842.182094506772, 5898.14476900847, 5902.704864756831, 5952.523798096142, 5976.970115149396, 3671.2840996006057, 3688.723345749026, 3699.0, 3703.8703195525623, 3718.4794128821986, 6693.431058360094, 6714.630695311707, 6719.529632925648, 6748.730050798012, 6763.0, 7072.115985501812, 7091.468139889529, 7102.254263302279, 7153.4992550522, 7158.498905076699, 6643.236027856762, 6649.470621757023, 6668.933310666928, 6676.732930682912, 6686.364795344434, 6893.276205998298, 6918.654067296515, 6943.3683084476115, 6945.826354341182, 6983.650817459208, 6891.173059232724, 6914.0666010088, 6922.61925594077, 6933.514653974174, 6936.41040511542, 6711.63086030273, 6725.361090696376, 6746.9325306746305, 6760.898586521108, 6767.526273161028, 5071.264666623245, 5074.594032477319, 5083.949160508496, 5101.183810590288, 5108.948910510847, 6960.962641667922, 6977.33715297046, 6988.091548098715, 6994.685239164148, 7016.6491675415, 6637.701303441453, 6661.134052573135, 6699.3872389769, 6722.159730033746, 6746.4265537429865, 6103.816885493442, 6716.899246511404, 6732.764353247613, 6776.525643204928, 6805.081314022742, 6646.268910419946, 6698.990302909206, 6724.394804467622, 6727.293634168342, 6734.461243100638, 6665.200175978914, 6687.598744075371, 6721.731130754715, 6776.93223067763, 6852.760153394607, 6363.840903977252, 6443.613383197023, 6498.805035848932, 6526.608403495806, 6576.210854697467], "value": 5175.798437945168, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [912.197266405563, 914.9268058555316, 927.3647551427268, 936.7798567336674, 949.6676163342831, 18146.818531814693, 19048.714269285956, 19063.142158602863, 19070.61858762824, 21167.57664846702, 20728.68906966393, 21190.682139767916, 21255.6811647825, 21257.0, 21317.147314107417, 912.6668765900448, 930.1070971866982, 931.7391130483476, 932.5430539035891, 933.8972713001565, 952.4618590496348, 967.7483854197889, 968.9224862011022, 970.0784254957783, 970.9805803883918, 1026.984595231072, 1029.9897001030006, 1032.463119178027, 1033.2715435617872, 1035.2339268941005, 1019.7093828258911, 1020.7856350166437, 1022.0086516079429, 1024.0118285854148, 1025.5948900184385, 758.3213024343237, 759.5366826235992, 761.090496856257, 762.2073044034198, 763.290140169642, 17987.73018404725, 18248.0, 18407.171677274553, 18421.26314947414, 20267.087981040888, 21066.683999740017, 21237.0, 21376.46558836026, 21761.673574896387, 21796.237131700473, 16124.677506449923, 16288.755668664979, 16543.91728041352, 16594.6681066378, 16601.252943617565, 3713.6100709425664, 3749.793761343125, 3751.1184871555433, 3754.155315054118, 3754.2866855297407, 117479.0, 119405.0, 119419.40290298493, 120429.0, 121846.0, 15647.608809779847, 16146.434874779326, 16243.51269461918, 16244.350225990827, 16256.43102491407, 28707.56938645922, 29779.40441191164, 29864.40271194564, 29908.401831963674, 29915.0, 8067.3142782864115, 8530.402871798915, 8558.272546833588, 8564.957175214084, 8608.0, 4432.955670443254, 4514.6388288936805, 4519.118771839459, 4528.637708983273, 4536.637069034469, 5387.164989426645, 5421.566274698014, 5508.118701007819, 5531.9723401382735, 5553.055980483327, 1077.5151181968147, 1111.2110401614943, 1114.6934592986831, 1115.4311301236428, 1125.291066628019, 622.7415622516695, 632.3771085480797, 633.2401118657538, 638.2564312575797, 653.1019847709399, 11206.38364889939, 11265.191415573434, 11362.431878406047, 11454.713632159095, 11627.476763545661, 675.4562577125363, 680.8638272345551, 692.7609974558769, 695.5826504097602, 696.2376198063113, 5171.97414012935, 5318.627696061239, 5451.155070964007, 5496.945030549723, 5633.774649014075, 116920.0, 119594.40202799105, 119748.0, 120556.0, 122027.3898630519, 102063.0, 102936.48531757294, 106576.46711766547, 108518.0, 109281.45359273153, 92342.0, 96224.51887740516, 96618.99999999859, 98869.0226195472, 98964.0, 11556.653300401002, 11707.824382634097, 11794.0, 11924.70188245266, 12010.339431331011, 42194.0, 42681.57318426776, 42957.0, 42986.57013429826, 43388.0, 54562.454375457324, 54841.0, 55026.17460738012, 55159.72420137873, 57856.13215801682, 17316.653666926843, 17555.82444175542, 17709.38017169393, 17799.644007120045, 17927.282908683508, 16742.162891855114, 16821.243044063292, 16920.915395422944, 17018.74471882898, 17164.485065448058, 16417.097059661355, 16497.91751041237, 16548.75176872372, 16636.58408539796, 16641.66716665684, 15634.687306254038, 17026.404075857285, 17166.82833171702, 17356.305747769948, 17378.739318909975, 17912.91043544774, 18126.456206313833, 18166.636667266845, 18198.363057292932, 18385.356512521998, 12722.554710585086, 12724.236545807282, 12952.222866628032, 12966.481340746643, 12973.351332433529, 13567.0, 13746.518871839438, 13822.86177138256, 13916.095453795471, 14255.287235638383], "value": 9000.148423953064, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1484.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 110.0, 95.0, 107.0, 110.0, 108.0, 109.0, 107.0, 108.0, 111.0], "value": 107.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 116.0, 151.0, 170.0, 118.0, 139.0, 147.0, 120.0, 175.0, 117.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 161.0, 160.0, 162.0, 165.0, 166.0, 169.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 172.0, 78.0, 76.0, 73.0, 73.0, 158.0, 75.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 135.0, 81.0, 83.0, 80.0, 128.0, 80.0, 79.0, 130.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 148.0, 148.0, 149.0, 148.0, 149.0, 148.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 95.0, 95.0, 96.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 53.0, 53.0, 53.0, 52.0, 52.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 37.0, 38.0, 37.0, 38.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 74.0, 73.0, 77.0, 75.0, 79.0, 80.0, 76.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 124.0, 125.0, 126.0, 123.0, 118.0, 116.0, 123.0, 166.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 170.0, 171.0, 173.0, 182.0, 169.0, 170.0, 167.0, 167.0, 172.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 64.0, 66.0, 66.0, 70.0, 65.0, 67.0], "value": 65.6, "unit": "score"}]}]} 02:39:11 INFO - Return code: 0 02:39:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:39:11 INFO - # TBPL SUCCESS # 02:39:11 INFO - Running post-action listener: _package_coverage_data 02:39:11 INFO - Running post-action listener: _resource_record_post_action 02:39:11 INFO - [mozharness: 2017-09-01 09:39:11.386299Z] Finished run-tests step (success) 02:39:11 INFO - Running post-run listener: _resource_record_post_run 02:39:11 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 398962688; Read time: 8; Write time: 219420 02:39:11 INFO - TinderboxPrint: CPU usage
13.1% 02:39:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:39:11 INFO - TinderboxPrint: I/O write bytes / time
398,962,688 / 219,420 02:39:11 INFO - TinderboxPrint: CPU idle
8,245.1 (86.9%) 02:39:11 INFO - TinderboxPrint: CPU user
1,193.2 (12.6%) 02:39:11 INFO - TinderboxPrint: Swap in / out
0 / 0 02:39:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115068928; Read time: 0; Write time: 64984 02:39:11 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:39:11 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283893760; Read time: 8; Write time: 154436 02:39:12 INFO - Running post-run listener: _upload_blobber_files 02:39:12 INFO - Blob upload gear active. 02:39:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:39:12 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 02:39:12 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'] 02:39:12 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 02:39:12 INFO - (blobuploader) - INFO - Open directory for files ... 02:39:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:39:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:39:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:16 INFO - (blobuploader) - INFO - Done attempting. 02:39:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:39:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:39:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:17 INFO - (blobuploader) - INFO - Done attempting. 02:39:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:39:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:39:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:18 INFO - (blobuploader) - INFO - Done attempting. 02:39:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:39:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:39:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:18 INFO - (blobuploader) - INFO - Done attempting. 02:39:18 INFO - (blobuploader) - INFO - Iteration through files over. 02:39:18 INFO - Return code: 0 02:39:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:39:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:39:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a6efa3b4f8fa2988bd06ab0e2fea25ba9386e3dfb529f84b73f4771018b91b5e0e0bf0e8460d92a37b3894b75a38ec6910ea8f4b88142b99fec73739e31af7a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2186e325e80881a4cdb741f2d95fd519370d18ad7c8aed905c594536dc304a8db46cc57b89d0b604df6ca9540c4d677b1668f02f6c4441725288b08d5aa4f782", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/171dce34a1d9d5aaeaaa0502964939603a4de48b8f2e8455291ab5f8903798d3818782ba349f9ed992ab3d44405faaae59a8465a34636c52216fcaf6538c548b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1a4048aa08d43db185e7d089cbdb617d435c1a81feeade3f4b67ccc3d94944ac90f5d4ea348120b2d81121de52a5af4953915ac98b10b33457bd88f09ff0130"} 02:39:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:39:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:39:18 INFO - Contents: 02:39:18 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a6efa3b4f8fa2988bd06ab0e2fea25ba9386e3dfb529f84b73f4771018b91b5e0e0bf0e8460d92a37b3894b75a38ec6910ea8f4b88142b99fec73739e31af7a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2186e325e80881a4cdb741f2d95fd519370d18ad7c8aed905c594536dc304a8db46cc57b89d0b604df6ca9540c4d677b1668f02f6c4441725288b08d5aa4f782", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/171dce34a1d9d5aaeaaa0502964939603a4de48b8f2e8455291ab5f8903798d3818782ba349f9ed992ab3d44405faaae59a8465a34636c52216fcaf6538c548b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1a4048aa08d43db185e7d089cbdb617d435c1a81feeade3f4b67ccc3d94944ac90f5d4ea348120b2d81121de52a5af4953915ac98b10b33457bd88f09ff0130"} 02:39:18 INFO - Running post-run listener: copy_logs_to_upload_dir 02:39:18 INFO - Copying logs to upload dir... 02:39:18 INFO - mkdir: /builds/slave/test/build/upload/logs 02:39:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.311363 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-09-01 02:39:19.030986) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 02:39:19.038357) ========= 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=438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a6efa3b4f8fa2988bd06ab0e2fea25ba9386e3dfb529f84b73f4771018b91b5e0e0bf0e8460d92a37b3894b75a38ec6910ea8f4b88142b99fec73739e31af7a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2186e325e80881a4cdb741f2d95fd519370d18ad7c8aed905c594536dc304a8db46cc57b89d0b604df6ca9540c4d677b1668f02f6c4441725288b08d5aa4f782", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/171dce34a1d9d5aaeaaa0502964939603a4de48b8f2e8455291ab5f8903798d3818782ba349f9ed992ab3d44405faaae59a8465a34636c52216fcaf6538c548b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1a4048aa08d43db185e7d089cbdb617d435c1a81feeade3f4b67ccc3d94944ac90f5d4ea348120b2d81121de52a5af4953915ac98b10b33457bd88f09ff0130"} build_url:https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a6efa3b4f8fa2988bd06ab0e2fea25ba9386e3dfb529f84b73f4771018b91b5e0e0bf0e8460d92a37b3894b75a38ec6910ea8f4b88142b99fec73739e31af7a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2186e325e80881a4cdb741f2d95fd519370d18ad7c8aed905c594536dc304a8db46cc57b89d0b604df6ca9540c4d677b1668f02f6c4441725288b08d5aa4f782", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/171dce34a1d9d5aaeaaa0502964939603a4de48b8f2e8455291ab5f8903798d3818782ba349f9ed992ab3d44405faaae59a8465a34636c52216fcaf6538c548b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1a4048aa08d43db185e7d089cbdb617d435c1a81feeade3f4b67ccc3d94944ac90f5d4ea348120b2d81121de52a5af4953915ac98b10b33457bd88f09ff0130"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 02:39:19.078724) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:39:19.079435) ========= 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=438111f3d31ce799eff2119d000001bc-1504243739.730776-1714126064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:39:19.158952) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 02:39:19.159316) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 02:39:19.159702) ========= ========= Total master_lag: 0.24 =========