builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1504257503.82 results: success (0) revision: 583e73fb8e3c734dbf3a5e13913df7617f5c492c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:23.817726) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:23.818162) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:23.818444) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:23.834922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:23.835272) ========= 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=0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-01 02:18:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2017-09-01 02:18:23 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125934 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:23.978809) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:23.979106) ========= 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=0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020144 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.034345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.034691) ========= 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=0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-01 02:18:24,092 truncating revision to first 12 chars 2017-09-01 02:18:24,092 Setting DEBUG logging. 2017-09-01 02:18:24,092 attempt 1/10 2017-09-01 02:18:24,092 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:24,391 unpacking tar archive at: mozilla-central-583e73fb8e3c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.664088 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.718294) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.718576) ========= script_repo_revision: 583e73fb8e3c734dbf3a5e13913df7617f5c492c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.718929) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.719184) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.731200) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-09-01 02:18:24.731507) ========= /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=0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:18:24 INFO - MultiFileLogger online at 20170901 02:18:24 in /builds/slave/test 02:18:24 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:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:18:24 INFO - {'append_to_log': False, 02:18:24 INFO - 'base_work_dir': '/builds/slave/test', 02:18:24 INFO - 'blob_upload_branch': 'Firefox', 02:18:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:18:24 INFO - 'branch': 'Firefox', 02:18:24 INFO - 'buildbot_json_path': 'buildprops.json', 02:18:24 INFO - 'code_coverage': False, 02:18:24 INFO - 'config_files': ('talos/linux_config.py',), 02:18:24 INFO - 'default_actions': ('clobber', 02:18:24 INFO - 'read-buildbot-config', 02:18:24 INFO - 'download-and-extract', 02:18:24 INFO - 'populate-webroot', 02:18:24 INFO - 'create-virtualenv', 02:18:24 INFO - 'install', 02:18:24 INFO - 'setup-mitmproxy', 02:18:24 INFO - 'run-tests'), 02:18:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:18:24 INFO - 'disable_ccov_upload': False, 02:18:24 INFO - 'disable_stylo': False, 02:18:24 INFO - 'download_minidump_stackwalk': True, 02:18:24 INFO - 'download_symbols': 'ondemand', 02:18:24 INFO - 'enable_stylo': False, 02:18:24 INFO - 'enable_webrender': False, 02:18:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:18:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:18:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:18:24 INFO - 'gecko_profile': False, 02:18:24 INFO - 'gecko_profile_interval': 0, 02:18:24 INFO - 'installer_path': 'installer.exe', 02:18:24 INFO - 'log_level': 'info', 02:18:24 INFO - 'log_name': 'talos', 02:18:24 INFO - 'log_to_console': True, 02:18:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:18:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:18:24 INFO - 'opt_config_files': (), 02:18:24 INFO - 'pip_index': False, 02:18:24 INFO - 'suite': 'dromaeojs-e10s', 02:18:24 INFO - 'system_bits': '32', 02:18:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:18:24 INFO - 'title': 'talos-linux64-ix-058', 02:18:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:18:24 INFO - 'use_talos_json': True, 02:18:24 INFO - 'verify': 'False', 02:18:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:18:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:18:24 INFO - 'work_dir': 'build'} 02:18:24 INFO - [mozharness: 2017-09-01 09:18:24.925304Z] Running clobber step. 02:18:24 INFO - Running pre-action listener: _resource_record_pre_action 02:18:24 INFO - Running main action method: clobber 02:18:24 INFO - rmtree: /builds/slave/test/build 02:18:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:18:26 INFO - Running post-action listener: _resource_record_post_action 02:18:26 INFO - [mozharness: 2017-09-01 09:18:26.459335Z] Finished clobber step (success) 02:18:26 INFO - [mozharness: 2017-09-01 09:18:26.459431Z] Running read-buildbot-config step. 02:18:26 INFO - Running pre-action listener: _resource_record_pre_action 02:18:26 INFO - Running main action method: read_buildbot_config 02:18:26 INFO - Using buildbot properties: 02:18:26 INFO - { 02:18:26 INFO - "project": "", 02:18:26 INFO - "product": "firefox", 02:18:26 INFO - "who": "archaeopteryx@coole-files.de", 02:18:26 INFO - "installer_path": "public/build/target.tar.bz2", 02:18:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:18:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:18:26 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:18:26 INFO - "stage_platform": "linux64-stylosequential", 02:18:26 INFO - "basedir": "/builds/slave/test", 02:18:26 INFO - "buildnumber": 222, 02:18:26 INFO - "platform": "ubuntu64_hw_styloseq", 02:18:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:18:26 INFO - "slavebuilddir": "test", 02:18:26 INFO - "taskId": "CFDBI2oAQdaDlgMmag3Tyw", 02:18:26 INFO - "branch": "mozilla-central", 02:18:26 INFO - "script_repo_revision": "production", 02:18:26 INFO - "revision": "583e73fb8e3c734dbf3a5e13913df7617f5c492c", 02:18:26 INFO - "slavename": "talos-linux64-ix-058", 02:18:26 INFO - "repo_path": "mozilla-central" 02:18:26 INFO - } 02:18:26 INFO - Finding installer, test and symbols from parent task. 02:18:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CFDBI2oAQdaDlgMmag3Tyw'}, attempt #1 02:18:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CFDBI2oAQdaDlgMmag3Tyw'}, attempt #1 02:18:27 INFO - Task dependencies: EVBwkXv4QIqaI8RoA8-sCA 02:18:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA'}, attempt #1 02:18:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2 02:18:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.test_packages.json 02:18:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.crashreporter-symbols.zip 02:18:27 INFO - Running post-action listener: _resource_record_post_action 02:18:27 INFO - [mozharness: 2017-09-01 09:18:27.785581Z] Finished read-buildbot-config step (success) 02:18:27 INFO - [mozharness: 2017-09-01 09:18:27.785797Z] Running download-and-extract step. 02:18:27 INFO - Running pre-action listener: _resource_record_pre_action 02:18:27 INFO - Running main action method: download_and_extract 02:18:27 INFO - mkdir: /builds/slave/test/build/tests 02:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:27 INFO - trying https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.test_packages.json 02:18:27 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:27 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:28 INFO - Downloaded 989 bytes. 02:18:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:18:28 INFO - Using the following test package requirements: 02:18:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:18:28 INFO - u'common': [u'target.common.tests.zip'], 02:18:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:18:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:18:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:18:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:18:28 INFO - u'mozbase': [u'target.common.tests.zip'], 02:18:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:18:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:18:28 INFO - u'web-platform': [u'target.common.tests.zip', 02:18:28 INFO - u'target.web-platform.tests.tar.gz'], 02:18:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:18:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:18:28 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:28 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:28 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:56 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:56 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:56 INFO - Fetch https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.talos.tests.zip into memory 02:18:57 INFO - Content-Length response header: 14496650 02:18:57 INFO - Bytes received: 14496650 02:18:57 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:57 INFO - trying https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2 02:18:57 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:57 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.528376Z] Finished download-and-extract step (success) 02:19:02 INFO - [mozharness: 2017-09-01 09:19:02.528606Z] 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.551677Z] Finished populate-webroot step (success) 02:19:02 INFO - [mozharness: 2017-09-01 09:19:02.551766Z] 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:03 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 0x203a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa090>, '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 0x23aad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', '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': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', 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 0x203a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa090>, '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 0x23aad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', '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': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', 02:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:04 INFO - '_': '/tools/buildbot/bin/python'} 02:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:05 INFO - Downloading/unpacking psutil>=3.1.1 02:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 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 - Installing collected packages: psutil 02:19:06 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 0x203a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa090>, '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 0x23aad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', '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': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', 02:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:06 INFO - '_': '/tools/buildbot/bin/python'} 02:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:19:07 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:07 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 - 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:07 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 - Downloading mozsystemmonitor-0.3.tar.gz 02:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:19:08 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:08 INFO - Installing collected packages: mozsystemmonitor 02:19:08 INFO - Running setup.py install for mozsystemmonitor 02:19:08 INFO - Successfully installed mozsystemmonitor 02:19:08 INFO - Cleaning up... 02:19:08 INFO - Return code: 0 02:19:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x203a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa090>, '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 0x23aad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', '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:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:19:08 INFO - Using env: {'DISPLAY': ':0', 02:19:08 INFO - 'HOME': '/home/cltbld', 02:19:08 INFO - 'LANG': 'en_US.UTF-8', 02:19:08 INFO - 'LANGUAGE': 'en_US:en', 02:19:08 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': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', 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:10 INFO - warning: no files found matching '*.txt' 02:19:10 INFO - no previously-included directories found matching 'build' 02:19:10 INFO - no previously-included directories found matching 'dist' 02:19:10 INFO - no previously-included directories found matching '.git*' 02:19:10 INFO - Successfully installed jsonschema functools32 02:19:10 INFO - Cleaning up... 02:19:10 INFO - Return code: 0 02:19:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x203a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa090>, '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 0x23aad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', '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:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:19:10 INFO - Using env: {'DISPLAY': ':0', 02:19:10 INFO - 'HOME': '/home/cltbld', 02:19:10 INFO - 'LANG': 'en_US.UTF-8', 02:19:10 INFO - 'LANGUAGE': 'en_US:en', 02:19:10 INFO - 'LOGNAME': 'cltbld', 02:19:10 INFO - 'MAIL': '/var/mail/cltbld', 02:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:10 INFO - 'MOZ_NO_REMOTE': '1', 02:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:10 INFO - 'NO_EM_RESTART': '1', 02:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:10 INFO - 'PWD': '/builds/slave/test', 02:19:10 INFO - 'SHELL': '/bin/bash', 02:19:10 INFO - 'SHLVL': '1', 02:19:10 INFO - 'TERM': 'linux', 02:19:10 INFO - 'TMOUT': '86400', 02:19:10 INFO - 'USER': 'cltbld', 02:19:10 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', 02:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:10 INFO - '_': '/tools/buildbot/bin/python'} 02:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:19:10 INFO - Cleaning up... 02:19:10 INFO - Return code: 0 02:19:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x203a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa090>, '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 0x23aad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', '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:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:19:10 INFO - Using env: {'DISPLAY': ':0', 02:19:10 INFO - 'HOME': '/home/cltbld', 02:19:10 INFO - 'LANG': 'en_US.UTF-8', 02:19:10 INFO - 'LANGUAGE': 'en_US:en', 02:19:10 INFO - 'LOGNAME': 'cltbld', 02:19:10 INFO - 'MAIL': '/var/mail/cltbld', 02:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:10 INFO - 'MOZ_NO_REMOTE': '1', 02:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:10 INFO - 'NO_EM_RESTART': '1', 02:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:10 INFO - 'PWD': '/builds/slave/test', 02:19:10 INFO - 'SHELL': '/bin/bash', 02:19:10 INFO - 'SHLVL': '1', 02:19:10 INFO - 'TERM': 'linux', 02:19:10 INFO - 'TMOUT': '86400', 02:19:10 INFO - 'USER': 'cltbld', 02:19:10 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', 02:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:10 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:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:12 INFO - Downloading docopt-0.6.1.tar.gz 02:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:19:12 INFO - Installing collected packages: blobuploader, requests, docopt 02:19:12 INFO - Running setup.py install for blobuploader 02:19:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:19:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:19:12 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 0x203a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa090>, '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 0x23aad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', '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': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', 02:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:12 INFO - '_': '/tools/buildbot/bin/python'} 02:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:13 INFO - Running setup.py (path:/tmp/pip-eqxoc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:13 INFO - Running setup.py (path:/tmp/pip-ooGl3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:13 INFO - Running setup.py (path:/tmp/pip-7dUDHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:13 INFO - Running setup.py (path:/tmp/pip-o0ZSGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:13 INFO - Running setup.py (path:/tmp/pip-7pnZDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:13 INFO - Running setup.py (path:/tmp/pip-cFUNnW-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-E3kb4C-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-zrLdMf-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-oJbFoz-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-toUuxH-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-GMAE6U-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-DbTDIh-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-21C41p-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-tAlJA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:14 INFO - Running setup.py (path:/tmp/pip-5kt3vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:14 INFO - Running setup.py (path:/tmp/pip-ECm8WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:14 INFO - Running setup.py (path:/tmp/pip-Mv3zWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:19:14 INFO - Running setup.py install for manifestparser 02:19:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:19:14 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:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:19:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:19:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:19:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:19:15 INFO - Running setup.py install for mozleak 02:19:15 INFO - Running setup.py install for mozlog 02:19:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:19:15 INFO - Running setup.py install for moznetwork 02:19:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:19:15 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:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:19:16 INFO - Cleaning up... 02:19:16 INFO - Return code: 0 02:19:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:16 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 0x203a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa090>, '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 0x23aad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', '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:16 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:16 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:16 INFO - Using env: {'DISPLAY': ':0', 02:19:16 INFO - 'HOME': '/home/cltbld', 02:19:16 INFO - 'LANG': 'en_US.UTF-8', 02:19:16 INFO - 'LANGUAGE': 'en_US:en', 02:19:16 INFO - 'LOGNAME': 'cltbld', 02:19:16 INFO - 'MAIL': '/var/mail/cltbld', 02:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:16 INFO - 'MOZ_NO_REMOTE': '1', 02:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:16 INFO - 'NO_EM_RESTART': '1', 02:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:16 INFO - 'PWD': '/builds/slave/test', 02:19:16 INFO - 'SHELL': '/bin/bash', 02:19:16 INFO - 'SHLVL': '1', 02:19:16 INFO - 'TERM': 'linux', 02:19:16 INFO - 'TMOUT': '86400', 02:19:16 INFO - 'USER': 'cltbld', 02:19:16 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', 02:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:16 INFO - '_': '/tools/buildbot/bin/python'} 02:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:16 INFO - Running setup.py (path:/tmp/pip-m_R8Jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:16 INFO - Running setup.py (path:/tmp/pip-0YE8BO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:16 INFO - Running setup.py (path:/tmp/pip-eSt1U8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:16 INFO - Running setup.py (path:/tmp/pip-z97FtV-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-CYNRZ0-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-klZ_ff-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-vmU9a5-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-wjsZtB-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-pU6SUA-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-_aNlbQ-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-HvHzb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:17 INFO - Running setup.py (path:/tmp/pip-8hf5Tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:17 INFO - Running setup.py (path:/tmp/pip-enIQJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:17 INFO - Running setup.py (path:/tmp/pip-taxB3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:17 INFO - Running setup.py (path:/tmp/pip-t3Coq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:17 INFO - Running setup.py (path:/tmp/pip-3Nf6cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:17 INFO - Running setup.py (path:/tmp/pip-f3DAGZ-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:19 INFO - Reading from file tmpfile_stdout 02:19:19 INFO - Current package versions: 02:19:19 INFO - argparse == 1.2.1 02:19:19 INFO - blessings == 1.6 02:19:19 INFO - blobuploader == 1.2.4 02:19:19 INFO - docopt == 0.6.1 02:19:19 INFO - functools32 == 3.2.3-2 02:19:19 INFO - jsonschema == 2.5.1 02:19:19 INFO - manifestparser == 1.1 02:19:19 INFO - mozInstall == 1.13 02:19:19 INFO - mozcrash == 1.0 02:19:19 INFO - mozdebug == 0.1 02:19:19 INFO - mozdevice == 0.51 02:19:19 INFO - mozfile == 1.2 02:19:19 INFO - mozhttpd == 0.7 02:19:19 INFO - mozinfo == 0.10 02:19:19 INFO - mozleak == 0.1 02:19:19 INFO - mozlog == 3.5 02:19:19 INFO - moznetwork == 0.27 02:19:19 INFO - mozprocess == 0.25 02:19:19 INFO - mozprofile == 0.28 02:19:19 INFO - mozrunner == 6.13 02:19:19 INFO - mozscreenshot == 0.1 02:19:19 INFO - mozsystemmonitor == 0.3 02:19:19 INFO - moztest == 0.8 02:19:19 INFO - mozversion == 1.4 02:19:19 INFO - psutil == 3.1.1 02:19:19 INFO - requests == 1.2.3 02:19:19 INFO - wsgiref == 0.1.2 02:19:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:19 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:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:19 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:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:19 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 0x203a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa090>, '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 0x23aad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 02:19:19 INFO - 'HOME': '/home/cltbld', 02:19:19 INFO - 'LANG': 'en_US.UTF-8', 02:19:19 INFO - 'LANGUAGE': 'en_US:en', 02:19:19 INFO - 'LOGNAME': 'cltbld', 02:19:19 INFO - 'MAIL': '/var/mail/cltbld', 02:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:19 INFO - 'MOZ_NO_REMOTE': '1', 02:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:19 INFO - 'NO_EM_RESTART': '1', 02:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:19 INFO - 'PWD': '/builds/slave/test', 02:19:19 INFO - 'SHELL': '/bin/bash', 02:19:19 INFO - 'SHLVL': '1', 02:19:19 INFO - 'TERM': 'linux', 02:19:19 INFO - 'TMOUT': '86400', 02:19:19 INFO - 'USER': 'cltbld', 02:19:19 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', 02:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:19 INFO - '_': '/tools/buildbot/bin/python'} 02:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:19 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:19 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:19 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:19 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:19 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:19 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:19 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:19 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:19 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:19 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:19:19 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:19 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 - 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:19 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:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:19:20 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:20 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:20 INFO - Installing collected packages: simplejson 02:19:20 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:21 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:21 INFO - Successfully installed simplejson 02:19:21 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 0x203a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa090>, '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 0x23aad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4f90>, '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': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', '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': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', 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.769883Z] Finished create-virtualenv step (success) 02:19:21 INFO - [mozharness: 2017-09-01 09:19:21.770343Z] 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:22 INFO - Reading from file tmpfile_stdout 02:19:22 INFO - Output received: 02:19:22 INFO - Usage: mozinstall [options] installer 02:19:22 INFO - Options: 02:19:22 INFO - -h, --help show this help message and exit 02:19:22 INFO - -d DEST, --destination=DEST 02:19:22 INFO - Directory to install application into. [default: 02:19:22 INFO - "/builds/slave/test"] 02:19:22 INFO - --app=APP Application being installed. [default: firefox] 02:19:22 INFO - mkdir: /builds/slave/test/build/application 02:19:22 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:22 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:39 INFO - Reading from file tmpfile_stdout 02:19:39 INFO - Output received: 02:19:39 INFO - /builds/slave/test/build/application/firefox/firefox 02:19:39 INFO - Running post-action listener: _resource_record_post_action 02:19:39 INFO - [mozharness: 2017-09-01 09:19:39.944032Z] Finished install step (success) 02:19:39 INFO - [mozharness: 2017-09-01 09:19:39.944282Z] Running setup-mitmproxy step. 02:19:39 INFO - Running pre-action listener: _resource_record_pre_action 02:19:39 INFO - Running main action method: setup_mitmproxy 02:19:39 INFO - Skipping: mitmproxy is not required 02:19:39 INFO - Running post-action listener: _resource_record_post_action 02:19:39 INFO - [mozharness: 2017-09-01 09:19:39.945401Z] Finished setup-mitmproxy step (success) 02:19:39 INFO - [mozharness: 2017-09-01 09:19:39.945620Z] Running run-tests step. 02:19:39 INFO - Running pre-action listener: _resource_record_pre_action 02:19:39 INFO - Running pre-action listener: _set_gcov_prefix 02:19:39 INFO - Running main action method: run_tests 02:19:39 WARNING - Try message not found. 02:19:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:19:39 INFO - Python 2.7.3 02:19:39 INFO - Return code: 0 02:19:39 INFO - grabbing minidump binary from tooltool 02:19:39 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:39 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 0x23aa090>, '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 0x23aad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:19:39 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:39 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:39 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:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:19:40 INFO - Return code: 0 02:19:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:19:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:19:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:19:40 INFO - ENV: RUST_BACKTRACE is now full 02:19:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:19:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:19:40 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-058', '--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:40 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-058 --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:40 INFO - Using env: {'DISPLAY': ':0', 02:19:40 INFO - 'HOME': '/home/cltbld', 02:19:40 INFO - 'LANG': 'en_US.UTF-8', 02:19:40 INFO - 'LANGUAGE': 'en_US:en', 02:19:40 INFO - 'LOGNAME': 'cltbld', 02:19:40 INFO - 'MAIL': '/var/mail/cltbld', 02:19:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:19:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:40 INFO - 'MOZ_NO_REMOTE': '1', 02:19:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:40 INFO - 'NO_EM_RESTART': '1', 02:19:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:40 INFO - 'PWD': '/builds/slave/test', 02:19:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:19:40 INFO - 'RUST_BACKTRACE': 'full', 02:19:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:19:40 INFO - 'SHELL': '/bin/bash', 02:19:40 INFO - 'SHLVL': '1', 02:19:40 INFO - 'STYLO_FORCE_ENABLED': '1', 02:19:40 INFO - 'STYLO_THREADS': '1', 02:19:40 INFO - 'TERM': 'linux', 02:19:40 INFO - 'TMOUT': '86400', 02:19:40 INFO - 'USER': 'cltbld', 02:19:40 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', 02:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:40 INFO - '_': '/tools/buildbot/bin/python'} 02:19:40 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-058', '--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:40 INFO - mozversion application_buildid: 20170901083126 02:19:40 INFO - mozversion application_changeset: 583e73fb8e3c734dbf3a5e13913df7617f5c492c 02:19:40 INFO - mozversion application_display_name: Nightly 02:19:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:19:40 INFO - mozversion application_name: Firefox 02:19:40 INFO - mozversion application_remotingname: firefox 02:19:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:19:40 INFO - mozversion application_vendor: Mozilla 02:19:40 INFO - mozversion application_version: 57.0a1 02:19:40 INFO - mozversion platform_buildid: 20170901083126 02:19:40 INFO - mozversion platform_changeset: 583e73fb8e3c734dbf3a5e13913df7617f5c492c 02:19:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:19:40 INFO - mozversion platform_version: 57.0a1 02:19:40 INFO - using testdate: 1504257580 02:19:40 INFO - actual date: 1504257580 02:19:40 INFO - starting webserver on 'localhost:43807' 02:19:40 INFO - SUITE-START | Running 2 tests 02:19:40 INFO - TEST-START | dromaeo_css 02:19:40 INFO - Initialising browser for dromaeo_css test... 02:19:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43807/getInfo.html -profile /tmp/tmpe1DJww/profile 02:19:40 INFO - TEST-INFO | started process 18090 (/builds/slave/test/build/application/firefox/firefox http://localhost:43807/getInfo.html) 02:19:45 INFO - TEST-INFO | 18090: exit 0 02:19:45 INFO - Browser initialized. 02:19:45 INFO - Running cycle 1/1 for dromaeo_css test... 02:19:45 INFO - Using env: {'DISPLAY': ':0', 02:19:45 INFO - 'HOME': '/home/cltbld', 02:19:45 INFO - 'JSGC_DISABLE_POISONING': '1', 02:19:45 INFO - 'LANG': 'en_US.UTF-8', 02:19:45 INFO - 'LANGUAGE': 'en_US:en', 02:19:45 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:19:45 INFO - 'LOGNAME': 'cltbld', 02:19:45 INFO - 'MAIL': '/var/mail/cltbld', 02:19:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:19:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:19:45 INFO - 'MOZ_CRASHREPORTER': '1', 02:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:45 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:19:45 INFO - 'MOZ_NO_REMOTE': '1', 02:19:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:19:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:45 INFO - 'NO_EM_RESTART': '1', 02:19:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:45 INFO - 'PWD': '/builds/slave/test', 02:19:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:19:45 INFO - 'RUST_BACKTRACE': 'full', 02:19:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:19:45 INFO - 'SHELL': '/bin/bash', 02:19:45 INFO - 'SHLVL': '1', 02:19:45 INFO - 'STYLO_FORCE_ENABLED': '1', 02:19:45 INFO - 'STYLO_THREADS': '1', 02:19:45 INFO - 'TERM': 'linux', 02:19:45 INFO - 'TMOUT': '86400', 02:19:45 INFO - 'USER': 'cltbld', 02:19:45 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', 02:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:45 INFO - '_': '/tools/buildbot/bin/python'} 02:19:45 INFO - TEST-INFO | started process 18278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe1DJww/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:19:46 INFO - PID 18278 | 02:19:46 INFO - PID 18278 | (/builds/slave/test/build/application/firefox/firefox:18330): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:19:46 INFO - PID 18278 | 02:19:57 INFO - PID 18278 | RSS: Main: 171085824 02:19:57 INFO - PID 18278 | 02:22:55 INFO - PID 18278 | Cycle 1(1): loaded http://localhost:43807/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43807/tests/dromaeo/cssquery-ext.html) 02:22:57 INFO - PID 18278 | RSS: Main: 173862912 02:22:57 INFO - PID 18278 | 02:25:59 INFO - PID 18278 | Cycle 1(1): loaded http://localhost:43807/tests/dromaeo/cssquery-ext.html (next: http://localhost:43807/tests/dromaeo/cssquery-jquery.html) 02:26:00 INFO - PID 18278 | RSS: Main: 171073536 02:26:00 INFO - PID 18278 | 02:29:01 INFO - PID 18278 | Cycle 1(1): loaded http://localhost:43807/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43807/tests/dromaeo/cssquery-mootools.html) 02:29:02 INFO - PID 18278 | RSS: Main: 173883392 02:29:02 INFO - PID 18278 | 02:32:04 INFO - PID 18278 | Cycle 1(1): loaded http://localhost:43807/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43807/tests/dromaeo/cssquery-prototype.html) 02:32:04 INFO - PID 18278 | RSS: Main: 171859968 02:32:04 INFO - PID 18278 | 02:35:08 INFO - PID 18278 | Cycle 1(1): loaded http://localhost:43807/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43807/tests/dromaeo/cssquery-yui.html) 02:35:09 INFO - PID 18278 | RSS: Main: 173129728 02:35:09 INFO - PID 18278 | 02:38:10 INFO - PID 18278 | Cycle 1(1): loaded http://localhost:43807/tests/dromaeo/cssquery-yui.html (next: http://localhost:43807/tests/dromaeo/cssquery-dojo.html) 02:38:11 INFO - PID 18278 | RSS: Main: 175726592 02:38:11 INFO - PID 18278 | 02:38:11 INFO - PID 18278 | __start_tp_report 02:38:11 INFO - PID 18278 | _x_x_mozilla_page_load 02:38:11 INFO - PID 18278 | _x_x_mozilla_page_load_details 02:38:11 INFO - PID 18278 | |i|pagename|runs| 02:38:11 INFO - PID 18278 | |0;dojo.html;3307.4212012897738;3310.702036816686;3342.181165614424;3354.2452948086698;3366.141633883359;6403.5197360198;6414.0699598558185;6425.164728585283;6446.290908000116;6488.44848187904;6201.348858369863;6292.5595208335435;6309.9369006310035;6317.241930968279;6320.083587879754;5820.563457740675;5831.212786273863;5847.386024467433;5863.706814659271;5865.208196893407;5866.530677545786;5868.677222752747;5871.8532036699;6021.578489505737;6038.516918646497;6001.759929602811;6014.4286292802335;6028.969855150718;6029.366916473773;6070.332263451017;5898.852528686817;5942.792002279943;5993.370696076914;6006.939930600682;6046.093086037085;5719.771209151629;5759.769609215627;5854.238948936653;5938.317093534212;5950.494207992326;6416.582922110095;6422.4862011039;6427.132337134473;6455.515836312248;6456.644884531349;6872.553284036521;6889.138857642794;6976.093107895941;6987.475939304572;6991.021257024021;6637.601743895381;6733.932660673379;6737.3599508046655;6943.132108486439;7059.329363710439;6305.369463053704;6323.114763933007;6325.209348831396;6328.778492752777;6345.49236061114;6959.6868140933775;6976.686049127801;7003.894941575779;7006.9649651751415;7010.579365238102;6562.704678289489;6661.600303981777;6677.1319728435965;6686.030525573765;6707;6881.311868813179;6898.413634841095;6940.687669054904;6950.270221626656;6955.93044069563;6772.5936443813525;6845.178578570504;6877.828054298682;6878.7248510060035;6909;6832.897506537406;6845.075914751545;6918;6932.341427564374;6981.965090174516;5175.249588809676;5210.583153347723;5390.838274851761;5453.209284653783;5467.398586155519;4677.976610116928;4741.644376671763;4785.449673287617;4807.567318941312;4832.903341933142;5989.31122920861;6005.579609427386;6053.939460605426;6064.241969753781;6073.1497590337385;6701.061851340816;6759.459243260528;6782.796516104525;6785.491088168407;6792.3886850182735;5848.800995795852;5864.237649105589;5872.970635146882;5876.823695289148;5888.116782482576;5630.676790954122;5722.341930677942;5730.283714535683;5793.044147715664;5872.559558033165;6741.52809303344;6745.797626071226;6773.966130169416;6774.72901083961;6776.69504872282;6908.792736217922;6925.826854328682;6999.1950925644205;7007.6846541904715;7023.92976070243;6303.243610766737;6420.229572451336;6594.208694956636;6685.866282674222;6687.197536295481;6834.829129271808;6856.348646878539;6877.243503214542;6901.689423975833;6906.551074180162;6432.9678351607945;6955.6869940851775;7001.50989430735;7078.929210707827;7082.220955694973;6675.866482670416;6699.129113215251;6767.289434609492;6784.08414863987;6793.762218322335;6505.349465053646;6589.110470086477;6591.044298576584;6592.538522303393;6654.800355989328;6455.289918109098;6478.967605161944;6568.967155164193;6572.244191917991;6658.300878407891;6673.299303573055;6717.899231511434;6762.661866906733;6768.187817461936;6778.288279730755;6431.839204019937;6521.543491955707;6560.147180866456;6566.343365663395;6567.605943643397 02:38:11 INFO - PID 18278 | |1;ext.html;848.9235968762812;878.8901387326582;1218.8110842819367;1237.1834589171156;1237.6843904804273;35617.109572260706;39041.414378784306;39138.80430597843;39323.803380983125;39357;37716;38121.42817857734;38159.42760858582;38198.809005955;38235;7154.248803875583;7275.5998420087135;7281.781546553612;7436.293552112541;7618.085829700443;7581.507202031878;7661.118971318314;7668.846623067535;7677.3090421862025;7693.422993275499;7643.3885289177015;7682.385409167281;7683.078030636331;7685.116211635677;7716.112647045577;7641.61791910405;7651;7687.154413014536;7688.192739762357;7689.4232932530285;7542.69829206831;7608.2391760823475;7615.80960475987;7618.314351708373;7624.771256862303;35694.28611427783;35971;36014.63985360139;36249.81875090634;36253;3504.456809194579;3545.85816567337;3546.9113272168142;3550.254446566224;3551.6093229744706;30943.226419339695;31200.37599248002;31229;31256.843715781277;31279.37441251162;5118.104331741967;5133.6919784813035;5174.2238664200295;5177.326947496839;5211.348581427322;187309;189370;190259;190259;190299;40224.396634050514;40792.79603601963;45453.54546454559;45921;46100.30849537192;50102;51032.48967510278;51214.74392628013;51301.74349128231;51330.48669513257;14082.155070695791;14095;14161;14213.218272994878;14224.928875355765;11257.774844503065;11260.268082574607;11263.26788758728;11272.154588405903;11293.491792869341;13614.659633509242;13789.103708258932;13877.653058673412;13913.165210087427;13953.302334883216;5529.695866727288;5596.942216892801;5602.635828671123;5739.454751798572;5793.420657934173;985.2659768472533;1009.3842755918884;1009.4094954451581;1012.792377562598;1019.9439030853226;22906;28119.57820632692;28591.57112643312;28829.135125946254;29338;1083.3499900060058;1084.2464487181492;1086.266769930294;1093.4860615510697;1094.5402930769096;12169.939150304192;12300.938495307466;12312.81530777039;12357.691057723448;12409.62771116868;220080;223517;224302;226384;227037;47778.28332575014;47784.28323575149;47850;47852.28221576679;47989.5201047985;1354.6410201296665;1394.1008049807615;1402.3759427055068;1406.1914399220489;1432.4556668466125;21974.560508790055;22179.556408872057;22207.777922221216;22408.215712449986;22475;31539.84230078835;35646.64353356433;35781.82109089438;35818;35863.46204806878;202074;202867;203457;204625;205231;28061.579076313465;28398.43203135967;28433.573496397155;30615.387692246477;31329.373412532077;39294;39354.60645393509;39469.40795888007;39640.80179599083;39817.80091099526;29471;30086.548701769927;30088.699113008588;30348;30475.695243047285;29057;29857;29885.103446896628;29943.70056299409;30279.848600757738;33295.50056749102;33304.00087997364;33373.499397508574;33407;33489.497657534666;32609;32822;32934.670653293164;33183.336333273684;33796.15509612279;23871.641925370786;24119.172149205;24631.137910173056;24693.382665433506;24877.378065547782 02:38:11 INFO - PID 18278 | |2;jquery.html;558.7653185662022;567.7757285872083;568.2754488027766;577.5754820207147;578.1010528627984;21871.453213669647;22190.88904555479;22652.433689157737;22652.77347226527;22681.54636907261;23556;25134.74865251347;25140;25150.496990060186;25236.36909077274;6567.277599464055;6708.228553716312;6713.362230588086;6717.462602991774;6723.462123030145;5889.087191485327;6409.775657851976;6423.550351475398;6447.484201263887;6617;6359.777407790728;6363.4272915437605;6365.649889256089;6369.617822930616;6371.522135839808;6360.745570177188;6375.744970201186;6381.457576106037;6385.297617262097;6390.6485143317095;5955.970220148914;5976.223090998143;5980.282366116094;5983.820485385445;6002.069679199731;27830.582541261898;28545.429091418264;28820.71179288201;28979.56530652021;29142.708572914213;1999.1703443071108;2074.668053111495;2076.9376918692465;2081.094723795154;2083.364573804989;19370.32203872872;19969.900150499154;19999;20031.79968200314;20057.1977120915;2409.7590240975937;2427.3324835670155;2437.402836305099;2486.465409936854;2492.5887228607257;131023;132315;132938.33530832478;133010;134223;14297.428102875769;14315.713685726436;14444.566663000127;14766.114033158045;14982.400703971936;21966;21986.560268794536;22345.55308893813;23230.53538929212;23274.767252327598;10172.796544069077;10245.385276883411;10263.7434064149;10400.375977441377;10433.373997560171;9536.523173841419;9597.712068637951;9599.32804703678;9631.903680963242;9640.180584650243;9332.16010559053;9413.717588472357;9493.382930109521;9514.143727064597;9525.333226674205;2811.032277405824;2829.8302101873956;2835.164835164835;2841.602175695404;2934.6625138108966;901.1619194149504;939.8402271613842;965.792354643755;974.9317547771587;992.925530585209;19459;19530.804691953184;19821.40535783929;19864.70202946957;24246.15138470145;993.4337427666161;1041.146260066738;1053.3837704942541;1067.1889364083197;1072.828347464402;11172.720681983015;11248.718782030352;11266.267692599955;11293.717657058474;11371.829422558503;475539;499891;544454;544671;545542;118145;121325;121631.39184304021;122243;122739;1198.2271434924426;1234.2964510229083;1247.8502579690314;1252.993735031319;1257.4467234416827;20854.270100546408;20858.791412085684;20867.373978780663;21049.684254735886;21052.57894842125;50047;51505;52757.47242527526;57492;57704.711476442346;61784.2929424236;66159;66984.66507667431;67874;68133.65933170302;14532.636684082983;14744.2627868604;14870.702585948437;14872.40510379616;14905.254737262876;23396.298111056694;23428.53142937166;23536.646950295417;23862.761372386052;23862.88068559646;18132.456026319232;18816.341428049953;18988.430347089055;18991.24035038583;18993.525161871064;17211.91394043022;17252.13739313004;17259.91370043192;17539.824601754328;17782.288708451517;19862.304819331832;20396.89801550983;20785.1685932561;21000.684989725472;21002.264920727703;20891.16435342569;21073.473163171042;21454.570908582053;21512.462188445414;21553.137874484844;18990.43028709141;19111;19194.328198512983;19256.326028588934;19263.133159007597 02:38:11 INFO - PID 18278 | |3;mootools.html;1325.1651459580467;1368.8083668286442;1384.4531410093011;1396.4553824008644;1402.0956483068421;14875.851241487595;15386.461473848418;15491.845081549181;15493.380264789423;15516.379344826222;14589.92705036476;15147.318370673318;15816.209189540506;15863;15866.444674436398;2767.4326763013532;2817.506936286152;2817.647794025747;2825.067727649881;2843.5166021776245;2678.812483126182;2688.2607282997137;2779.722027797224;2782.1097248880365;2791.7487426131643;2765.3224959884856;2776.4585905748386;2785.7632101271415;2799.230211691781;2811.8031737778365;2738.4933787249224;2750.7386798254233;2764.1292992707336;2766.3775650478583;2782.1097248880365;2697.757201851823;2713.7693296069856;2737.192528204165;2768.2525718056213;2798.790090743182;15122.470713524974;15144.54566363011;15223.923880380638;15293.158876261801;15307.923460382626;7655.157932627407;7736.34241089508;7906.80232994174;7916.445848790587;7924.128345881948;5250.238715386247;5322;5416.674999500043;5541.889162216773;5577.330720313547;1893.848492120627;1914.368258474714;1916.5975145219381;1940.8258003907574;1950.1419375474889;26218.34454138643;26524.867375662998;26547;26616.866915665298;27792.722072779216;7222.313880181375;7236.963815180996;7355;7446.478746487694;7499.362554182846;20345.796542034685;20397.694034589495;20408.693869591967;20418.183272668928;20465.89767051185;8117;8281.420300579022;8281.8343633127;8283.917160828436;8292.087870334259;7316.341529262286;7348.154962179311;7380.372668323253;7525.172231054579;7533.585652789039;5542.946840100368;5687.544996400361;5712.942870571324;5722.856928576735;5751.568632352591;1691.4249155287262;1754.6227561074431;1754.9034803085954;1778.7865456145346;1804.2138283099637;868.2316150207113;895.9328050396247;906.8866391701038;909.9762766887252;910.3536489092686;7358.816029599303;7379.926200737924;7474;7479.663415146331;7503.812404689927;720.7909706185147;726.5241266970143;736.1497470421672;741.4068745003975;749.1871319618275;4494.820207191741;4502.5047244803045;4506.504284528699;4546.363509108727;4569.908601827945;21362.679559806616;21403.57192856134;21485.248016319354;21655.67516487254;21663.78336216649;20301.187952482032;21261.787382125982;21897.38693115618;21904.78095219059;21906.23328183506;9346.392484488486;9645.08371704701;11134.49894754738;11467.139964502696;11543.365114918592;7879.251471110236;8841.867371989296;8970.923588968364;9030.593623286837;9134.77163070902;18306.359277425225;18809.341673041377;18901.338453154072;19220.71168932439;19236.23055077837;18738.625227495646;18979.24083036663;19077.427677169708;19087.8091219086;19394.70907936354;10834.295770774874;11034.448277586249;11186;11197.44012799373;11231.38227397501;13629.659258518219;13844.238566878917;13854.515091972136;13855.930720346738;13866.376013079638;11182.88817111851;11342.659720208407;11373.431328433711;11403.372814495282;11463.484143213409;10486.528106235086;10692.411917344622;10786.730331741455;10832.295900766425;10894.727631808952;9258.259339252978;9477.241820654193;9614.423134611945;9614.71155865325;9620.278479113955;7255.818604534928;7280.890786638099;7351.632418379167;7360.711875421887;7366.189719130784;6914.274001229798;6917.550359226634;7071.398931090915;7074.186468555976;7076.681549330396 02:38:11 INFO - PID 18278 | |4;prototype.html;504.2612572581168;507.3075252280637;529.161279372195;530.8646295194725;537.3820106877091;6237.126802247689;6240.594361366508;6260.968695156524;6287.811365659026;6323.893318669226;5940.346561878201;6038.792241551696;6081.48307393871;6128.969355153229;6134.693265336738;4873.269009648546;4944.728039957801;4947.77735001924;4955.231939049444;4987.725675087869;4842.201036828919;4887.584555312803;4904.386951631046;4912.656114072016;4929;4730.0776348612035;4862;4863.489333619972;4879.926801097969;4922.286268491067;4883.218685010382;4891.9755401222765;4909.656324057318;4919.286703428001;4920.286558449041;4366.8034938427845;4399.12017596482;4400.691951563392;4411.911761764747;4424.557544245549;6037.396260373927;6112.572119951606;6116.235470566179;6135.723892424851;6138.938610613882;5609.419666953207;5618.943810561883;5626.777422917966;5649.887002259973;5671.404502527216;6466.353364663543;6467.902981455282;6476.676166191672;6498.967505162444;6540.607563546155;4728.361671174382;4763.5471181289695;4783.354247176621;4802.567768900815;4822.300766388854;6854.828629284308;6891.105735591063;6914;6928;6948.131483564554;4850.733209673432;4886.926696099561;4919.631027672939;4925.916298414343;4929.679570827885;4918.385201849769;4942.9258561121615;4966.90066198674;4981.227909674007;5000.174971129795;5563;5575.60970732053;5605.159226116034;5605.663660180402;5611.298587676541;6439.452646525004;6483.870322593521;6527.792358413709;6552.330694810921;6604.900926486107;1603.486884197069;1681.2434404518017;1684.3936182974119;1698.853274040018;1711.8801683882257;1156.1675593572613;1218.890299872998;1221.908356873238;1231.5381731850557;1236.713817629655;5770.403318506689;5796.594238403356;5801.098072129129;5835.912461313083;5862.618929769551;6581.703823327962;6617.154623511839;6633.701483433257;6679.76620818269;6793.845046342035;5892.793752218652;5897.911531327033;5898.262717160355;5908.586398952118;5914.940850591439;3560.857565697343;3574.767640103385;3583.516225309602;3596.777095787445;3611.1694310308776;6586;6604.933950660432;6637.800865974028;6639.302873198341;6640.535162538576;6977.267386924402;6991.440684745208;7023.824404389931;7026.435351096813;7063.293670632998;6572;6601.438877695354;6616;6622;6660.433863121592;6811.876040453468;6838.658067096725;6842.418394436529;6847.589144651337;6847.965760171167;6738.35985581369;6742.460603151638;6752.5948443093575;6790.42281406086;6825.010373495915;6378.394052564999;6423.871522569429;6469.547131700736;6488.480921526172;6491.253505846888;4790.065937142223;4846.878828029327;4857.716873069651;4859.781309841136;4865.56209941107;6811.012403201607;6812.216595091628;6817.284185160685;6877.2091209509545;6908.3091690830515;6451.806445806634;6502.967485162544;6527.9673601633585;6566.409023187936;6584.76953306632;6411.551191416556;6501.9674901625185;6506.544541882212;6522.804315870531;6560.278369379269;6248.875022499434;6294.464970477561;6320.209973753281;6371.6814159290925;6389.648569328731;6365.1088847562305;6368.630744389979;6489.545731798918;6490.545661803629;6571.732752200483;6167.55062560289;6313.779017734541;6323.430891219812;6337.588056776295;6375.234971803413 02:38:11 INFO - PID 18278 | |5;yui.html;886.3706768194581;890.5725251879098;904.0913881549044;904.1320332480818;905.8550631898897;19009.42971710849;19990.800091999077;19993.800061999376;20019.099140538692;20071.197152113935;20415.28546500873;20989.265375711853;21519.462013449673;21546.245881394156;21861.12555497778;954.3415043619915;971.6502059258661;974.0989584634185;974.1135566634364;975.2539307429787;925.2320573923661;980.6371642492288;981.8723565936418;984.0208992052917;984.4437892590663;1037.5953378182514;1044.1229367331441;1045.0594464981502;1046.236247539293;1047.7171163785774;991.0386924683082;1009.2430676992255;1019.3781793106199;1020.2042406922575;1020.2297265564525;735.2390276064248;746.358132006474;753.1564647594674;753.2693287511105;753.581762122022;17467.126643667892;18210.817891821043;18298.81701182998;18336.449906502825;18453.7231941521;19163.712544311846;19524.316648917218;19595.412137635893;19636.90181549083;20478.897605511876;15879.36482540697;16049.91975040129;16163.838361616468;16183.271752771036;16188.75716864248;3645;3677.7425580209397;3688.704903607732;3689.4834723138783;3691.8154092295276;126916.36541817324;129829;130670;131253;132531;15972.840271597368;16067.357305707874;16405.58986025359;16485.670286594443;16527.091009994325;29539.556906646416;30266.394672106875;30412.69587304143;30439.239019024702;30479.23801904926;7259.709611615476;7529.849403011909;8235.711750088838;8550.615222315011;8659.350548708871;4051.736637118578;4073.103917138225;4136.524299705512;4137.151883863861;4151.750894946313;5119.97440012805;5164.302819119446;5217.6347655664495;5273.683578985273;5276.683398996072;1103.2112039891515;1107.125370956935;1115.6485707002269;1117.201201141188;1125.971850703739;671.6272468779874;690.0718533572337;700.9579425234502;715.7172916697875;719.1909102259957;11000.614978475714;11140.275882067639;11198.272112312674;11501.942490287662;12802.167859089315;653.5980372071142;665.2615596687673;673.8989151627295;679.1476696745552;688.5214775730819;5404.378496472956;5447.319085114361;5447.96488667152;5531.976584331912;5612.35457922336;107269;109135;109503.45248273708;110894;115104;91456;93540.53229733808;93928.53035734777;98088;100035.49982250042;82685.17314826895;84052.15947840565;84250;84934;87471.12528874757;11987.700307492383;12049.51801927913;12204.267743935392;12296.430744068564;12335.259884406963;41455;41718.374224386054;42515;43031.924201895206;43312.133757325304;53784.73107634437;55633;55997.72001139968;56037.15944260921;56959;18254.81745182531;18353.724694129865;18532.444026679223;18580.81419185791;18888.33890813815;17931;18155.36456224026;18202.90898545499;18275.26898924028;18348.90825545864;17367.218475168902;17462.30150793954;17488.387906423723;17514.649707006043;17678.911605441892;17728.379506717203;17846.375376861746;18036.89727881335;18154.818451815314;18274.360397386026;17827.286908523514;18137.455876323733;18155.36456224026;18380.724289135407;18457.90771046136;11343.829842552203;11353.602623908124;11652.883471165518;11672.941635291769;11764;13185.637662396028;13795.652152199675;14143.292835357985;14218.928905355408;14322.57032289033 02:38:11 INFO - PID 18278 | __end_tp_report 02:38:11 INFO - PID 18278 | __start_cc_report 02:38:11 INFO - PID 18278 | _x_x_mozilla_cycle_collect,366 02:38:11 INFO - PID 18278 | __end_cc_report 02:38:11 INFO - PID 18278 | __startTimestamp1504258691092__endTimestamp 02:38:11 INFO - PID 18278 | 02:38:11 INFO - PID 18278 | ------- Summary: start ------- 02:38:11 INFO - PID 18278 | Number of tests: 6 02:38:11 INFO - PID 18278 | 02:38:11 INFO - PID 18278 | [#0] dojo.html Cycles:165 Average:6311.75 Median:6521.54 stddev:743.60 (11.4%) stddev-sans-first:707.55 02:38:11 INFO - PID 18278 | Values: 3307.4 3310.7 3342.2 3354.2 3366.1 6403.5 6414.1 6425.2 6446.3 6488.4 6201.3 6292.6 6309.9 6317.2 6320.1 5820.6 5831.2 5847.4 5863.7 5865.2 5866.5 5868.7 5871.9 6021.6 6038.5 6001.8 6014.4 6029.0 6029.4 6070.3 5898.9 5942.8 5993.4 6006.9 6046.1 5719.8 5759.8 5854.2 5938.3 5950.5 6416.6 6422.5 6427.1 6455.5 6456.6 6872.6 6889.1 6976.1 6987.5 6991.0 6637.6 6733.9 6737.4 6943.1 7059.3 6305.4 6323.1 6325.2 6328.8 6345.5 6959.7 6976.7 7003.9 7007.0 7010.6 6562.7 6661.6 6677.1 6686.0 6707.0 6881.3 6898.4 6940.7 6950.3 6955.9 6772.6 6845.2 6877.8 6878.7 6909.0 6832.9 6845.1 6918.0 6932.3 6982.0 5175.2 5210.6 5390.8 5453.2 5467.4 4678.0 4741.6 4785.4 4807.6 4832.9 5989.3 6005.6 6053.9 6064.2 6073.1 6701.1 6759.5 6782.8 6785.5 6792.4 5848.8 5864.2 5873.0 5876.8 5888.1 5630.7 5722.3 5730.3 5793.0 5872.6 6741.5 6745.8 6774.0 6774.7 6776.7 6908.8 6925.8 6999.2 7007.7 7023.9 6303.2 6420.2 6594.2 6685.9 6687.2 6834.8 6856.3 6877.2 6901.7 6906.6 6433.0 6955.7 7001.5 7078.9 7082.2 6675.9 6699.1 6767.3 6784.1 6793.8 6505.3 6589.1 6591.0 6592.5 6654.8 6455.3 6479.0 6569.0 6572.2 6658.3 6673.3 6717.9 6762.7 6768.2 6778.3 6431.8 6521.5 6560.1 6566.3 6567.6 02:38:11 INFO - PID 18278 | 02:38:11 INFO - PID 18278 | [#1] ext.html Cycles:180 Average:36572.81 Median:33059.00 stddev:53400.98 (161.5%) stddev-sans-first:53483.41 02:38:11 INFO - PID 18278 | Values: 848.9 878.9 1218.8 1237.2 1237.7 35617.1 39041.4 39138.8 39323.8 39357.0 37716.0 38121.4 38159.4 38198.8 38235.0 7154.2 7275.6 7281.8 7436.3 7618.1 7581.5 7661.1 7668.8 7677.3 7693.4 7643.4 7682.4 7683.1 7685.1 7716.1 7641.6 7651.0 7687.2 7688.2 7689.4 7542.7 7608.2 7615.8 7618.3 7624.8 35694.3 35971.0 36014.6 36249.8 36253.0 3504.5 3545.9 3546.9 3550.3 3551.6 30943.2 31200.4 31229.0 31256.8 31279.4 5118.1 5133.7 5174.2 5177.3 5211.3 187309.0 189370.0 190259.0 190259.0 190299.0 40224.4 40792.8 45453.5 45921.0 46100.3 50102.0 51032.5 51214.7 51301.7 51330.5 14082.2 14095.0 14161.0 14213.2 14224.9 11257.8 11260.3 11263.3 11272.2 11293.5 13614.7 13789.1 13877.7 13913.2 13953.3 5529.7 5596.9 5602.6 5739.5 5793.4 985.3 1009.4 1009.4 1012.8 1019.9 22906.0 28119.6 28591.6 28829.1 29338.0 1083.3 1084.2 1086.3 1093.5 1094.5 12169.9 12300.9 12312.8 12357.7 12409.6 220080.0 223517.0 224302.0 226384.0 227037.0 47778.3 47784.3 47850.0 47852.3 47989.5 1354.6 1394.1 1402.4 1406.2 1432.5 21974.6 22179.6 22207.8 22408.2 22475.0 31539.8 35646.6 35781.8 35818.0 35863.5 202074.0 202867.0 203457.0 204625.0 205231.0 28061.6 28398.4 28433.6 30615.4 31329.4 39294.0 39354.6 39469.4 39640.8 39817.8 29471.0 30086.5 30088.7 30348.0 30475.7 29057.0 29857.0 29885.1 29943.7 30279.8 33295.5 33304.0 33373.5 33407.0 33489.5 32609.0 32822.0 32934.7 33183.3 33796.2 23871.6 24119.2 24631.1 24693.4 24877.4 02:38:11 INFO - PID 18278 | 02:38:11 INFO - PID 18278 | [#2] jquery.html Cycles:180 Average:35825.25 Median:22956.04 stddev:87484.07 (381.1%) stddev-sans-first:87689.41 02:38:11 INFO - PID 18278 | Values: 558.8 567.8 568.3 577.6 578.1 21871.5 22190.9 22652.4 22652.8 22681.5 23556.0 25134.7 25140.0 25150.5 25236.4 6567.3 6708.2 6713.4 6717.5 6723.5 5889.1 6409.8 6423.6 6447.5 6617.0 6359.8 6363.4 6365.6 6369.6 6371.5 6360.7 6375.7 6381.5 6385.3 6390.6 5956.0 5976.2 5980.3 5983.8 6002.1 27830.6 28545.4 28820.7 28979.6 29142.7 1999.2 2074.7 2076.9 2081.1 2083.4 19370.3 19969.9 19999.0 20031.8 20057.2 2409.8 2427.3 2437.4 2486.5 2492.6 131023.0 132315.0 132938.3 133010.0 134223.0 14297.4 14315.7 14444.6 14766.1 14982.4 21966.0 21986.6 22345.6 23230.5 23274.8 10172.8 10245.4 10263.7 10400.4 10433.4 9536.5 9597.7 9599.3 9631.9 9640.2 9332.2 9413.7 9493.4 9514.1 9525.3 2811.0 2829.8 2835.2 2841.6 2934.7 901.2 939.8 965.8 974.9 992.9 19459.0 19530.8 19821.4 19864.7 24246.2 993.4 1041.1 1053.4 1067.2 1072.8 11172.7 11248.7 11266.3 11293.7 11371.8 475539.0 499891.0 544454.0 544671.0 545542.0 118145.0 121325.0 121631.4 122243.0 122739.0 1198.2 1234.3 1247.9 1253.0 1257.4 20854.3 20858.8 20867.4 21049.7 21052.6 50047.0 51505.0 52757.5 57492.0 57704.7 61784.3 66159.0 66984.7 67874.0 68133.7 14532.6 14744.3 14870.7 14872.4 14905.3 23396.3 23428.5 23536.6 23862.8 23862.9 18132.5 18816.3 18988.4 18991.2 18993.5 17211.9 17252.1 17259.9 17539.8 17782.3 19862.3 20396.9 20785.2 21000.7 21002.3 20891.2 21073.5 21454.6 21512.5 21553.1 18990.4 19111.0 19194.3 19256.3 19263.1 02:38:11 INFO - PID 18278 | 02:38:11 INFO - PID 18278 | [#3] mootools.html Cycles:180 Average:9411.12 Median:2765.85 stddev:6810.67 (246.2%) stddev-sans-first:6802.68 02:38:11 INFO - PID 18278 | Values: 1325.2 1368.8 1384.5 1396.5 1402.1 14875.9 15386.5 15491.8 15493.4 15516.4 14589.9 15147.3 15816.2 15863.0 15866.4 2767.4 2817.5 2817.6 2825.1 2843.5 2678.8 2688.3 2779.7 2782.1 2791.7 2765.3 2776.5 2785.8 2799.2 2811.8 2738.5 2750.7 2764.1 2766.4 2782.1 2697.8 2713.8 2737.2 2768.3 2798.8 15122.5 15144.5 15223.9 15293.2 15307.9 7655.2 7736.3 7906.8 7916.4 7924.1 5250.2 5322.0 5416.7 5541.9 5577.3 1893.8 1914.4 1916.6 1940.8 1950.1 26218.3 26524.9 26547.0 26616.9 27792.7 7222.3 7237.0 7355.0 7446.5 7499.4 20345.8 20397.7 20408.7 20418.2 20465.9 8117.0 8281.4 8281.8 8283.9 8292.1 7316.3 7348.2 7380.4 7525.2 7533.6 5542.9 5687.5 5712.9 5722.9 5751.6 1691.4 1754.6 1754.9 1778.8 1804.2 868.2 895.9 906.9 910.0 910.4 7358.8 7379.9 7474.0 7479.7 7503.8 720.8 726.5 736.1 741.4 749.2 4494.8 4502.5 4506.5 4546.4 4569.9 21362.7 21403.6 21485.2 21655.7 21663.8 20301.2 21261.8 21897.4 21904.8 21906.2 9346.4 9645.1 11134.5 11467.1 11543.4 7879.3 8841.9 8970.9 9030.6 9134.8 18306.4 18809.3 18901.3 19220.7 19236.2 18738.6 18979.2 19077.4 19087.8 19394.7 10834.3 11034.4 11186.0 11197.4 11231.4 13629.7 13844.2 13854.5 13855.9 13866.4 11182.9 11342.7 11373.4 11403.4 11463.5 10486.5 10692.4 10786.7 10832.3 10894.7 9258.3 9477.2 9614.4 9614.7 9620.3 7255.8 7280.9 7351.6 7360.7 7366.2 6914.3 6917.6 7071.4 7074.2 7076.7 02:38:11 INFO - PID 18278 | 02:38:11 INFO - PID 18278 | [#4] prototype.html Cycles:180 Average:5492.05 Median:6122.60 stddev:1566.90 (25.6%) stddev-sans-first:1525.92 02:38:11 INFO - PID 18278 | Values: 504.3 507.3 529.2 530.9 537.4 6237.1 6240.6 6261.0 6287.8 6323.9 5940.3 6038.8 6081.5 6129.0 6134.7 4873.3 4944.7 4947.8 4955.2 4987.7 4842.2 4887.6 4904.4 4912.7 4929.0 4730.1 4862.0 4863.5 4879.9 4922.3 4883.2 4892.0 4909.7 4919.3 4920.3 4366.8 4399.1 4400.7 4411.9 4424.6 6037.4 6112.6 6116.2 6135.7 6138.9 5609.4 5618.9 5626.8 5649.9 5671.4 6466.4 6467.9 6476.7 6499.0 6540.6 4728.4 4763.5 4783.4 4802.6 4822.3 6854.8 6891.1 6914.0 6928.0 6948.1 4850.7 4886.9 4919.6 4925.9 4929.7 4918.4 4942.9 4966.9 4981.2 5000.2 5563.0 5575.6 5605.2 5605.7 5611.3 6439.5 6483.9 6527.8 6552.3 6604.9 1603.5 1681.2 1684.4 1698.9 1711.9 1156.2 1218.9 1221.9 1231.5 1236.7 5770.4 5796.6 5801.1 5835.9 5862.6 6581.7 6617.2 6633.7 6679.8 6793.8 5892.8 5897.9 5898.3 5908.6 5914.9 3560.9 3574.8 3583.5 3596.8 3611.2 6586.0 6604.9 6637.8 6639.3 6640.5 6977.3 6991.4 7023.8 7026.4 7063.3 6572.0 6601.4 6616.0 6622.0 6660.4 6811.9 6838.7 6842.4 6847.6 6848.0 6738.4 6742.5 6752.6 6790.4 6825.0 6378.4 6423.9 6469.5 6488.5 6491.3 4790.1 4846.9 4857.7 4859.8 4865.6 6811.0 6812.2 6817.3 6877.2 6908.3 6451.8 6503.0 6528.0 6566.4 6584.8 6411.6 6502.0 6506.5 6522.8 6560.3 6248.9 6294.5 6320.2 6371.7 6389.6 6365.1 6368.6 6489.5 6490.5 6571.7 6167.6 6313.8 6323.4 6337.6 6375.2 02:38:11 INFO - PID 18278 | 02:38:11 INFO - PID 18278 | [#5] yui.html Cycles:180 Average:23183.10 Median:19992.30 stddev:31887.05 (159.5%) stddev-sans-first:31932.55 02:38:11 INFO - PID 18278 | Values: 886.4 890.6 904.1 904.1 905.9 19009.4 19990.8 19993.8 20019.1 20071.2 20415.3 20989.3 21519.5 21546.2 21861.1 954.3 971.7 974.1 974.1 975.3 925.2 980.6 981.9 984.0 984.4 1037.6 1044.1 1045.1 1046.2 1047.7 991.0 1009.2 1019.4 1020.2 1020.2 735.2 746.4 753.2 753.3 753.6 17467.1 18210.8 18298.8 18336.4 18453.7 19163.7 19524.3 19595.4 19636.9 20478.9 15879.4 16049.9 16163.8 16183.3 16188.8 3645.0 3677.7 3688.7 3689.5 3691.8 126916.4 129829.0 130670.0 131253.0 132531.0 15972.8 16067.4 16405.6 16485.7 16527.1 29539.6 30266.4 30412.7 30439.2 30479.2 7259.7 7529.8 8235.7 8550.6 8659.4 4051.7 4073.1 4136.5 4137.2 4151.8 5120.0 5164.3 5217.6 5273.7 5276.7 1103.2 1107.1 1115.6 1117.2 1126.0 671.6 690.1 701.0 715.7 719.2 11000.6 11140.3 11198.3 11501.9 12802.2 653.6 665.3 673.9 679.1 688.5 5404.4 5447.3 5448.0 5532.0 5612.4 107269.0 109135.0 109503.5 110894.0 115104.0 91456.0 93540.5 93928.5 98088.0 100035.5 82685.2 84052.2 84250.0 84934.0 87471.1 11987.7 12049.5 12204.3 12296.4 12335.3 41455.0 41718.4 42515.0 43031.9 43312.1 53784.7 55633.0 55997.7 56037.2 56959.0 18254.8 18353.7 18532.4 18580.8 18888.3 17931.0 18155.4 18202.9 18275.3 18348.9 17367.2 17462.3 17488.4 17514.6 17678.9 17728.4 17846.4 18036.9 18154.8 18274.4 17827.3 18137.5 18155.4 18380.7 18457.9 11343.8 11353.6 11652.9 11672.9 11764.0 13185.6 13795.7 14143.3 14218.9 14322.6 02:38:11 INFO - PID 18278 | -------- Summary: end -------- 02:38:11 INFO - PID 18278 | 02:38:11 INFO - TEST-INFO | 18278: exit 0 02:38:11 INFO - TEST-OK | dromaeo_css | took 1111481ms 02:38:11 INFO - TEST-START | kraken 02:38:11 INFO - Initialising browser for kraken test... 02:38:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43807/getInfo.html -profile /tmp/tmpUaem6F/profile 02:38:11 INFO - TEST-INFO | started process 18649 (/builds/slave/test/build/application/firefox/firefox http://localhost:43807/getInfo.html) 02:38:17 INFO - TEST-INFO | 18649: exit 0 02:38:17 INFO - Browser initialized. 02:38:17 INFO - Running cycle 1/1 for kraken test... 02:38:17 INFO - Using env: {'DISPLAY': ':0', 02:38:17 INFO - 'HOME': '/home/cltbld', 02:38:17 INFO - 'JSGC_DISABLE_POISONING': '1', 02:38:17 INFO - 'LANG': 'en_US.UTF-8', 02:38:17 INFO - 'LANGUAGE': 'en_US:en', 02:38:17 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:38:17 INFO - 'LOGNAME': 'cltbld', 02:38:17 INFO - 'MAIL': '/var/mail/cltbld', 02:38:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:38:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:38:17 INFO - 'MOZ_CRASHREPORTER': '1', 02:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:17 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:38:17 INFO - 'MOZ_NO_REMOTE': '1', 02:38:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:38:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:17 INFO - 'NO_EM_RESTART': '1', 02:38:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:17 INFO - 'PWD': '/builds/slave/test', 02:38:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:38:17 INFO - 'RUST_BACKTRACE': 'full', 02:38:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:38:17 INFO - 'SHELL': '/bin/bash', 02:38:17 INFO - 'SHLVL': '1', 02:38:17 INFO - 'STYLO_FORCE_ENABLED': '1', 02:38:17 INFO - 'STYLO_THREADS': '1', 02:38:17 INFO - 'TERM': 'linux', 02:38:17 INFO - 'TMOUT': '86400', 02:38:17 INFO - 'USER': 'cltbld', 02:38:17 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699', 02:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:17 INFO - '_': '/tools/buildbot/bin/python'} 02:38:17 INFO - TEST-INFO | started process 18833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUaem6F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:38:18 INFO - PID 18833 | 02:38:18 INFO - PID 18833 | (/builds/slave/test/build/application/firefox/firefox:18885): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:38:18 INFO - PID 18833 | 02:38:28 INFO - PID 18833 | RSS: Main: 173064192 02:38:28 INFO - PID 18833 | 02:38:31 INFO - PID 18833 | Cycle 1(1): loaded http://localhost:43807/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43807/tests/kraken/driver.html?testName=audio-beat-detection) 02:38:32 INFO - PID 18833 | RSS: Main: 178946048 02:38:32 INFO - PID 18833 | 02:38:34 INFO - PID 18833 | Cycle 1(1): loaded http://localhost:43807/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43807/tests/kraken/driver.html?testName=audio-dft) 02:38:35 INFO - PID 18833 | RSS: Main: 183554048 02:38:35 INFO - PID 18833 | 02:38:38 INFO - PID 18833 | Cycle 1(1): loaded http://localhost:43807/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43807/tests/kraken/driver.html?testName=audio-fft) 02:38:39 INFO - PID 18833 | RSS: Main: 175337472 02:38:39 INFO - PID 18833 | 02:38:41 INFO - PID 18833 | Cycle 1(1): loaded http://localhost:43807/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43807/tests/kraken/driver.html?testName=audio-oscillator) 02:38:41 INFO - PID 18833 | RSS: Main: 175923200 02:38:41 INFO - PID 18833 | 02:38:44 INFO - PID 18833 | Cycle 1(1): loaded http://localhost:43807/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43807/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:38:44 INFO - PID 18833 | RSS: Main: 175992832 02:38:44 INFO - PID 18833 | 02:38:47 INFO - PID 18833 | Cycle 1(1): loaded http://localhost:43807/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43807/tests/kraken/driver.html?testName=imaging-darkroom) 02:38:48 INFO - PID 18833 | RSS: Main: 177143808 02:38:48 INFO - PID 18833 | 02:38:51 INFO - PID 18833 | Cycle 1(1): loaded http://localhost:43807/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43807/tests/kraken/driver.html?testName=imaging-desaturate) 02:38:52 INFO - PID 18833 | RSS: Main: 176582656 02:38:52 INFO - PID 18833 | 02:38:55 INFO - PID 18833 | Cycle 1(1): loaded http://localhost:43807/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43807/tests/kraken/driver.html?testName=json-parse-financial) 02:38:56 INFO - PID 18833 | RSS: Main: 176939008 02:38:56 INFO - PID 18833 | 02:38:57 INFO - PID 18833 | Cycle 1(1): loaded http://localhost:43807/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43807/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:38:58 INFO - PID 18833 | RSS: Main: 177156096 02:38:58 INFO - PID 18833 | 02:38:59 INFO - PID 18833 | Cycle 1(1): loaded http://localhost:43807/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43807/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:39:00 INFO - PID 18833 | RSS: Main: 177172480 02:39:00 INFO - PID 18833 | 02:39:02 INFO - PID 18833 | Cycle 1(1): loaded http://localhost:43807/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43807/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:39:03 INFO - PID 18833 | RSS: Main: 173559808 02:39:03 INFO - PID 18833 | 02:39:05 INFO - PID 18833 | Cycle 1(1): loaded http://localhost:43807/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:39:06 INFO - PID 18833 | RSS: Main: 173764608 02:39:06 INFO - PID 18833 | 02:39:09 INFO - PID 18833 | Cycle 1(1): loaded http://localhost:43807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:39:10 INFO - PID 18833 | RSS: Main: 174415872 02:39:10 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | Cycle 1(1): loaded http://localhost:43807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43807/tests/kraken/driver.html?testName=ai-astar) 02:39:12 INFO - PID 18833 | RSS: Main: 175931392 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | __start_tp_report 02:39:12 INFO - PID 18833 | _x_x_mozilla_page_load 02:39:12 INFO - PID 18833 | _x_x_mozilla_page_load_details 02:39:12 INFO - PID 18833 | |i|pagename|runs| 02:39:12 INFO - PID 18833 | |0;ai-astar;97;107;105;109;106;113;110;101;109;110 02:39:12 INFO - PID 18833 | |1;audio-beat-detection;150;116;149;171;118;141;146;120;174;118 02:39:12 INFO - PID 18833 | |2;audio-dft;166;163;164;164;162;161;162;167;173;162 02:39:12 INFO - PID 18833 | |3;audio-fft;74;77;75;176;75;74;77;73;156;75 02:39:12 INFO - PID 18833 | |4;audio-oscillator;79;79;136;78;79;79;131;80;79;129 02:39:12 INFO - PID 18833 | |5;imaging-gaussian-blur;115;114;115;114;113;114;114;115;114;113 02:39:12 INFO - PID 18833 | |6;imaging-darkroom;148;148;149;148;149;149;147;147;147;148 02:39:12 INFO - PID 18833 | |7;imaging-desaturate;94;94;94;95;94;94;94;94;94;93 02:39:12 INFO - PID 18833 | |8;json-parse-financial;53;53;52;53;53;53;54;53;53;54 02:39:12 INFO - PID 18833 | |9;json-stringify-tinderbox;37;38;37;38;38;38;38;39;38;39 02:39:12 INFO - PID 18833 | |10;stanford-crypto-aes;81;80;81;79;77;75;76;74;75;74 02:39:12 INFO - PID 18833 | |11;stanford-crypto-ccm;119;123;118;118;129;119;122;119;120;159 02:39:12 INFO - PID 18833 | |12;stanford-crypto-pbkdf2;173;172;169;169;169;178;163;176;165;170 02:39:12 INFO - PID 18833 | |13;stanford-crypto-sha256-iterative;68;64;66;71;64;63;65;62;65;63 02:39:12 INFO - PID 18833 | __end_tp_report 02:39:12 INFO - PID 18833 | __start_cc_report 02:39:12 INFO - PID 18833 | _x_x_mozilla_cycle_collect,954 02:39:12 INFO - PID 18833 | __end_cc_report 02:39:12 INFO - PID 18833 | __startTimestamp1504258752274__endTimestamp 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | ------- Summary: start ------- 02:39:12 INFO - PID 18833 | Number of tests: 14 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | [#0] ai-astar Cycles:10 Average:106.70 Median:109.50 stddev:4.74 (4.3%) stddev-sans-first:3.49 02:39:12 INFO - PID 18833 | Values: 97.0 107.0 105.0 109.0 106.0 113.0 110.0 101.0 109.0 110.0 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:147.50 stddev:21.80 (14.8%) stddev-sans-first:22.84 02:39:12 INFO - PID 18833 | Values: 150.0 116.0 149.0 171.0 118.0 141.0 146.0 120.0 174.0 118.0 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:3.57 (2.2%) stddev-sans-first:3.73 02:39:12 INFO - PID 18833 | Values: 166.0 163.0 164.0 164.0 162.0 161.0 162.0 167.0 173.0 162.0 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:38.68 (51.6%) stddev-sans-first:40.39 02:39:12 INFO - PID 18833 | Values: 74.0 77.0 75.0 176.0 75.0 74.0 77.0 73.0 156.0 75.0 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:79.00 stddev:25.66 (32.5%) stddev-sans-first:26.57 02:39:12 INFO - PID 18833 | Values: 79.0 79.0 136.0 78.0 79.0 79.0 131.0 80.0 79.0 129.0 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 02:39:12 INFO - PID 18833 | Values: 115.0 114.0 115.0 114.0 113.0 114.0 114.0 115.0 114.0 113.0 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 02:39:12 INFO - PID 18833 | Values: 148.0 148.0 149.0 148.0 149.0 149.0 147.0 147.0 147.0 148.0 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 02:39:12 INFO - PID 18833 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 93.0 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 02:39:12 INFO - PID 18833 | Values: 53.0 53.0 52.0 53.0 53.0 53.0 54.0 53.0 53.0 54.0 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.67 (1.8%) stddev-sans-first:0.60 02:39:12 INFO - PID 18833 | Values: 37.0 38.0 37.0 38.0 38.0 38.0 38.0 39.0 38.0 39.0 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:78.00 stddev:2.82 (3.6%) stddev-sans-first:2.64 02:39:12 INFO - PID 18833 | Values: 81.0 80.0 81.0 79.0 77.0 75.0 76.0 74.0 75.0 74.0 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:121.00 stddev:12.54 (10.4%) stddev-sans-first:13.13 02:39:12 INFO - PID 18833 | Values: 119.0 123.0 118.0 118.0 129.0 119.0 122.0 119.0 120.0 159.0 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.00 stddev:4.58 (2.7%) stddev-sans-first:4.76 02:39:12 INFO - PID 18833 | Values: 173.0 172.0 169.0 169.0 169.0 178.0 163.0 176.0 165.0 170.0 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:2.69 (4.1%) stddev-sans-first:2.64 02:39:12 INFO - PID 18833 | Values: 68.0 64.0 66.0 71.0 64.0 63.0 65.0 62.0 65.0 63.0 02:39:12 INFO - PID 18833 | -------- Summary: end -------- 02:39:12 INFO - PID 18833 | 02:39:12 INFO - PID 18833 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 02:39:12 INFO - TEST-INFO | 18833: exit 0 02:39:12 INFO - TEST-OK | kraken | took 61160ms 02:39:12 INFO - SUITE-END | took 1172s 02:39:13 INFO - Completed test suite (00:19:33) 02:39:13 INFO - javascript benchmark 02:39:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8529.093232771225, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.4212012897738, 3310.702036816686, 3342.181165614424, 3354.2452948086698, 3366.141633883359, 6403.5197360198, 6414.0699598558185, 6425.164728585283, 6446.290908000116, 6488.44848187904, 6201.348858369863, 6292.5595208335435, 6309.9369006310035, 6317.241930968279, 6320.083587879754, 5820.563457740675, 5831.212786273863, 5847.386024467433, 5863.706814659271, 5865.208196893407, 5866.530677545786, 5868.677222752747, 5871.8532036699, 6021.578489505737, 6038.516918646497, 6001.759929602811, 6014.4286292802335, 6028.969855150718, 6029.366916473773, 6070.332263451017, 5898.852528686817, 5942.792002279943, 5993.370696076914, 6006.939930600682, 6046.093086037085, 5719.771209151629, 5759.769609215627, 5854.238948936653, 5938.317093534212, 5950.494207992326, 6416.582922110095, 6422.4862011039, 6427.132337134473, 6455.515836312248, 6456.644884531349, 6872.553284036521, 6889.138857642794, 6976.093107895941, 6987.475939304572, 6991.021257024021, 6637.601743895381, 6733.932660673379, 6737.3599508046655, 6943.132108486439, 7059.329363710439, 6305.369463053704, 6323.114763933007, 6325.209348831396, 6328.778492752777, 6345.49236061114, 6959.6868140933775, 6976.686049127801, 7003.894941575779, 7006.9649651751415, 7010.579365238102, 6562.704678289489, 6661.600303981777, 6677.1319728435965, 6686.030525573765, 6707.0, 6881.311868813179, 6898.413634841095, 6940.687669054904, 6950.270221626656, 6955.93044069563, 6772.5936443813525, 6845.178578570504, 6877.828054298682, 6878.7248510060035, 6909.0, 6832.897506537406, 6845.075914751545, 6918.0, 6932.341427564374, 6981.965090174516, 5175.249588809676, 5210.583153347723, 5390.838274851761, 5453.209284653783, 5467.398586155519, 4677.976610116928, 4741.644376671763, 4785.449673287617, 4807.567318941312, 4832.903341933142, 5989.31122920861, 6005.579609427386, 6053.939460605426, 6064.241969753781, 6073.1497590337385, 6701.061851340816, 6759.459243260528, 6782.796516104525, 6785.491088168407, 6792.3886850182735, 5848.800995795852, 5864.237649105589, 5872.970635146882, 5876.823695289148, 5888.116782482576, 5630.676790954122, 5722.341930677942, 5730.283714535683, 5793.044147715664, 5872.559558033165, 6741.52809303344, 6745.797626071226, 6773.966130169416, 6774.72901083961, 6776.69504872282, 6908.792736217922, 6925.826854328682, 6999.1950925644205, 7007.6846541904715, 7023.92976070243, 6303.243610766737, 6420.229572451336, 6594.208694956636, 6685.866282674222, 6687.197536295481, 6834.829129271808, 6856.348646878539, 6877.243503214542, 6901.689423975833, 6906.551074180162, 6432.9678351607945, 6955.6869940851775, 7001.50989430735, 7078.929210707827, 7082.220955694973, 6675.866482670416, 6699.129113215251, 6767.289434609492, 6784.08414863987, 6793.762218322335, 6505.349465053646, 6589.110470086477, 6591.044298576584, 6592.538522303393, 6654.800355989328, 6455.289918109098, 6478.967605161944, 6568.967155164193, 6572.244191917991, 6658.300878407891, 6673.299303573055, 6717.899231511434, 6762.661866906733, 6768.187817461936, 6778.288279730755, 6431.839204019937, 6521.543491955707, 6560.147180866456, 6566.343365663395, 6567.605943643397], "value": 6257.380109935507, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [848.9235968762812, 878.8901387326582, 1218.8110842819367, 1237.1834589171156, 1237.6843904804273, 35617.109572260706, 39041.414378784306, 39138.80430597843, 39323.803380983125, 39357.0, 37716.0, 38121.42817857734, 38159.42760858582, 38198.809005955, 38235.0, 7154.248803875583, 7275.5998420087135, 7281.781546553612, 7436.293552112541, 7618.085829700443, 7581.507202031878, 7661.118971318314, 7668.846623067535, 7677.3090421862025, 7693.422993275499, 7643.3885289177015, 7682.385409167281, 7683.078030636331, 7685.116211635677, 7716.112647045577, 7641.61791910405, 7651.0, 7687.154413014536, 7688.192739762357, 7689.4232932530285, 7542.69829206831, 7608.2391760823475, 7615.80960475987, 7618.314351708373, 7624.771256862303, 35694.28611427783, 35971.0, 36014.63985360139, 36249.81875090634, 36253.0, 3504.456809194579, 3545.85816567337, 3546.9113272168142, 3550.254446566224, 3551.6093229744706, 30943.226419339695, 31200.37599248002, 31229.0, 31256.843715781277, 31279.37441251162, 5118.104331741967, 5133.6919784813035, 5174.2238664200295, 5177.326947496839, 5211.348581427322, 187309.0, 189370.0, 190259.0, 190259.0, 190299.0, 40224.396634050514, 40792.79603601963, 45453.54546454559, 45921.0, 46100.30849537192, 50102.0, 51032.48967510278, 51214.74392628013, 51301.74349128231, 51330.48669513257, 14082.155070695791, 14095.0, 14161.0, 14213.218272994878, 14224.928875355765, 11257.774844503065, 11260.268082574607, 11263.26788758728, 11272.154588405903, 11293.491792869341, 13614.659633509242, 13789.103708258932, 13877.653058673412, 13913.165210087427, 13953.302334883216, 5529.695866727288, 5596.942216892801, 5602.635828671123, 5739.454751798572, 5793.420657934173, 985.2659768472533, 1009.3842755918884, 1009.4094954451581, 1012.792377562598, 1019.9439030853226, 22906.0, 28119.57820632692, 28591.57112643312, 28829.135125946254, 29338.0, 1083.3499900060058, 1084.2464487181492, 1086.266769930294, 1093.4860615510697, 1094.5402930769096, 12169.939150304192, 12300.938495307466, 12312.81530777039, 12357.691057723448, 12409.62771116868, 220080.0, 223517.0, 224302.0, 226384.0, 227037.0, 47778.28332575014, 47784.28323575149, 47850.0, 47852.28221576679, 47989.5201047985, 1354.6410201296665, 1394.1008049807615, 1402.3759427055068, 1406.1914399220489, 1432.4556668466125, 21974.560508790055, 22179.556408872057, 22207.777922221216, 22408.215712449986, 22475.0, 31539.84230078835, 35646.64353356433, 35781.82109089438, 35818.0, 35863.46204806878, 202074.0, 202867.0, 203457.0, 204625.0, 205231.0, 28061.579076313465, 28398.43203135967, 28433.573496397155, 30615.387692246477, 31329.373412532077, 39294.0, 39354.60645393509, 39469.40795888007, 39640.80179599083, 39817.80091099526, 29471.0, 30086.548701769927, 30088.699113008588, 30348.0, 30475.695243047285, 29057.0, 29857.0, 29885.103446896628, 29943.70056299409, 30279.848600757738, 33295.50056749102, 33304.00087997364, 33373.499397508574, 33407.0, 33489.497657534666, 32609.0, 32822.0, 32934.670653293164, 33183.336333273684, 33796.15509612279, 23871.641925370786, 24119.172149205, 24631.137910173056, 24693.382665433506, 24877.378065547782], "value": 16716.190583255044, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.7653185662022, 567.7757285872083, 568.2754488027766, 577.5754820207147, 578.1010528627984, 21871.453213669647, 22190.88904555479, 22652.433689157737, 22652.77347226527, 22681.54636907261, 23556.0, 25134.74865251347, 25140.0, 25150.496990060186, 25236.36909077274, 6567.277599464055, 6708.228553716312, 6713.362230588086, 6717.462602991774, 6723.462123030145, 5889.087191485327, 6409.775657851976, 6423.550351475398, 6447.484201263887, 6617.0, 6359.777407790728, 6363.4272915437605, 6365.649889256089, 6369.617822930616, 6371.522135839808, 6360.745570177188, 6375.744970201186, 6381.457576106037, 6385.297617262097, 6390.6485143317095, 5955.970220148914, 5976.223090998143, 5980.282366116094, 5983.820485385445, 6002.069679199731, 27830.582541261898, 28545.429091418264, 28820.71179288201, 28979.56530652021, 29142.708572914213, 1999.1703443071108, 2074.668053111495, 2076.9376918692465, 2081.094723795154, 2083.364573804989, 19370.32203872872, 19969.900150499154, 19999.0, 20031.79968200314, 20057.1977120915, 2409.7590240975937, 2427.3324835670155, 2437.402836305099, 2486.465409936854, 2492.5887228607257, 131023.0, 132315.0, 132938.33530832478, 133010.0, 134223.0, 14297.428102875769, 14315.713685726436, 14444.566663000127, 14766.114033158045, 14982.400703971936, 21966.0, 21986.560268794536, 22345.55308893813, 23230.53538929212, 23274.767252327598, 10172.796544069077, 10245.385276883411, 10263.7434064149, 10400.375977441377, 10433.373997560171, 9536.523173841419, 9597.712068637951, 9599.32804703678, 9631.903680963242, 9640.180584650243, 9332.16010559053, 9413.717588472357, 9493.382930109521, 9514.143727064597, 9525.333226674205, 2811.032277405824, 2829.8302101873956, 2835.164835164835, 2841.602175695404, 2934.6625138108966, 901.1619194149504, 939.8402271613842, 965.792354643755, 974.9317547771587, 992.925530585209, 19459.0, 19530.804691953184, 19821.40535783929, 19864.70202946957, 24246.15138470145, 993.4337427666161, 1041.146260066738, 1053.3837704942541, 1067.1889364083197, 1072.828347464402, 11172.720681983015, 11248.718782030352, 11266.267692599955, 11293.717657058474, 11371.829422558503, 475539.0, 499891.0, 544454.0, 544671.0, 545542.0, 118145.0, 121325.0, 121631.39184304021, 122243.0, 122739.0, 1198.2271434924426, 1234.2964510229083, 1247.8502579690314, 1252.993735031319, 1257.4467234416827, 20854.270100546408, 20858.791412085684, 20867.373978780663, 21049.684254735886, 21052.57894842125, 50047.0, 51505.0, 52757.47242527526, 57492.0, 57704.711476442346, 61784.2929424236, 66159.0, 66984.66507667431, 67874.0, 68133.65933170302, 14532.636684082983, 14744.2627868604, 14870.702585948437, 14872.40510379616, 14905.254737262876, 23396.298111056694, 23428.53142937166, 23536.646950295417, 23862.761372386052, 23862.88068559646, 18132.456026319232, 18816.341428049953, 18988.430347089055, 18991.24035038583, 18993.525161871064, 17211.91394043022, 17252.13739313004, 17259.91370043192, 17539.824601754328, 17782.288708451517, 19862.304819331832, 20396.89801550983, 20785.1685932561, 21000.684989725472, 21002.264920727703, 20891.16435342569, 21073.473163171042, 21454.570908582053, 21512.462188445414, 21553.137874484844, 18990.43028709141, 19111.0, 19194.328198512983, 19256.326028588934, 19263.133159007597], "value": 12237.58200741206, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.1651459580467, 1368.8083668286442, 1384.4531410093011, 1396.4553824008644, 1402.0956483068421, 14875.851241487595, 15386.461473848418, 15491.845081549181, 15493.380264789423, 15516.379344826222, 14589.92705036476, 15147.318370673318, 15816.209189540506, 15863.0, 15866.444674436398, 2767.4326763013532, 2817.506936286152, 2817.647794025747, 2825.067727649881, 2843.5166021776245, 2678.812483126182, 2688.2607282997137, 2779.722027797224, 2782.1097248880365, 2791.7487426131643, 2765.3224959884856, 2776.4585905748386, 2785.7632101271415, 2799.230211691781, 2811.8031737778365, 2738.4933787249224, 2750.7386798254233, 2764.1292992707336, 2766.3775650478583, 2782.1097248880365, 2697.757201851823, 2713.7693296069856, 2737.192528204165, 2768.2525718056213, 2798.790090743182, 15122.470713524974, 15144.54566363011, 15223.923880380638, 15293.158876261801, 15307.923460382626, 7655.157932627407, 7736.34241089508, 7906.80232994174, 7916.445848790587, 7924.128345881948, 5250.238715386247, 5322.0, 5416.674999500043, 5541.889162216773, 5577.330720313547, 1893.848492120627, 1914.368258474714, 1916.5975145219381, 1940.8258003907574, 1950.1419375474889, 26218.34454138643, 26524.867375662998, 26547.0, 26616.866915665298, 27792.722072779216, 7222.313880181375, 7236.963815180996, 7355.0, 7446.478746487694, 7499.362554182846, 20345.796542034685, 20397.694034589495, 20408.693869591967, 20418.183272668928, 20465.89767051185, 8117.0, 8281.420300579022, 8281.8343633127, 8283.917160828436, 8292.087870334259, 7316.341529262286, 7348.154962179311, 7380.372668323253, 7525.172231054579, 7533.585652789039, 5542.946840100368, 5687.544996400361, 5712.942870571324, 5722.856928576735, 5751.568632352591, 1691.4249155287262, 1754.6227561074431, 1754.9034803085954, 1778.7865456145346, 1804.2138283099637, 868.2316150207113, 895.9328050396247, 906.8866391701038, 909.9762766887252, 910.3536489092686, 7358.816029599303, 7379.926200737924, 7474.0, 7479.663415146331, 7503.812404689927, 720.7909706185147, 726.5241266970143, 736.1497470421672, 741.4068745003975, 749.1871319618275, 4494.820207191741, 4502.5047244803045, 4506.504284528699, 4546.363509108727, 4569.908601827945, 21362.679559806616, 21403.57192856134, 21485.248016319354, 21655.67516487254, 21663.78336216649, 20301.187952482032, 21261.787382125982, 21897.38693115618, 21904.78095219059, 21906.23328183506, 9346.392484488486, 9645.08371704701, 11134.49894754738, 11467.139964502696, 11543.365114918592, 7879.251471110236, 8841.867371989296, 8970.923588968364, 9030.593623286837, 9134.77163070902, 18306.359277425225, 18809.341673041377, 18901.338453154072, 19220.71168932439, 19236.23055077837, 18738.625227495646, 18979.24083036663, 19077.427677169708, 19087.8091219086, 19394.70907936354, 10834.295770774874, 11034.448277586249, 11186.0, 11197.44012799373, 11231.38227397501, 13629.659258518219, 13844.238566878917, 13854.515091972136, 13855.930720346738, 13866.376013079638, 11182.88817111851, 11342.659720208407, 11373.431328433711, 11403.372814495282, 11463.484143213409, 10486.528106235086, 10692.411917344622, 10786.730331741455, 10832.295900766425, 10894.727631808952, 9258.259339252978, 9477.241820654193, 9614.423134611945, 9614.71155865325, 9620.278479113955, 7255.818604534928, 7280.890786638099, 7351.632418379167, 7360.711875421887, 7366.189719130784, 6914.274001229798, 6917.550359226634, 7071.398931090915, 7074.186468555976, 7076.681549330396], "value": 6687.0236768387085, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.2612572581168, 507.3075252280637, 529.161279372195, 530.8646295194725, 537.3820106877091, 6237.126802247689, 6240.594361366508, 6260.968695156524, 6287.811365659026, 6323.893318669226, 5940.346561878201, 6038.792241551696, 6081.48307393871, 6128.969355153229, 6134.693265336738, 4873.269009648546, 4944.728039957801, 4947.77735001924, 4955.231939049444, 4987.725675087869, 4842.201036828919, 4887.584555312803, 4904.386951631046, 4912.656114072016, 4929.0, 4730.0776348612035, 4862.0, 4863.489333619972, 4879.926801097969, 4922.286268491067, 4883.218685010382, 4891.9755401222765, 4909.656324057318, 4919.286703428001, 4920.286558449041, 4366.8034938427845, 4399.12017596482, 4400.691951563392, 4411.911761764747, 4424.557544245549, 6037.396260373927, 6112.572119951606, 6116.235470566179, 6135.723892424851, 6138.938610613882, 5609.419666953207, 5618.943810561883, 5626.777422917966, 5649.887002259973, 5671.404502527216, 6466.353364663543, 6467.902981455282, 6476.676166191672, 6498.967505162444, 6540.607563546155, 4728.361671174382, 4763.5471181289695, 4783.354247176621, 4802.567768900815, 4822.300766388854, 6854.828629284308, 6891.105735591063, 6914.0, 6928.0, 6948.131483564554, 4850.733209673432, 4886.926696099561, 4919.631027672939, 4925.916298414343, 4929.679570827885, 4918.385201849769, 4942.9258561121615, 4966.90066198674, 4981.227909674007, 5000.174971129795, 5563.0, 5575.60970732053, 5605.159226116034, 5605.663660180402, 5611.298587676541, 6439.452646525004, 6483.870322593521, 6527.792358413709, 6552.330694810921, 6604.900926486107, 1603.486884197069, 1681.2434404518017, 1684.3936182974119, 1698.853274040018, 1711.8801683882257, 1156.1675593572613, 1218.890299872998, 1221.908356873238, 1231.5381731850557, 1236.713817629655, 5770.403318506689, 5796.594238403356, 5801.098072129129, 5835.912461313083, 5862.618929769551, 6581.703823327962, 6617.154623511839, 6633.701483433257, 6679.76620818269, 6793.845046342035, 5892.793752218652, 5897.911531327033, 5898.262717160355, 5908.586398952118, 5914.940850591439, 3560.857565697343, 3574.767640103385, 3583.516225309602, 3596.777095787445, 3611.1694310308776, 6586.0, 6604.933950660432, 6637.800865974028, 6639.302873198341, 6640.535162538576, 6977.267386924402, 6991.440684745208, 7023.824404389931, 7026.435351096813, 7063.293670632998, 6572.0, 6601.438877695354, 6616.0, 6622.0, 6660.433863121592, 6811.876040453468, 6838.658067096725, 6842.418394436529, 6847.589144651337, 6847.965760171167, 6738.35985581369, 6742.460603151638, 6752.5948443093575, 6790.42281406086, 6825.010373495915, 6378.394052564999, 6423.871522569429, 6469.547131700736, 6488.480921526172, 6491.253505846888, 4790.065937142223, 4846.878828029327, 4857.716873069651, 4859.781309841136, 4865.56209941107, 6811.012403201607, 6812.216595091628, 6817.284185160685, 6877.2091209509545, 6908.3091690830515, 6451.806445806634, 6502.967485162544, 6527.9673601633585, 6566.409023187936, 6584.76953306632, 6411.551191416556, 6501.9674901625185, 6506.544541882212, 6522.804315870531, 6560.278369379269, 6248.875022499434, 6294.464970477561, 6320.209973753281, 6371.6814159290925, 6389.648569328731, 6365.1088847562305, 6368.630744389979, 6489.545731798918, 6490.545661803629, 6571.732752200483, 6167.55062560289, 6313.779017734541, 6323.430891219812, 6337.588056776295, 6375.234971803413], "value": 5031.526791929961, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.3706768194581, 890.5725251879098, 904.0913881549044, 904.1320332480818, 905.8550631898897, 19009.42971710849, 19990.800091999077, 19993.800061999376, 20019.099140538692, 20071.197152113935, 20415.28546500873, 20989.265375711853, 21519.462013449673, 21546.245881394156, 21861.12555497778, 954.3415043619915, 971.6502059258661, 974.0989584634185, 974.1135566634364, 975.2539307429787, 925.2320573923661, 980.6371642492288, 981.8723565936418, 984.0208992052917, 984.4437892590663, 1037.5953378182514, 1044.1229367331441, 1045.0594464981502, 1046.236247539293, 1047.7171163785774, 991.0386924683082, 1009.2430676992255, 1019.3781793106199, 1020.2042406922575, 1020.2297265564525, 735.2390276064248, 746.358132006474, 753.1564647594674, 753.2693287511105, 753.581762122022, 17467.126643667892, 18210.817891821043, 18298.81701182998, 18336.449906502825, 18453.7231941521, 19163.712544311846, 19524.316648917218, 19595.412137635893, 19636.90181549083, 20478.897605511876, 15879.36482540697, 16049.91975040129, 16163.838361616468, 16183.271752771036, 16188.75716864248, 3645.0, 3677.7425580209397, 3688.704903607732, 3689.4834723138783, 3691.8154092295276, 126916.36541817324, 129829.0, 130670.0, 131253.0, 132531.0, 15972.840271597368, 16067.357305707874, 16405.58986025359, 16485.670286594443, 16527.091009994325, 29539.556906646416, 30266.394672106875, 30412.69587304143, 30439.239019024702, 30479.23801904926, 7259.709611615476, 7529.849403011909, 8235.711750088838, 8550.615222315011, 8659.350548708871, 4051.736637118578, 4073.103917138225, 4136.524299705512, 4137.151883863861, 4151.750894946313, 5119.97440012805, 5164.302819119446, 5217.6347655664495, 5273.683578985273, 5276.683398996072, 1103.2112039891515, 1107.125370956935, 1115.6485707002269, 1117.201201141188, 1125.971850703739, 671.6272468779874, 690.0718533572337, 700.9579425234502, 715.7172916697875, 719.1909102259957, 11000.614978475714, 11140.275882067639, 11198.272112312674, 11501.942490287662, 12802.167859089315, 653.5980372071142, 665.2615596687673, 673.8989151627295, 679.1476696745552, 688.5214775730819, 5404.378496472956, 5447.319085114361, 5447.96488667152, 5531.976584331912, 5612.35457922336, 107269.0, 109135.0, 109503.45248273708, 110894.0, 115104.0, 91456.0, 93540.53229733808, 93928.53035734777, 98088.0, 100035.49982250042, 82685.17314826895, 84052.15947840565, 84250.0, 84934.0, 87471.12528874757, 11987.700307492383, 12049.51801927913, 12204.267743935392, 12296.430744068564, 12335.259884406963, 41455.0, 41718.374224386054, 42515.0, 43031.924201895206, 43312.133757325304, 53784.73107634437, 55633.0, 55997.72001139968, 56037.15944260921, 56959.0, 18254.81745182531, 18353.724694129865, 18532.444026679223, 18580.81419185791, 18888.33890813815, 17931.0, 18155.36456224026, 18202.90898545499, 18275.26898924028, 18348.90825545864, 17367.218475168902, 17462.30150793954, 17488.387906423723, 17514.649707006043, 17678.911605441892, 17728.379506717203, 17846.375376861746, 18036.89727881335, 18154.818451815314, 18274.360397386026, 17827.286908523514, 18137.455876323733, 18155.36456224026, 18380.724289135407, 18457.90771046136, 11343.829842552203, 11353.602623908124, 11652.883471165518, 11672.941635291769, 11764.0, 13185.637662396028, 13795.652152199675, 14143.292835357985, 14218.928905355408, 14322.57032289033], "value": 8937.86621477003, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1484.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 105.0, 109.0, 106.0, 113.0, 110.0, 101.0, 109.0, 110.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 116.0, 149.0, 171.0, 118.0, 141.0, 146.0, 120.0, 174.0, 118.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 164.0, 164.0, 162.0, 161.0, 162.0, 167.0, 173.0, 162.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 176.0, 75.0, 74.0, 77.0, 73.0, 156.0, 75.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 136.0, 78.0, 79.0, 79.0, 131.0, 80.0, 79.0, 129.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 115.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 149.0, 149.0, 147.0, 147.0, 147.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 53.0, 53.0, 54.0, 53.0, 53.0, 54.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 39.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 81.0, 79.0, 77.0, 75.0, 76.0, 74.0, 75.0, 74.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 123.0, 118.0, 118.0, 129.0, 119.0, 122.0, 119.0, 120.0, 159.0], "value": 124.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 169.0, 169.0, 169.0, 178.0, 163.0, 176.0, 165.0, 170.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 66.0, 71.0, 64.0, 63.0, 65.0, 62.0, 65.0, 63.0], "value": 65.1, "unit": "score"}]}]} 02:39:13 INFO - Return code: 0 02:39:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:39:13 INFO - # TBPL SUCCESS # 02:39:13 INFO - Running post-action listener: _package_coverage_data 02:39:13 INFO - Running post-action listener: _resource_record_post_action 02:39:13 INFO - [mozharness: 2017-09-01 09:39:13.539705Z] Finished run-tests step (success) 02:39:13 INFO - Running post-run listener: _resource_record_post_run 02:39:13 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 392085504; Read time: 172; Write time: 243572 02:39:13 INFO - TinderboxPrint: CPU usage
13.1% 02:39:13 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 172 02:39:13 INFO - TinderboxPrint: I/O write bytes / time
392,085,504 / 243,572 02:39:13 INFO - TinderboxPrint: CPU idle
8,251.5 (86.9%) 02:39:13 INFO - TinderboxPrint: CPU user
1,195.0 (12.6%) 02:39:13 INFO - TinderboxPrint: Swap in / out
0 / 0 02:39:13 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 108670976; Read time: 24; Write time: 74332 02:39:13 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:13 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283414528; Read time: 128; Write time: 169240 02:39:14 INFO - Running post-run listener: _upload_blobber_files 02:39:14 INFO - Blob upload gear active. 02:39:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:39:14 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:14 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:14 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:14 INFO - (blobuploader) - INFO - Open directory for files ... 02:39:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:39:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:39:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:15 INFO - (blobuploader) - INFO - Done attempting. 02:39:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:39:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:39:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:19 INFO - (blobuploader) - INFO - Done attempting. 02:39:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:39:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:39:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:20 INFO - (blobuploader) - INFO - Done attempting. 02:39:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:39:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:39:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:21 INFO - (blobuploader) - INFO - Done attempting. 02:39:21 INFO - (blobuploader) - INFO - Iteration through files over. 02:39:21 INFO - Return code: 0 02:39:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:39:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:39:21 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/beb7f44e598ed3b2cc5c083906d29a86e153efd5ea8d52b6600744d3eb2083bfafa2025c3c8275c89ec29aba591c45f9f2439bc4585153ea981fea7e3b27f246", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89685d4ad08356f76f4f1ef6e1ce93b2c95da464d5e54c3b274e5a9687496e2e180ac93103cd3020ce3f5bc4359595b7543075f10db76fde811fcba209028fe9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bfa403dca5ef8c2aebfe8d21f2a0b3d69b12415b558484bcde504f6bb5ece40ae773f075f02639c48e12b9888355a7ab585cb110897da6eb040457ebde2ce72", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a6df0d9e6ae8a0acdcb2b8bee0c661e6048c5dbe9e0b9a9fc3e6cba60a202962500720d75faf53733629b152c6433f90ff36f4fd40ac61a8d81a0ac1baef7ac"} 02:39:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:39:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:39:21 INFO - Contents: 02:39:21 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/beb7f44e598ed3b2cc5c083906d29a86e153efd5ea8d52b6600744d3eb2083bfafa2025c3c8275c89ec29aba591c45f9f2439bc4585153ea981fea7e3b27f246", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89685d4ad08356f76f4f1ef6e1ce93b2c95da464d5e54c3b274e5a9687496e2e180ac93103cd3020ce3f5bc4359595b7543075f10db76fde811fcba209028fe9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bfa403dca5ef8c2aebfe8d21f2a0b3d69b12415b558484bcde504f6bb5ece40ae773f075f02639c48e12b9888355a7ab585cb110897da6eb040457ebde2ce72", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a6df0d9e6ae8a0acdcb2b8bee0c661e6048c5dbe9e0b9a9fc3e6cba60a202962500720d75faf53733629b152c6433f90ff36f4fd40ac61a8d81a0ac1baef7ac"} 02:39:21 INFO - Running post-run listener: copy_logs_to_upload_dir 02:39:21 INFO - Copying logs to upload dir... 02:39:21 INFO - mkdir: /builds/slave/test/build/upload/logs 02:39:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.411270 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-09-01 02:39:21.178326) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 02:39:21.182267) ========= 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=0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699 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/beb7f44e598ed3b2cc5c083906d29a86e153efd5ea8d52b6600744d3eb2083bfafa2025c3c8275c89ec29aba591c45f9f2439bc4585153ea981fea7e3b27f246", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89685d4ad08356f76f4f1ef6e1ce93b2c95da464d5e54c3b274e5a9687496e2e180ac93103cd3020ce3f5bc4359595b7543075f10db76fde811fcba209028fe9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bfa403dca5ef8c2aebfe8d21f2a0b3d69b12415b558484bcde504f6bb5ece40ae773f075f02639c48e12b9888355a7ab585cb110897da6eb040457ebde2ce72", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a6df0d9e6ae8a0acdcb2b8bee0c661e6048c5dbe9e0b9a9fc3e6cba60a202962500720d75faf53733629b152c6433f90ff36f4fd40ac61a8d81a0ac1baef7ac"} build_url:https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011436 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/beb7f44e598ed3b2cc5c083906d29a86e153efd5ea8d52b6600744d3eb2083bfafa2025c3c8275c89ec29aba591c45f9f2439bc4585153ea981fea7e3b27f246", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89685d4ad08356f76f4f1ef6e1ce93b2c95da464d5e54c3b274e5a9687496e2e180ac93103cd3020ce3f5bc4359595b7543075f10db76fde811fcba209028fe9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bfa403dca5ef8c2aebfe8d21f2a0b3d69b12415b558484bcde504f6bb5ece40ae773f075f02639c48e12b9888355a7ab585cb110897da6eb040457ebde2ce72", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a6df0d9e6ae8a0acdcb2b8bee0c661e6048c5dbe9e0b9a9fc3e6cba60a202962500720d75faf53733629b152c6433f90ff36f4fd40ac61a8d81a0ac1baef7ac"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 02:39:21.214049) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:39:21.214488) ========= 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=0e2a256762fed810e2f0f810000001b3-1504254212.685832-409941699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:39:21.296966) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 02:39:21.297329) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 02:39:21.297736) ========= ========= Total master_lag: 0.21 =========