builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-040 starttime: 1506103465.8 results: success (0) revision: df744fbcedc4cb24d6f339a0027bfd8caaaf616a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 11:04:25.797351) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 11:04:25.797892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 11:04:25.798183) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 11:04:25.816736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:04:25.817138) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-22 11:04:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.9M=0s 2017-09-22 11:04:25 (34.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126215 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:04:25.961582) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:04:25.961934) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022772 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:04:26.014652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-22 11:04:26.015069) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev df744fbcedc4cb24d6f339a0027bfd8caaaf616a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev df744fbcedc4cb24d6f339a0027bfd8caaaf616a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-22 11:04:26,050 truncating revision to first 12 chars 2017-09-22 11:04:26,050 Setting DEBUG logging. 2017-09-22 11:04:26,050 attempt 1/10 2017-09-22 11:04:26,050 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/df744fbcedc4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-22 11:04:27,126 unpacking tar archive at: mozilla-beta-df744fbcedc4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.374768 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-22 11:04:27.414099) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 11:04:27.414503) ========= script_repo_revision: df744fbcedc4cb24d6f339a0027bfd8caaaf616a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 11:04:27.414915) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 11:04:27.415182) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 11:04:27.428848) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-09-22 11:04:27.429253) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:04:27 INFO - MultiFileLogger online at 20170922 11:04:27 in /builds/slave/test 11:04:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 11:04:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:04:27 INFO - {'append_to_log': False, 11:04:27 INFO - 'base_work_dir': '/builds/slave/test', 11:04:27 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 11:04:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:04:27 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 11:04:27 INFO - 'buildbot_json_path': 'buildprops.json', 11:04:27 INFO - 'code_coverage': False, 11:04:27 INFO - 'config_files': ('talos/linux_config.py',), 11:04:27 INFO - 'default_actions': ('clobber', 11:04:27 INFO - 'read-buildbot-config', 11:04:27 INFO - 'download-and-extract', 11:04:27 INFO - 'populate-webroot', 11:04:27 INFO - 'create-virtualenv', 11:04:27 INFO - 'install', 11:04:27 INFO - 'setup-mitmproxy', 11:04:27 INFO - 'run-tests'), 11:04:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:04:27 INFO - 'disable_ccov_upload': False, 11:04:27 INFO - 'disable_stylo': False, 11:04:27 INFO - 'download_minidump_stackwalk': True, 11:04:27 INFO - 'download_symbols': 'ondemand', 11:04:27 INFO - 'enable_stylo': False, 11:04:27 INFO - 'enable_webrender': False, 11:04:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:04:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:04:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:04:27 INFO - 'gecko_profile': False, 11:04:27 INFO - 'gecko_profile_interval': 0, 11:04:27 INFO - 'installer_path': 'installer.exe', 11:04:27 INFO - 'log_level': 'info', 11:04:27 INFO - 'log_name': 'talos', 11:04:27 INFO - 'log_to_console': True, 11:04:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:04:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:04:27 INFO - 'opt_config_files': (), 11:04:27 INFO - 'pip_index': False, 11:04:27 INFO - 'suite': 'dromaeojs-e10s', 11:04:27 INFO - 'system_bits': '32', 11:04:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:04:27 INFO - 'title': 'talos-linux64-ix-040', 11:04:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:04:27 INFO - 'use_talos_json': True, 11:04:27 INFO - 'verify': 'False', 11:04:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:04:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:04:27 INFO - 'work_dir': 'build'} 11:04:27 INFO - [mozharness: 2017-09-22 18:04:27.611325Z] Running clobber step. 11:04:27 INFO - Running pre-action listener: _resource_record_pre_action 11:04:27 INFO - Running main action method: clobber 11:04:27 INFO - rmtree: /builds/slave/test/build 11:04:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:04:28 INFO - Running post-action listener: _resource_record_post_action 11:04:28 INFO - [mozharness: 2017-09-22 18:04:28.609028Z] Finished clobber step (success) 11:04:28 INFO - [mozharness: 2017-09-22 18:04:28.609127Z] Running read-buildbot-config step. 11:04:28 INFO - Running pre-action listener: _resource_record_pre_action 11:04:28 INFO - Running main action method: read_buildbot_config 11:04:28 INFO - Using buildbot properties: 11:04:28 INFO - { 11:04:28 INFO - "project": "", 11:04:28 INFO - "product": "firefox", 11:04:28 INFO - "who": "ryanvm@gmail.com", 11:04:28 INFO - "installer_path": "public/build/target.tar.bz2", 11:04:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 11:04:28 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 11:04:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 11:04:28 INFO - "stage_platform": "linux64", 11:04:28 INFO - "basedir": "/builds/slave/test", 11:04:28 INFO - "buildnumber": 107, 11:04:28 INFO - "platform": "ubuntu64_hw", 11:04:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:04:28 INFO - "slavebuilddir": "test", 11:04:28 INFO - "taskId": "KzF0IVXzT5GGLiRBhMPHeg", 11:04:28 INFO - "branch": "mozilla-beta", 11:04:28 INFO - "script_repo_revision": "production", 11:04:28 INFO - "revision": "df744fbcedc4cb24d6f339a0027bfd8caaaf616a", 11:04:28 INFO - "slavename": "talos-linux64-ix-040", 11:04:28 INFO - "repo_path": "releases/mozilla-beta" 11:04:28 INFO - } 11:04:28 INFO - Finding installer, test and symbols from parent task. 11:04:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KzF0IVXzT5GGLiRBhMPHeg'}, attempt #1 11:04:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KzF0IVXzT5GGLiRBhMPHeg'}, attempt #1 11:04:29 INFO - Task dependencies: AZ65th0vQIiBXDGdF3v13Q 11:04:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q'}, attempt #1 11:04:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.tar.bz2 11:04:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.test_packages.json 11:04:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.crashreporter-symbols.zip 11:04:29 INFO - Running post-action listener: _resource_record_post_action 11:04:29 INFO - [mozharness: 2017-09-22 18:04:29.962147Z] Finished read-buildbot-config step (success) 11:04:29 INFO - [mozharness: 2017-09-22 18:04:29.962362Z] Running download-and-extract step. 11:04:29 INFO - Running pre-action listener: _resource_record_pre_action 11:04:29 INFO - Running main action method: download_and_extract 11:04:29 INFO - mkdir: /builds/slave/test/build/tests 11:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:29 INFO - trying https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.test_packages.json 11:04:29 INFO - Downloading https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:04:30 INFO - Downloaded 989 bytes. 11:04:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:04:30 INFO - Using the following test package requirements: 11:04:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:04:30 INFO - u'common': [u'target.common.tests.zip'], 11:04:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:04:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:04:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:04:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:04:30 INFO - u'mozbase': [u'target.common.tests.zip'], 11:04:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:04:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:04:30 INFO - u'web-platform': [u'target.common.tests.zip', 11:04:30 INFO - u'target.web-platform.tests.tar.gz'], 11:04:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:04:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:04:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.common.tests.zip 11:04:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:04:30 INFO - Fetch https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.common.tests.zip into memory 11:04:32 INFO - Content-Length response header: 55178587 11:04:32 INFO - Bytes received: 55178587 11:04:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.talos.tests.zip 11:04:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:04:43 INFO - Fetch https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.talos.tests.zip into memory 11:04:45 INFO - Content-Length response header: 14509184 11:04:45 INFO - Bytes received: 14509184 11:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:45 INFO - trying https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.tar.bz2 11:04:45 INFO - Downloading https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:04:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:04:47 INFO - Downloaded 53450225 bytes. 11:04:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.tar.bz2 11:04:47 INFO - mkdir: /builds/slave/test/properties 11:04:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:04:47 INFO - Writing to file /builds/slave/test/properties/build_url 11:04:47 INFO - Contents: 11:04:47 INFO - build_url:https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.tar.bz2 11:04:47 INFO - Running post-action listener: _resource_record_post_action 11:04:47 INFO - Running post-action listener: find_tests_for_verification 11:04:47 INFO - Running post-action listener: set_extra_try_arguments 11:04:47 INFO - [mozharness: 2017-09-22 18:04:47.462153Z] Finished download-and-extract step (success) 11:04:47 INFO - [mozharness: 2017-09-22 18:04:47.462329Z] Running populate-webroot step. 11:04:47 INFO - Running pre-action listener: _resource_record_pre_action 11:04:47 INFO - Running main action method: populate_webroot 11:04:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:04:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:04:47 INFO - 'tests': ['tresize', 11:04:47 INFO - 'tcanvasmark']}, 11:04:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:04:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:04:47 INFO - 'tests': ['dromaeo_css', 11:04:47 INFO - 'kraken']}, 11:04:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:04:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:04:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:04:47 INFO - 'talos_options': ['--disable-stylo'], 11:04:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:04:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:04:47 INFO - 'tests': ['damp', 'tps']}, 11:04:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:04:47 INFO - 'talos_options': ['--disable-stylo'], 11:04:47 INFO - 'tests': ['damp', 'tps']}, 11:04:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:04:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:04:47 INFO - 'tests': ['dromaeo_dom']}, 11:04:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:04:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:04:47 INFO - 'tests': ['basic_compositor_video', 11:04:47 INFO - 'glvideo']}, 11:04:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:04:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:04:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:04:47 INFO - 'talos_options': ['--disable-stylo'], 11:04:47 INFO - 'tests': ['ts_paint_webext', 11:04:47 INFO - 'tp5o_webext']}, 11:04:47 INFO - 'other-e10s': {'tests': ['a11yr', 11:04:47 INFO - 'ts_paint', 11:04:47 INFO - 'tpaint', 11:04:47 INFO - 'sessionrestore', 11:04:47 INFO - 'sessionrestore_many_windows', 11:04:47 INFO - 'sessionrestore_no_auto_restore', 11:04:47 INFO - 'tabpaint']}, 11:04:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:04:47 INFO - 'tests': ['a11yr', 11:04:47 INFO - 'ts_paint', 11:04:47 INFO - 'tpaint', 11:04:47 INFO - 'sessionrestore', 11:04:47 INFO - 'sessionrestore_many_windows', 11:04:47 INFO - 'sessionrestore_no_auto_restore', 11:04:47 INFO - 'tabpaint']}, 11:04:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:04:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:04:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:04:47 INFO - 'tests': ['perf_reftest_singletons']}, 11:04:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:04:47 INFO - 'tests': ['bloom_basic']}, 11:04:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:04:47 INFO - 'tsvgr_opacity', 11:04:47 INFO - 'tart', 11:04:47 INFO - 'tscrollx', 11:04:47 INFO - 'tsvg_static']}, 11:04:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:04:47 INFO - 'tests': ['tsvgx', 11:04:47 INFO - 'tsvgr_opacity', 11:04:47 INFO - 'tart', 11:04:47 INFO - 'tscrollx', 11:04:47 INFO - 'tsvg_static']}, 11:04:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:04:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:04:47 INFO - 'talos_options': ['--disable-stylo'], 11:04:47 INFO - 'tests': ['tp5o']}, 11:04:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:04:47 INFO - 'talos_options': ['--mitmproxy', 11:04:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:04:47 INFO - '--firstNonBlankPaint'], 11:04:47 INFO - 'tests': ['tp6_google', 11:04:47 INFO - 'tp6_youtube', 11:04:47 INFO - 'tp6_amazon', 11:04:47 INFO - 'tp6_facebook']}, 11:04:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:04:47 INFO - 'talos_options': ['--disable-stylo', 11:04:47 INFO - '--mitmproxy', 11:04:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:04:47 INFO - '--firstNonBlankPaint'], 11:04:47 INFO - 'tests': ['tp6_google', 11:04:47 INFO - 'tp6_youtube', 11:04:47 INFO - 'tp6_amazon', 11:04:47 INFO - 'tp6_facebook']}, 11:04:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:04:47 INFO - 'talos_options': ['--stylo-threads=1', 11:04:47 INFO - '--mitmproxy', 11:04:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:04:47 INFO - '--firstNonBlankPaint'], 11:04:47 INFO - 'tests': ['tp6_google', 11:04:47 INFO - 'tp6_youtube', 11:04:47 INFO - 'tp6_amazon', 11:04:47 INFO - 'tp6_facebook']}, 11:04:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:04:47 INFO - 'talos_options': ['--xperf_path', 11:04:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:04:47 INFO - 'tests': ['tp5n']}, 11:04:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:04:47 INFO - 'talos_options': ['--disable-stylo', 11:04:47 INFO - '--xperf_path', 11:04:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:04:47 INFO - 'tests': ['tp5n']}}} 11:04:47 INFO - Running post-action listener: _resource_record_post_action 11:04:47 INFO - [mozharness: 2017-09-22 18:04:47.480827Z] Finished populate-webroot step (success) 11:04:47 INFO - [mozharness: 2017-09-22 18:04:47.480916Z] Running create-virtualenv step. 11:04:47 INFO - Running pre-action listener: _resource_record_pre_action 11:04:47 INFO - Running main action method: create_virtualenv 11:04:47 INFO - Creating virtualenv /builds/slave/test/build/venv 11:04:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:04:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:04:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:04:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:04:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:04:48 INFO - Installing distribute.............................................................................................................................................................................................done. 11:04:48 INFO - Installing pip...............done. 11:04:48 INFO - Return code: 0 11:04:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:04:48 INFO - Reading from file tmpfile_stdout 11:04:48 INFO - Output received: 11:04:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:04:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:48 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 0x18bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a090>, '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 0x1c2ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:04:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:04:48 INFO - Using env: {'DISPLAY': ':0', 11:04:48 INFO - 'HOME': '/home/cltbld', 11:04:48 INFO - 'LANG': 'en_US.UTF-8', 11:04:48 INFO - 'LANGUAGE': 'en_US:en', 11:04:48 INFO - 'LOGNAME': 'cltbld', 11:04:48 INFO - 'MAIL': '/var/mail/cltbld', 11:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:48 INFO - 'MOZ_NO_REMOTE': '1', 11:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:48 INFO - 'NO_EM_RESTART': '1', 11:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:48 INFO - 'PWD': '/builds/slave/test', 11:04:48 INFO - 'SHELL': '/bin/bash', 11:04:48 INFO - 'SHLVL': '1', 11:04:48 INFO - 'TERM': 'linux', 11:04:48 INFO - 'TMOUT': '86400', 11:04:48 INFO - 'USER': 'cltbld', 11:04:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 11:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:48 INFO - '_': '/tools/buildbot/bin/python'} 11:04:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:04:49 INFO - Downloading/unpacking pip>=1.5 11:04:49 INFO - Running setup.py egg_info for package pip 11:04:49 INFO - warning: no files found matching 'pip/cacert.pem' 11:04:49 INFO - warning: no files found matching '*.html' under directory 'docs' 11:04:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:04:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:04:49 INFO - Installing collected packages: pip 11:04:49 INFO - Found existing installation: pip 1.1 11:04:49 INFO - Uninstalling pip: 11:04:49 INFO - Successfully uninstalled pip 11:04:49 INFO - Running setup.py install for pip 11:04:49 INFO - warning: no files found matching 'pip/cacert.pem' 11:04:49 INFO - warning: no files found matching '*.html' under directory 'docs' 11:04:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:04:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:04:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:04:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:04:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:04:49 INFO - Successfully installed pip 11:04:49 INFO - Cleaning up... 11:04:49 INFO - Return code: 0 11:04:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a090>, '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 0x1c2ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:04:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:04:49 INFO - Using env: {'DISPLAY': ':0', 11:04:49 INFO - 'HOME': '/home/cltbld', 11:04:49 INFO - 'LANG': 'en_US.UTF-8', 11:04:49 INFO - 'LANGUAGE': 'en_US:en', 11:04:49 INFO - 'LOGNAME': 'cltbld', 11:04:49 INFO - 'MAIL': '/var/mail/cltbld', 11:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:49 INFO - 'MOZ_NO_REMOTE': '1', 11:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:49 INFO - 'NO_EM_RESTART': '1', 11:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:49 INFO - 'PWD': '/builds/slave/test', 11:04:49 INFO - 'SHELL': '/bin/bash', 11:04:49 INFO - 'SHLVL': '1', 11:04:49 INFO - 'TERM': 'linux', 11:04:49 INFO - 'TMOUT': '86400', 11:04:49 INFO - 'USER': 'cltbld', 11:04:49 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 11:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:49 INFO - '_': '/tools/buildbot/bin/python'} 11:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:49 INFO - Downloading/unpacking psutil>=3.1.1 11:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:04:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:04:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:04:51 INFO - Installing collected packages: psutil 11:04:51 INFO - Running setup.py install for psutil 11:04:51 INFO - building 'psutil._psutil_linux' extension 11:04:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:04:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:04:51 INFO - building 'psutil._psutil_posix' extension 11:04:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:04:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:04:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:04:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:04:51 INFO - Successfully installed psutil 11:04:51 INFO - Cleaning up... 11:04:51 INFO - Return code: 0 11:04:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a090>, '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 0x1c2ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:04:51 INFO - Using env: {'DISPLAY': ':0', 11:04:51 INFO - 'HOME': '/home/cltbld', 11:04:51 INFO - 'LANG': 'en_US.UTF-8', 11:04:51 INFO - 'LANGUAGE': 'en_US:en', 11:04:51 INFO - 'LOGNAME': 'cltbld', 11:04:51 INFO - 'MAIL': '/var/mail/cltbld', 11:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:51 INFO - 'MOZ_NO_REMOTE': '1', 11:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:51 INFO - 'NO_EM_RESTART': '1', 11:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:51 INFO - 'PWD': '/builds/slave/test', 11:04:51 INFO - 'SHELL': '/bin/bash', 11:04:51 INFO - 'SHLVL': '1', 11:04:51 INFO - 'TERM': 'linux', 11:04:51 INFO - 'TMOUT': '86400', 11:04:51 INFO - 'USER': 'cltbld', 11:04:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 11:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:51 INFO - '_': '/tools/buildbot/bin/python'} 11:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:04:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:04:53 INFO - Installing collected packages: mozsystemmonitor 11:04:53 INFO - Running setup.py install for mozsystemmonitor 11:04:53 INFO - Successfully installed mozsystemmonitor 11:04:53 INFO - Cleaning up... 11:04:54 INFO - Return code: 0 11:04:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a090>, '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 0x1c2ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:04:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:04:54 INFO - Using env: {'DISPLAY': ':0', 11:04:54 INFO - 'HOME': '/home/cltbld', 11:04:54 INFO - 'LANG': 'en_US.UTF-8', 11:04:54 INFO - 'LANGUAGE': 'en_US:en', 11:04:54 INFO - 'LOGNAME': 'cltbld', 11:04:54 INFO - 'MAIL': '/var/mail/cltbld', 11:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:54 INFO - 'MOZ_NO_REMOTE': '1', 11:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:54 INFO - 'NO_EM_RESTART': '1', 11:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:54 INFO - 'PWD': '/builds/slave/test', 11:04:54 INFO - 'SHELL': '/bin/bash', 11:04:54 INFO - 'SHLVL': '1', 11:04:54 INFO - 'TERM': 'linux', 11:04:54 INFO - 'TMOUT': '86400', 11:04:54 INFO - 'USER': 'cltbld', 11:04:54 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 11:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:54 INFO - '_': '/tools/buildbot/bin/python'} 11:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:54 INFO - Downloading/unpacking jsonschema==2.5.1 11:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:04:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:55 INFO - Downloading functools32-3.2.3-2.tar.gz 11:04:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:04:55 INFO - warning: no files found matching '*.txt' 11:04:55 INFO - no previously-included directories found matching 'build' 11:04:55 INFO - no previously-included directories found matching 'dist' 11:04:55 INFO - no previously-included directories found matching '.git*' 11:04:55 INFO - Installing collected packages: jsonschema, functools32 11:04:55 INFO - Running setup.py install for functools32 11:04:55 INFO - warning: no files found matching '*.txt' 11:04:55 INFO - no previously-included directories found matching 'build' 11:04:55 INFO - no previously-included directories found matching 'dist' 11:04:55 INFO - no previously-included directories found matching '.git*' 11:04:55 INFO - Successfully installed jsonschema functools32 11:04:55 INFO - Cleaning up... 11:04:56 INFO - Return code: 0 11:04:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a090>, '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 0x1c2ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:04:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:04:56 INFO - Using env: {'DISPLAY': ':0', 11:04:56 INFO - 'HOME': '/home/cltbld', 11:04:56 INFO - 'LANG': 'en_US.UTF-8', 11:04:56 INFO - 'LANGUAGE': 'en_US:en', 11:04:56 INFO - 'LOGNAME': 'cltbld', 11:04:56 INFO - 'MAIL': '/var/mail/cltbld', 11:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:56 INFO - 'MOZ_NO_REMOTE': '1', 11:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:56 INFO - 'NO_EM_RESTART': '1', 11:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:56 INFO - 'PWD': '/builds/slave/test', 11:04:56 INFO - 'SHELL': '/bin/bash', 11:04:56 INFO - 'SHLVL': '1', 11:04:56 INFO - 'TERM': 'linux', 11:04:56 INFO - 'TMOUT': '86400', 11:04:56 INFO - 'USER': 'cltbld', 11:04:56 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 11:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:56 INFO - '_': '/tools/buildbot/bin/python'} 11:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:04:56 INFO - Cleaning up... 11:04:56 INFO - Return code: 0 11:04:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a090>, '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 0x1c2ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:04:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:04:56 INFO - Using env: {'DISPLAY': ':0', 11:04:56 INFO - 'HOME': '/home/cltbld', 11:04:56 INFO - 'LANG': 'en_US.UTF-8', 11:04:56 INFO - 'LANGUAGE': 'en_US:en', 11:04:56 INFO - 'LOGNAME': 'cltbld', 11:04:56 INFO - 'MAIL': '/var/mail/cltbld', 11:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:56 INFO - 'MOZ_NO_REMOTE': '1', 11:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:56 INFO - 'NO_EM_RESTART': '1', 11:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:56 INFO - 'PWD': '/builds/slave/test', 11:04:56 INFO - 'SHELL': '/bin/bash', 11:04:56 INFO - 'SHLVL': '1', 11:04:56 INFO - 'TERM': 'linux', 11:04:56 INFO - 'TMOUT': '86400', 11:04:56 INFO - 'USER': 'cltbld', 11:04:56 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 11:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:56 INFO - '_': '/tools/buildbot/bin/python'} 11:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:57 INFO - Downloading/unpacking blobuploader==1.2.4 11:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:58 INFO - Downloading blobuploader-1.2.4.tar.gz 11:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:04:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:04:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:58 INFO - Downloading docopt-0.6.1.tar.gz 11:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:04:58 INFO - Installing collected packages: blobuploader, requests, docopt 11:04:58 INFO - Running setup.py install for blobuploader 11:04:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:04:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:04:59 INFO - Running setup.py install for requests 11:04:59 INFO - Running setup.py install for docopt 11:04:59 INFO - Successfully installed blobuploader requests docopt 11:04:59 INFO - Cleaning up... 11:04:59 INFO - Return code: 0 11:04:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a090>, '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 0x1c2ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:04:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:04:59 INFO - Using env: {'DISPLAY': ':0', 11:04:59 INFO - 'HOME': '/home/cltbld', 11:04:59 INFO - 'LANG': 'en_US.UTF-8', 11:04:59 INFO - 'LANGUAGE': 'en_US:en', 11:04:59 INFO - 'LOGNAME': 'cltbld', 11:04:59 INFO - 'MAIL': '/var/mail/cltbld', 11:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:59 INFO - 'MOZ_NO_REMOTE': '1', 11:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:59 INFO - 'NO_EM_RESTART': '1', 11:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:59 INFO - 'PWD': '/builds/slave/test', 11:04:59 INFO - 'SHELL': '/bin/bash', 11:04:59 INFO - 'SHLVL': '1', 11:04:59 INFO - 'TERM': 'linux', 11:04:59 INFO - 'TMOUT': '86400', 11:04:59 INFO - 'USER': 'cltbld', 11:04:59 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 11:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:59 INFO - '_': '/tools/buildbot/bin/python'} 11:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:04:59 INFO - Running setup.py (path:/tmp/pip-v801Bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:04:59 INFO - Running setup.py (path:/tmp/pip-lcOhfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:04:59 INFO - Running setup.py (path:/tmp/pip-5uqqE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:04:59 INFO - Running setup.py (path:/tmp/pip-UD4wRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:00 INFO - Running setup.py (path:/tmp/pip-V3NIw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:00 INFO - Running setup.py (path:/tmp/pip-qjGodG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:00 INFO - Running setup.py (path:/tmp/pip-8uXHhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:00 INFO - Running setup.py (path:/tmp/pip-0rqYuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:00 INFO - Running setup.py (path:/tmp/pip-kq1v_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:00 INFO - Running setup.py (path:/tmp/pip-4aIytQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:00 INFO - Running setup.py (path:/tmp/pip-ddf2Fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:00 INFO - Running setup.py (path:/tmp/pip-SL23EJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:00 INFO - Running setup.py (path:/tmp/pip-aMeN5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:00 INFO - Running setup.py (path:/tmp/pip-mmaj7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:00 INFO - Running setup.py (path:/tmp/pip-Id47Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:00 INFO - Running setup.py (path:/tmp/pip-1YafqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:00 INFO - Running setup.py (path:/tmp/pip-nfz3Fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:05:00 INFO - Running setup.py install for manifestparser 11:05:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:05:01 INFO - Running setup.py install for mozcrash 11:05:01 INFO - Running setup.py install for mozdebug 11:05:01 INFO - Running setup.py install for mozdevice 11:05:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:05:01 INFO - Running setup.py install for mozfile 11:05:01 INFO - Running setup.py install for mozhttpd 11:05:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:05:01 INFO - Running setup.py install for mozinfo 11:05:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:05:01 INFO - Running setup.py install for mozInstall 11:05:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:05:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:05:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:05:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:05:01 INFO - Running setup.py install for mozleak 11:05:01 INFO - Running setup.py install for mozlog 11:05:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:05:01 INFO - Running setup.py install for moznetwork 11:05:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:05:02 INFO - Running setup.py install for mozprocess 11:05:02 INFO - Running setup.py install for mozprofile 11:05:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:05:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:05:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:05:02 INFO - Running setup.py install for mozrunner 11:05:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:05:02 INFO - Running setup.py install for mozscreenshot 11:05:02 INFO - Running setup.py install for moztest 11:05:02 INFO - Running setup.py install for mozversion 11:05:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:05:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:05:02 INFO - Cleaning up... 11:05:02 INFO - Return code: 0 11:05:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a090>, '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 0x1c2ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:05:02 INFO - Using env: {'DISPLAY': ':0', 11:05:02 INFO - 'HOME': '/home/cltbld', 11:05:02 INFO - 'LANG': 'en_US.UTF-8', 11:05:02 INFO - 'LANGUAGE': 'en_US:en', 11:05:02 INFO - 'LOGNAME': 'cltbld', 11:05:02 INFO - 'MAIL': '/var/mail/cltbld', 11:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:02 INFO - 'MOZ_NO_REMOTE': '1', 11:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:02 INFO - 'NO_EM_RESTART': '1', 11:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:02 INFO - 'PWD': '/builds/slave/test', 11:05:02 INFO - 'SHELL': '/bin/bash', 11:05:02 INFO - 'SHLVL': '1', 11:05:02 INFO - 'TERM': 'linux', 11:05:02 INFO - 'TMOUT': '86400', 11:05:02 INFO - 'USER': 'cltbld', 11:05:02 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 11:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:02 INFO - '_': '/tools/buildbot/bin/python'} 11:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:02 INFO - Running setup.py (path:/tmp/pip-2MedTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:03 INFO - Running setup.py (path:/tmp/pip-VW1VUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:03 INFO - Running setup.py (path:/tmp/pip-iZLC8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:03 INFO - Running setup.py (path:/tmp/pip-6FZgTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:03 INFO - Running setup.py (path:/tmp/pip-taze42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:03 INFO - Running setup.py (path:/tmp/pip-duD4Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:03 INFO - Running setup.py (path:/tmp/pip-WSxnzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:03 INFO - Running setup.py (path:/tmp/pip-iGZXXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:03 INFO - Running setup.py (path:/tmp/pip-F0_PTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:03 INFO - Running setup.py (path:/tmp/pip-e2o9uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:03 INFO - Running setup.py (path:/tmp/pip-71A_3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:03 INFO - Running setup.py (path:/tmp/pip-ai99EK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:03 INFO - Running setup.py (path:/tmp/pip-EIYJMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:03 INFO - Running setup.py (path:/tmp/pip-9BEx34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:03 INFO - Running setup.py (path:/tmp/pip-q8VT1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:04 INFO - Running setup.py (path:/tmp/pip-g71_nE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:04 INFO - Running setup.py (path:/tmp/pip-ak6Mow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:05:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:05 INFO - Downloading blessings-1.6.tar.gz 11:05:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:05:05 INFO - Installing collected packages: blessings 11:05:05 INFO - Running setup.py install for blessings 11:05:05 INFO - Successfully installed blessings 11:05:05 INFO - Cleaning up... 11:05:05 INFO - Return code: 0 11:05:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:05:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:05:05 INFO - Reading from file tmpfile_stdout 11:05:05 INFO - Current package versions: 11:05:05 INFO - argparse == 1.2.1 11:05:05 INFO - blessings == 1.6 11:05:05 INFO - blobuploader == 1.2.4 11:05:05 INFO - docopt == 0.6.1 11:05:05 INFO - functools32 == 3.2.3-2 11:05:05 INFO - jsonschema == 2.5.1 11:05:05 INFO - manifestparser == 1.1 11:05:05 INFO - mozInstall == 1.13 11:05:05 INFO - mozcrash == 1.0 11:05:05 INFO - mozdebug == 0.1 11:05:05 INFO - mozdevice == 0.51 11:05:05 INFO - mozfile == 1.2 11:05:05 INFO - mozhttpd == 0.7 11:05:05 INFO - mozinfo == 0.10 11:05:05 INFO - mozleak == 0.1 11:05:05 INFO - mozlog == 3.5 11:05:05 INFO - moznetwork == 0.27 11:05:05 INFO - mozprocess == 0.25 11:05:05 INFO - mozprofile == 0.28 11:05:05 INFO - mozrunner == 6.13 11:05:05 INFO - mozscreenshot == 0.1 11:05:05 INFO - mozsystemmonitor == 0.3 11:05:05 INFO - moztest == 0.8 11:05:05 INFO - mozversion == 1.4 11:05:05 INFO - psutil == 3.1.1 11:05:05 INFO - requests == 1.2.3 11:05:05 INFO - wsgiref == 0.1.2 11:05:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a090>, '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 0x1c2ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:05:05 INFO - Using env: {'DISPLAY': ':0', 11:05:05 INFO - 'HOME': '/home/cltbld', 11:05:05 INFO - 'LANG': 'en_US.UTF-8', 11:05:05 INFO - 'LANGUAGE': 'en_US:en', 11:05:05 INFO - 'LOGNAME': 'cltbld', 11:05:05 INFO - 'MAIL': '/var/mail/cltbld', 11:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:05 INFO - 'MOZ_NO_REMOTE': '1', 11:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:05 INFO - 'NO_EM_RESTART': '1', 11:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:05 INFO - 'PWD': '/builds/slave/test', 11:05:05 INFO - 'SHELL': '/bin/bash', 11:05:05 INFO - 'SHLVL': '1', 11:05:05 INFO - 'TERM': 'linux', 11:05:05 INFO - 'TMOUT': '86400', 11:05:05 INFO - 'USER': 'cltbld', 11:05:05 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 11:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:05 INFO - '_': '/tools/buildbot/bin/python'} 11:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:05:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:05:07 INFO - Installing collected packages: simplejson 11:05:07 INFO - Running setup.py install for simplejson 11:05:07 INFO - building 'simplejson._speedups' extension 11:05:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:05:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:05:08 INFO - Successfully installed simplejson 11:05:08 INFO - Cleaning up... 11:05:08 INFO - Return code: 0 11:05:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a090>, '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 0x1c2ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05: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'] in /builds/slave/test/build 11:05: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 11:05:08 INFO - Using env: {'DISPLAY': ':0', 11:05:08 INFO - 'HOME': '/home/cltbld', 11:05:08 INFO - 'LANG': 'en_US.UTF-8', 11:05:08 INFO - 'LANGUAGE': 'en_US:en', 11:05:08 INFO - 'LOGNAME': 'cltbld', 11:05:08 INFO - 'MAIL': '/var/mail/cltbld', 11:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:08 INFO - 'MOZ_NO_REMOTE': '1', 11:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:08 INFO - 'NO_EM_RESTART': '1', 11:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:08 INFO - 'PWD': '/builds/slave/test', 11:05:08 INFO - 'SHELL': '/bin/bash', 11:05:08 INFO - 'SHLVL': '1', 11:05:08 INFO - 'TERM': 'linux', 11:05:08 INFO - 'TMOUT': '86400', 11:05:08 INFO - 'USER': 'cltbld', 11:05:08 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 11:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:08 INFO - '_': '/tools/buildbot/bin/python'} 11:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:05:08 INFO - Cleaning up... 11:05:08 INFO - Return code: 0 11:05:08 INFO - Running post-action listener: _resource_record_post_action 11:05:08 INFO - Running post-action listener: _start_resource_monitoring 11:05:08 INFO - Starting resource monitoring. 11:05:08 INFO - [mozharness: 2017-09-22 18:05:08.423687Z] Finished create-virtualenv step (success) 11:05:08 INFO - [mozharness: 2017-09-22 18:05:08.424205Z] Running install step. 11:05:08 INFO - Running pre-action listener: _resource_record_pre_action 11:05:08 INFO - Running main action method: install 11:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:05:08 INFO - Reading from file tmpfile_stdout 11:05:08 INFO - Detecting whether we're running mozinstall >=1.0... 11:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:05:08 INFO - Reading from file tmpfile_stdout 11:05:08 INFO - Output received: 11:05:08 INFO - Usage: mozinstall [options] installer 11:05:08 INFO - Options: 11:05:08 INFO - -h, --help show this help message and exit 11:05:08 INFO - -d DEST, --destination=DEST 11:05:08 INFO - Directory to install application into. [default: 11:05:08 INFO - "/builds/slave/test"] 11:05:08 INFO - --app=APP Application being installed. [default: firefox] 11:05:08 INFO - mkdir: /builds/slave/test/build/application 11:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:05:23 INFO - Reading from file tmpfile_stdout 11:05:23 INFO - Output received: 11:05:23 INFO - /builds/slave/test/build/application/firefox/firefox 11:05:23 INFO - Running post-action listener: _resource_record_post_action 11:05:23 INFO - [mozharness: 2017-09-22 18:05:23.327893Z] Finished install step (success) 11:05:23 INFO - [mozharness: 2017-09-22 18:05:23.328040Z] Running setup-mitmproxy step. 11:05:23 INFO - Running pre-action listener: _resource_record_pre_action 11:05:23 INFO - Running main action method: setup_mitmproxy 11:05:23 INFO - Skipping: mitmproxy is not required 11:05:23 INFO - Running post-action listener: _resource_record_post_action 11:05:23 INFO - [mozharness: 2017-09-22 18:05:23.328575Z] Finished setup-mitmproxy step (success) 11:05:23 INFO - [mozharness: 2017-09-22 18:05:23.328678Z] Running run-tests step. 11:05:23 INFO - Running pre-action listener: _resource_record_pre_action 11:05:23 INFO - Running pre-action listener: _set_gcov_prefix 11:05:23 INFO - Running main action method: run_tests 11:05:23 WARNING - Try message not found. 11:05:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:05:23 INFO - Python 2.7.3 11:05:23 INFO - Return code: 0 11:05:23 INFO - grabbing minidump binary from tooltool 11:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:23 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 0x1c2a090>, '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 0x1c2ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:05:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:05:23 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:05:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:05:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:05:23 INFO - Return code: 0 11:05:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:05:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:05:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:05:23 INFO - ENV: RUST_BACKTRACE is now full 11:05:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:05:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:05:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:05:23 INFO - Using env: {'DISPLAY': ':0', 11:05:23 INFO - 'HOME': '/home/cltbld', 11:05:23 INFO - 'LANG': 'en_US.UTF-8', 11:05:23 INFO - 'LANGUAGE': 'en_US:en', 11:05:23 INFO - 'LOGNAME': 'cltbld', 11:05:23 INFO - 'MAIL': '/var/mail/cltbld', 11:05:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:05:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:23 INFO - 'MOZ_NO_REMOTE': '1', 11:05:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:23 INFO - 'NO_EM_RESTART': '1', 11:05:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:23 INFO - 'PWD': '/builds/slave/test', 11:05:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:05:23 INFO - 'RUST_BACKTRACE': 'full', 11:05:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:05:23 INFO - 'SHELL': '/bin/bash', 11:05:23 INFO - 'SHLVL': '1', 11:05:23 INFO - 'TERM': 'linux', 11:05:23 INFO - 'TMOUT': '86400', 11:05:23 INFO - 'USER': 'cltbld', 11:05:23 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 11:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:23 INFO - '_': '/tools/buildbot/bin/python'} 11:05:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:05:23 INFO - mozversion application_buildid: 20170922164243 11:05:23 INFO - mozversion application_changeset: df744fbcedc4cb24d6f339a0027bfd8caaaf616a 11:05:23 INFO - mozversion application_display_name: Firefox 11:05:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:05:23 INFO - mozversion application_name: Firefox 11:05:23 INFO - mozversion application_remotingname: firefox 11:05:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:05:23 INFO - mozversion application_vendor: Mozilla 11:05:23 INFO - mozversion application_version: 57.0 11:05:23 INFO - mozversion platform_buildid: 20170922164243 11:05:23 INFO - mozversion platform_changeset: df744fbcedc4cb24d6f339a0027bfd8caaaf616a 11:05:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:05:23 INFO - mozversion platform_version: 57.0 11:05:23 INFO - using testdate: 1506103523 11:05:23 INFO - actual date: 1506103523 11:05:23 INFO - starting webserver on 'localhost:40388' 11:05:23 INFO - SUITE-START | Running 2 tests 11:05:23 INFO - TEST-START | dromaeo_css 11:05:23 INFO - Initialising browser for dromaeo_css test... 11:05:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40388/getInfo.html -profile /tmp/tmpZXnz2H/profile 11:05:23 INFO - TEST-INFO | started process 29067 (/builds/slave/test/build/application/firefox/firefox http://localhost:40388/getInfo.html) 11:05:28 INFO - TEST-INFO | 29067: exit 0 11:05:28 INFO - Browser initialized. 11:05:28 INFO - Running cycle 1/1 for dromaeo_css test... 11:05:28 INFO - Using env: {'DISPLAY': ':0', 11:05:28 INFO - 'HOME': '/home/cltbld', 11:05:28 INFO - 'JSGC_DISABLE_POISONING': '1', 11:05:28 INFO - 'LANG': 'en_US.UTF-8', 11:05:28 INFO - 'LANGUAGE': 'en_US:en', 11:05:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:05:28 INFO - 'LOGNAME': 'cltbld', 11:05:28 INFO - 'MAIL': '/var/mail/cltbld', 11:05:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:05:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:05:28 INFO - 'MOZ_CRASHREPORTER': '1', 11:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:05:28 INFO - 'MOZ_NO_REMOTE': '1', 11:05:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:28 INFO - 'NO_EM_RESTART': '1', 11:05:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:28 INFO - 'PWD': '/builds/slave/test', 11:05:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:05:28 INFO - 'RUST_BACKTRACE': 'full', 11:05:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:05:28 INFO - 'SHELL': '/bin/bash', 11:05:28 INFO - 'SHLVL': '1', 11:05:28 INFO - 'TERM': 'linux', 11:05:28 INFO - 'TMOUT': '86400', 11:05:28 INFO - 'USER': 'cltbld', 11:05:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 11:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:28 INFO - '_': '/tools/buildbot/bin/python'} 11:05:28 INFO - TEST-INFO | started process 29252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZXnz2H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:05:39 INFO - PID 29252 | RSS: Main: 146137088 11:05:39 INFO - PID 29252 | 11:08:37 INFO - PID 29252 | Cycle 1(1): loaded http://localhost:40388/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40388/tests/dromaeo/cssquery-ext.html) 11:08:38 INFO - PID 29252 | RSS: Main: 148762624 11:08:38 INFO - PID 29252 | 11:11:39 INFO - PID 29252 | Cycle 1(1): loaded http://localhost:40388/tests/dromaeo/cssquery-ext.html (next: http://localhost:40388/tests/dromaeo/cssquery-jquery.html) 11:11:40 INFO - PID 29252 | RSS: Main: 146784256 11:11:40 INFO - PID 29252 | 11:14:41 INFO - PID 29252 | Cycle 1(1): loaded http://localhost:40388/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40388/tests/dromaeo/cssquery-mootools.html) 11:14:42 INFO - PID 29252 | RSS: Main: 147959808 11:14:42 INFO - PID 29252 | 11:17:43 INFO - PID 29252 | Cycle 1(1): loaded http://localhost:40388/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40388/tests/dromaeo/cssquery-prototype.html) 11:17:44 INFO - PID 29252 | RSS: Main: 148189184 11:17:44 INFO - PID 29252 | 11:20:47 INFO - PID 29252 | Cycle 1(1): loaded http://localhost:40388/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40388/tests/dromaeo/cssquery-yui.html) 11:20:47 INFO - PID 29252 | RSS: Main: 149798912 11:20:47 INFO - PID 29252 | 11:23:49 INFO - PID 29252 | Cycle 1(1): loaded http://localhost:40388/tests/dromaeo/cssquery-yui.html (next: http://localhost:40388/tests/dromaeo/cssquery-dojo.html) 11:23:49 INFO - PID 29252 | RSS: Main: 152313856 11:23:49 INFO - PID 29252 | 11:23:49 INFO - PID 29252 | __start_tp_report 11:23:49 INFO - PID 29252 | _x_x_mozilla_page_load 11:23:49 INFO - PID 29252 | _x_x_mozilla_page_load_details 11:23:49 INFO - PID 29252 | |i|pagename|runs| 11:23:49 INFO - PID 29252 | |0;dojo.html;4007.659348955339;4016.859409920653;4065.654419374351;4072.3484242521204;4078.306687863063;6642.601443913362;6657.367550082747;6700.798976030721;6725.394714475696;6747.493937954649;6621.933780662204;6691.799246022615;6701.2963638817955;6712.194536655608;6728;5947.316058653256;5959.553033522481;6050.788222412217;6065.454109130177;6073.969630151865;5959.672218028007;5973.4623883850445;5982.3120341160675;6039.6980150992495;6122.785702500413;6025.035994240922;6093.207882975207;6102.267727872661;6118.235220597426;6136.294326152505;5922.082077277985;6026.728797204137;6042.486388656969;6116.602420842631;6120.051392034242;5751.626144300607;5796.043652797283;5887;5940.46535811779;5955.225820643289;6518.967405162991;6544.770933017321;6566.606003639797;6603.438707709851;6628.005799130169;7078.292170782932;7155.964220178866;7177.031100801377;7227.205007449176;7245.601491917942;7109.8222544436285;7210.242924492957;7210.67551960163;7212.963935180343;7304.74433394834;6684.799456016327;6686;6690.33096690332;6690.632015239111;6691.063251144844;7236.312550307713;7353;7370.8894366584545;7456.962715186498;7469.701211951461;7036.542624729376;7077.646117694095;7099.148102227766;7101.076860008269;7167.784966451015;7115.181754098241;7186.46101542376;7282.927170728331;7338.192798792129;7349.889751653729;7114.395276401564;7145.571265723969;7152.356287934111;7174.461915356369;7188.784336469915;7106.538075025107;7144.535605185646;7227.710891564278;7230;7231.602261875542;5349.759260833272;5358.54452371545;5409.513143817076;5428.619996600279;5443.891122177534;4848.5636292733825;4853.150698627726;4862.489438608965;4915.827946021872;4998.350214472095;6743.325667433218;6774.525783195228;6777.322267773183;6786.151731033621;6792.184937807495;7160.713571457188;7174.282571742784;7178.820529486805;7180.102487189101;7258.129024517092;6530.738770449128;6592.80221593353;6678.79963601083;6768.357006084414;6770.255271920085;6009.879802404015;6021.638701677914;6033.215681961317;6042.577019608585;6059.697015149225;7437.739679111205;7439.851202976019;7511.737089201852;7536.24637536242;7574.356179724675;7046.436285097282;7066.293370662893;7167.247439018828;7193.820154496179;7195.568265904062;7364.079490063527;7366.889496657447;7450.888236676563;7475.925240747523;7481.738139165103;7124.358807707331;7148.249433809375;7178.856422871618;7188.173360063451;7197.712091516491;7233.493655444279;7323.487355885037;7325.194228634952;7345.742898998509;7346.228645992308;6942.757003504853;6960.756373526902;7032.331928466788;7053.224145344111;7060.8940865886025;6694.59832410057;6761.256261811295;6917.619530925847;6922.965385173244;7008.544444611084;6896.793096207121;6920.515563910478;6925.238223795479;6928.653567321715;6929.02993580889;6912.758053468105;7053.435725142079;7059.18819335783;7071.36357727807;7081.468889833386;6764.255931847394;6785.982102684637;6789.253182149861;6884.621345826027;6907.481938854506 11:23:49 INFO - PID 29252 | |1;ext.html;967.540418301307;974.2839013325209;994.4729293474458;1015.6800607808535;1028.126092821102;45637.57718171134;46083.76958115213;46386.30420543694;46419;46544.999999999956;43505.78247108768;43559.78220108895;43566;43830;43959.78020109895;8185.386096042806;8280.792980175484;8291.33669306454;8307.127751586087;8307.543085130315;8095.6761729531045;8112.067112282075;8132.674693012273;8136.14570470101;8162.6734930603;8510.48937063775;8819.118088191162;8839.95580022099;8842.336824738139;8848.646054157825;8701.738947831544;8771.868421973675;8772.03507614162;8773.078826723166;8783.560821958908;8712.172343627408;8721.258693011101;8763.211310982042;8798.252148567379;8813.779655508664;41655.58344416547;41673.583264167275;41912.79043604793;41942.58057419417;42020.78989605063;3810.8856734297738;3848.172642881766;3848.288066707668;3849.441830934527;3855.2289542091694;33270.667293327;33299.167520811934;33408.33183336344;33487.66512334894;33510.49734253988;5423.674579525241;5512.310961129859;5564.081926482126;5568.749406276727;5574.554035677136;226176;226228;226559;227315.86342068348;227516;52643.210351844755;52744.20883686748;52978.20532692013;53003.734981325615;53008.734956325745;54869;55283.72358138183;55402.72298638481;55591.72204139034;55616.443835561935;17622.91188544049;18087.276508939496;18133;18139.818601814077;18141;14847.554573362817;14956;15033.323500442506;15050.247487625575;15073.924630376778;15096.698066038618;15526.9223653881;15638.765418518731;15644.530664080095;15651.921740391454;5981.850453738692;6002.6698531580305;6020.759169633166;6023.518118550505;6243.875122497525;1088.1240601316017;1091.5197313182175;1094.7865166292656;1103.2773533335678;1108.684025052856;26370.20889373322;26460.47079058408;26540.60189097165;26597.867010664824;26597.86701066521;1189.5598628507335;1217.4764851113928;1219.2379762648345;1234.5802427174804;1239.4980033086615;13961.371738271802;14013.859861401255;14063.85936140646;14067.226302553254;14086.366113524917;271192;302213;304039;308830;309180;63925.36074639287;64369.67815160894;64664;64899.67550162219;64955;1512.3345727879698;1542.437010491185;1550.9146996915051;1559.8518140776607;1566.8511491408299;31003.069907902798;31292.374152516368;31598.36803263876;31604;32384;44702.55297447114;44975.550244497135;45113.32330015118;45125.77437112793;45177.774111129234;269600;271238;271258;271272;271614;37696.246075078896;38737.80631096826;38829.6117038826;39273.80363098166;39286.607133929436;46996.295055574876;48356.274655880894;49049.75475122601;49116.75441622769;49211.75394123006;35444;35650.643493564734;35707.82146089253;36115.458268125476;36185.81907090448;35139.82430087936;35607.82196089003;35682;35833.64166358407;36158.457623135146;41364.79317603393;41411.378829318186;41578.37632435576;41752.58247417487;41993.160136797705;34554.13614659654;34779.82610086934;34850;35035.29929401448;35139.82430087833;26091.73908260969;26693.599596006465;26836.038532265477;26984.32539186536;27241.182764517096 11:23:49 INFO - PID 29252 | |2;jquery.html;635.0891586033831;635.4579746590582;637.1338658920358;642.2739229954561;648.0280516252484;24613.507729845416;25518.362040948963;25613.231603051892;25621.743782562167;25643.23070307889;27842.30394240145;28178.154655360373;28462.146135615963;28491.287717807012;28515.287117822012;6328.588641738295;6803.285655006227;6841.62371069591;6842;6842.178938527383;6643.933560664404;6706.865862682744;6714.160729908762;6714.19429668438;6724.932750672504;6526.379993900572;6695.296993815652;6696.83257918551;6762.628055456948;6782.152230971129;6842.623655698934;6848.6918088686125;6874.243833178346;6884.621345825977;6908.240093589701;6425.485961123146;6438.3883531064475;6441.0982462455295;6449.774257900951;6450.096986421858;30707.385852283052;31105.066847994596;31661.683383166102;31727.365452690818;31837.363252734816;2437.402836305099;2496.9375765605823;2497.2757900208917;2498.5002999400194;2499.0378704198833;20536.486587835276;21069.5786084279;21169.788302116936;21176.258830941;21185.89407052955;2591.5335239656856;2660.773834224093;2674.1041751013436;2686.3418462476625;2697.581874809388;139109.3044534771;144332;144803;161811;169533.15233423753;16684.24920878539;17372.565685857702;17501.299948002194;17510.91244543769;17659.823401766076;27045.729542704714;27145.185644430305;27266.591001135;27377.589336159974;27449.86275068612;11406.144539159597;11626.76746465066;11651.30092194471;11689.123315751352;11732.648020559396;10665.200109991782;10707;10745.14038876888;10805.405702686428;10806.945965270123;10047.598096076075;10197.286189966779;10262.384256944608;10298.867124616287;10470.528826202839;3013.246688327918;3042.680518545565;3136.8745250190195;3136.9372612547622;3181.920451988719;1041.953112109957;1053.3574519543072;1060.9734756630992;1062.0229388962018;1078.735709751116;21117.577648446946;21565.13739450436;21588;21934.561308773737;22193.22323718662;1142.2404101272728;1154.6478324111226;1159.7390587117832;1163.5811108001112;1166.1079274355125;11922.225055371373;11949.283043017447;12129.696757580954;12248.571300004634;12261.203021803554;548873;586415;590360;595626;622828;128243.35878320549;130226.34886825505;136140;138562;138610.30694846663;1282.7242142939313;1284.1524593768067;1312.652147181017;1313.0677219174493;1316.7827308494184;18997.810021899604;19262.24411113632;19267.614647706687;19412.2235110594;19442.611147776683;62515.062274065014;62702.37297627148;63555.6822215886;64048;64407.677961609894;76822.23177768374;77808;80439.59780201061;81274.18725812667;81853.59073204595;16405.179741012664;16507.422240221535;16552.66894662076;16686;16893.66212675764;24757.62863557012;24802.751972480044;25045.49909001846;25120.497590047733;25417.237482875542;20572.69140962857;20580.27969021077;20600.55796094259;20693;20900;17837.821621783616;18071;18198.909005454887;18211.54471138232;18766.437006889813;20723.585528289652;20875;21153.788462115182;21164.4708882273;21327.253546125812;16229.67540649204;16350.264238109075;16423.42518011864;16442.424515141913;16454.177291135635;20321.390358289274;20462.386128416172;20576.176952921716;20649.69025464589;20757.688634670794 11:23:49 INFO - PID 29252 | |3;mootools.html;1443.408202636919;1504.811898512686;1517.1883042572226;1518.1270769307644;1526.2521364531376;16958;17916.28334866607;17927.731084033734;17956.82043179571;17982.5504362391;17287.30850765971;17427.5643108922;17490.737638935396;17502.562435939075;17557.91221043893;2945.2195168280423;2998.0705981145916;3039.60485136933;3046.84765761711;3048.2074660588187;2817.0844475545528;2865.28367908023;2872.827630342176;2874.78439117066;2877.9136625901256;2938.8824447022203;2940.3825196708717;2988.357503136825;2991;2995.8052726572705;2786;2805.4529366773486;2811.550151975674;2814.7326004029583;2818.6758522769837;2793.69269380368;2830.80184387093;2833.5607980763016;2834.6598408190944;2836.2342167614834;16623.335066597323;17001;17029.65940681192;17035.318587256494;17036.14819259032;8334.708285210048;8383.035950865667;8591.3556483264;8620.310375169971;8665.39342246043;5433.266509021271;5497.833572949573;5644.971775141139;5858.41415858415;6161.845953851145;2209.193644319828;2215.3021798133536;2217.6049866144685;2251.110811229555;2254.334971183505;27610.447791044066;28861.71138288611;30891;32201.1949701257;32261;7430.108386993596;7439.181690014094;7594.544327340377;7609.391248700091;7743.4966727162555;23958.161464348665;24085.7591424087;24169;24178.153764618153;24184.637230441556;8593.871091933626;8676.652933882575;8737.126287371211;8783.341249406192;8943.329250306253;7647.502912310682;8046.131820880027;8168.795780105426;8198.057223419264;8263.710770123016;6220.595661282002;6273.1844860167885;6344.809655710336;6402;6402.231732192166;1900.923963041463;1918.7793403758467;1920.5909510618762;1930.8744931579402;1933.58427937994;1018.7045756730613;1029.1149611334247;1034.3897100710617;1034.4775888176423;1049.559185142242;9144.268458523302;9166.679166229284;9238.399504032217;9241.260699144052;9311.860322095174;832.3549249331817;847.372944021432;849.9957500212583;852.9019162796358;873.8121303919688;5523.834284971457;5575.804846830341;5648.519875810603;5662.320521537442;5678.914816277759;25883.352916177246;26218.606720899203;27481.725182747916;27498.587521187197;27528.862355688092;25479;26449.206523804318;26658.866705666347;26773.330666733487;26814.329641758723;11095.098708979223;12880.613581592566;12953.028522860823;12979.610611681665;13116.475340986253;10748.516316765608;10826.350418974887;10834.837477437686;10898.782024359627;10909;22024.44938876477;22469.43826404353;22535.661965070864;22626.547469050856;23321.416964576023;22573.774262257168;22863.31410057701;23065;23573.29280121599;23638;13859.168449893039;13884.652883677989;13922.72154556883;13968.930155349159;14117.788233176716;16006.439774607832;16121.113338766012;16169;16190.190490475665;16262.593435164215;12001.63995080114;12060.276383417024;12179.512819487121;12281.815772763237;12463;13004.21974681522;13090.410931507915;13222.669433264246;13293.80059299092;13311.400986955803;10768.246222764332;10896.400697961371;10920.890791091988;10952.780944381228;10958.178136639943;8272.33821294307;8281.29608983243;8336.124706905688;8361.414700971118;8371.288440482627;8347.207015333533;8426.536540490331;8453.830923381622;8515.446495977742;8535.189157030072 11:23:49 INFO - PID 29252 | |4;prototype.html;563.5435297409101;579.6927628356972;585.1690599348923;602.912577676237;610.3865615056867;6393.680315984206;6424.2612099608505;6492.772752953648;6542.149520562332;6543.738250469975;6369.681515924197;6402.390278999125;6413.198350206224;6421.389967953037;6486.708098135583;5311.2298716686055;5316.680999140045;5322.574194064485;5327.653702509344;5341.145416733323;5034.144195486776;5170.603936937025;5274.26160337553;5308.734563271841;5338.386085600167;5163.302954101186;5169.224616307546;5183.611229157809;5200.479952004807;5204.141316682742;5056.8482945511505;5105.923411148836;5132.486751324856;5149.356330458692;5181.53366197044;4713.198756211452;4752.358431611723;4761.428628564595;4767.499412561666;4780.641451891087;6314.463270621956;6337.397947195009;6341.904871426932;6378.744850205986;6408.519361047894;6067.362926892657;6073.240844894388;6120.326764055951;6122.96938515309;6123.87752244957;6824.522283440161;6836.179658440969;6853.623050732208;6855.897161542581;6856.314368563154;5208.869778255536;5242.580593552507;5264.947350526484;5265.3681558212875;5268;6918.273581273944;6927.896081558781;7087.3267039631155;7088.3974862136265;7108.075950126502;5331.840044798662;5362.383325917569;5363.919541206885;5401.702906340189;5433.67397956116;5441.265429167091;5483.369412517612;5512.751926163332;5518.696471694015;5528.75120619573;5991.670458124845;6000.129981152709;6017.969910150508;6035.486983606354;6112.51099912006;6757.8648427031185;6844.726210951606;6867.587944723333;6920.861582768316;6955.6869940852785;1872.8969906655266;1875.681134207188;1898.642470633476;1901.7622797150357;1916.1951980168362;1301.6875949771986;1307.8692130787035;1350.770369037266;1362.8841548468292;1366.631009627395;6294.0558916162945;6380.617162970237;6382.234131904202;6387.265464471552;6400.615963042233;6728.226253980855;6848.794536163923;6868.210155832143;6890.586564806128;6944.791656250321;6255.593386429868;6313.40022697843;6356.141920840627;6395.232572091379;6412.839679008062;3652.926941461156;3658.7804731716183;3662.1760103976394;3663.3405986922608;3677.7793332400142;7161.606111663804;7186.496945213889;7191.065161528968;7200.387967022757;7249.637518124073;6963.1644202696;7018.859622807618;7031.296870312928;7066.258042905523;7076.752313668997;7101.62095697947;7146.3568278855155;7175.748848790267;7194.676239569128;7212.639368031578;6903.551269167488;6971.337722916315;7013.22854485996;7014;7014.929850701427;6806.319368063154;6901.689423975833;6911.688973996082;6921.757738479129;6958.443324534126;7205.531640443354;7226.74706385274;7237.63811809418;7240.52936559122;7282.980382746526;5337.8131765388025;5373.328333958255;5420.4037555868035;5429.53848922846;5453.454654534515;6510.967445162744;6629.105070815378;6883.552569082994;6969.965150174216;6974.79075627732;6605.207375115017;6609.570377925419;6715.26132125456;6741.460683145238;6746.6626668665385;6581.407673309425;6648.434883034996;6697.7655782047395;6699.76550820719;6802.217744959195;6490.221173459215;6574.572652777554;6683.8663226734225;6685.0306705526455;6707.631080290631;6668.233153187445;6689.464842812466;6718.361755633207;6775.559588626724;6792.762253321308;6566.967165164335;6592.70332835014;6609.537332386687;6611.305812889577;6647 11:23:49 INFO - PID 29252 | |5;yui.html;988.6836212412031;1018.2973748113801;1021.3361315145155;1045.5504133222717;1063.2132222155606;20302.492437689045;20744.377668669964;20775.792242077576;20811.895940520313;20872;17260;17544.912275438637;17636.47090587281;17824.465266042007;18047.458576242734;1048.543883410715;1068.4070340960764;1068.9412082335468;1074.457399013499;1075.1237741240902;1054.9894501055007;1091;1091.3942761767216;1093.830456279274;1097.5280629329386;1163.7323415614414;1166.125405945541;1166.5450474314982;1166.9824952625718;1167.474636413613;1158.5481662151767;1162.517555214585;1163.5345861655405;1165.021382039087;1165.4697112813649;861.1302584389749;862.598891515442;864.0236532717988;865.3812524045275;866.3632230310717;18524.722129168073;20169.193232270693;20724.067416966274;20897.791022089736;21007.369778906657;20967.26614568483;21099.894500527553;21580.460488487755;21584;21630.134794608195;16381.262843172086;16492.670146597;17106.31574737009;17210.311587536482;17285.740713889303;3994.141259629194;4141.627253547195;4159.500859896802;4165.187788381237;4174.08170202558;164729;167336;167812.16093919575;168839.15580422143;169924;17948.910255448638;18419.72370414445;18449.354272600394;18539.258429662932;18548.350807721665;36018.63981360153;36559.4516082259;36745.08137296589;36959;37054.62945370566;9786.608535658635;9823;10043.146332561668;10050.195984321237;10056;5064.974675126675;5093.694378337312;5119.897602047939;5149.433562308143;5151.6908985461;6246.500279977591;6316.115743795872;6345.746170153142;6363.268224154189;6430.614163150226;1165.5862168929907;1167.5096459486865;1196.6469891382062;1199.4962115911337;1199.7120691034263;671.1878626861454;680.6290571638469;687.4809518813264;689.4484412470003;695.2109355881112;11591.884081159249;11606.825897611543;11829.171957963032;11907.106966977512;11931.04551635867;759.8860170974287;763.8319569694659;765.762613589789;766.4864540757706;771.7877583664538;5740.454656807597;5759.913601295984;5812.331581868055;5885.411458854081;5914.0537513998415;149193;149673;151034;153512;153671;127536.36231818967;128463;128714;129946.35026824805;130486;113893;114225.4288728551;115154;117225;117617;10963;11077.612283570037;11200.551977921117;11229.101671866069;11421.942890285496;59974.70012649909;60113.39886601078;60457;60742;60971.39028609657;75091.87362189681;75762;76503.61748191224;78485;79470.20529794628;15058.472953446577;15172.165530895907;15224.923875380553;15289.159096249814;15299.77050344268;16753.329866805678;16838.326466941184;16850.07324597159;16853.915730421268;16880.324787008383;15165.620859478602;15721;15773.132477713836;15923.124228167562;15968.600784980468;14058.297085145497;14180.929095354457;14181.503647372292;14243.430262789372;14377;15252.847471525587;15328.156951367337;15344.846551534341;15459.690806184039;15476.613084672974;11329.69708483535;11351.48918298695;11592.188546801643;12007.939960300142;12115.878841211475;12001.219920705475;12128.757424851277;12194.085443591943;12484.937575312066;12546.87453125457 11:23:49 INFO - PID 29252 | __end_tp_report 11:23:49 INFO - PID 29252 | __start_cc_report 11:23:49 INFO - PID 29252 | _x_x_mozilla_cycle_collect,239 11:23:49 INFO - PID 29252 | __end_cc_report 11:23:49 INFO - PID 29252 | __startTimestamp1506104629502__endTimestamp 11:23:49 INFO - PID 29252 | 11:23:49 INFO - PID 29252 | ------- Summary: start ------- 11:23:49 INFO - PID 29252 | Number of tests: 6 11:23:49 INFO - PID 29252 | 11:23:49 INFO - PID 29252 | [#0] dojo.html Cycles:165 Average:6647.03 Median:6907.48 stddev:765.74 (11.1%) stddev-sans-first:739.57 11:23:49 INFO - PID 29252 | Values: 4007.7 4016.9 4065.7 4072.3 4078.3 6642.6 6657.4 6700.8 6725.4 6747.5 6621.9 6691.8 6701.3 6712.2 6728.0 5947.3 5959.6 6050.8 6065.5 6074.0 5959.7 5973.5 5982.3 6039.7 6122.8 6025.0 6093.2 6102.3 6118.2 6136.3 5922.1 6026.7 6042.5 6116.6 6120.1 5751.6 5796.0 5887.0 5940.5 5955.2 6519.0 6544.8 6566.6 6603.4 6628.0 7078.3 7156.0 7177.0 7227.2 7245.6 7109.8 7210.2 7210.7 7213.0 7304.7 6684.8 6686.0 6690.3 6690.6 6691.1 7236.3 7353.0 7370.9 7457.0 7469.7 7036.5 7077.6 7099.1 7101.1 7167.8 7115.2 7186.5 7282.9 7338.2 7349.9 7114.4 7145.6 7152.4 7174.5 7188.8 7106.5 7144.5 7227.7 7230.0 7231.6 5349.8 5358.5 5409.5 5428.6 5443.9 4848.6 4853.2 4862.5 4915.8 4998.4 6743.3 6774.5 6777.3 6786.2 6792.2 7160.7 7174.3 7178.8 7180.1 7258.1 6530.7 6592.8 6678.8 6768.4 6770.3 6009.9 6021.6 6033.2 6042.6 6059.7 7437.7 7439.9 7511.7 7536.2 7574.4 7046.4 7066.3 7167.2 7193.8 7195.6 7364.1 7366.9 7450.9 7475.9 7481.7 7124.4 7148.2 7178.9 7188.2 7197.7 7233.5 7323.5 7325.2 7345.7 7346.2 6942.8 6960.8 7032.3 7053.2 7060.9 6694.6 6761.3 6917.6 6923.0 7008.5 6896.8 6920.5 6925.2 6928.7 6929.0 6912.8 7053.4 7059.2 7071.4 7081.5 6764.3 6786.0 6789.3 6884.6 6907.5 11:23:49 INFO - PID 29252 | 11:23:49 INFO - PID 29252 | [#1] ext.html Cycles:180 Average:45152.99 Median:3848.86 stddev:69577.42 (1807.7%) stddev-sans-first:69693.51 11:23:49 INFO - PID 29252 | Values: 967.5 974.3 994.5 1015.7 1028.1 45637.6 46083.8 46386.3 46419.0 46545.0 43505.8 43559.8 43566.0 43830.0 43959.8 8185.4 8280.8 8291.3 8307.1 8307.5 8095.7 8112.1 8132.7 8136.1 8162.7 8510.5 8819.1 8840.0 8842.3 8848.6 8701.7 8771.9 8772.0 8773.1 8783.6 8712.2 8721.3 8763.2 8798.3 8813.8 41655.6 41673.6 41912.8 41942.6 42020.8 3810.9 3848.2 3848.3 3849.4 3855.2 33270.7 33299.2 33408.3 33487.7 33510.5 5423.7 5512.3 5564.1 5568.7 5574.6 226176.0 226228.0 226559.0 227315.9 227516.0 52643.2 52744.2 52978.2 53003.7 53008.7 54869.0 55283.7 55402.7 55591.7 55616.4 17622.9 18087.3 18133.0 18139.8 18141.0 14847.6 14956.0 15033.3 15050.2 15073.9 15096.7 15526.9 15638.8 15644.5 15651.9 5981.9 6002.7 6020.8 6023.5 6243.9 1088.1 1091.5 1094.8 1103.3 1108.7 26370.2 26460.5 26540.6 26597.9 26597.9 1189.6 1217.5 1219.2 1234.6 1239.5 13961.4 14013.9 14063.9 14067.2 14086.4 271192.0 302213.0 304039.0 308830.0 309180.0 63925.4 64369.7 64664.0 64899.7 64955.0 1512.3 1542.4 1550.9 1559.9 1566.9 31003.1 31292.4 31598.4 31604.0 32384.0 44702.6 44975.6 45113.3 45125.8 45177.8 269600.0 271238.0 271258.0 271272.0 271614.0 37696.2 38737.8 38829.6 39273.8 39286.6 46996.3 48356.3 49049.8 49116.8 49211.8 35444.0 35650.6 35707.8 36115.5 36185.8 35139.8 35607.8 35682.0 35833.6 36158.5 41364.8 41411.4 41578.4 41752.6 41993.2 34554.1 34779.8 34850.0 35035.3 35139.8 26091.7 26693.6 26836.0 26984.3 27241.2 11:23:49 INFO - PID 29252 | 11:23:49 INFO - PID 29252 | [#2] jquery.html Cycles:180 Average:39970.86 Median:21446.20 stddev:98837.10 (460.9%) stddev-sans-first:99070.24 11:23:49 INFO - PID 29252 | Values: 635.1 635.5 637.1 642.3 648.0 24613.5 25518.4 25613.2 25621.7 25643.2 27842.3 28178.2 28462.1 28491.3 28515.3 6328.6 6803.3 6841.6 6842.0 6842.2 6643.9 6706.9 6714.2 6714.2 6724.9 6526.4 6695.3 6696.8 6762.6 6782.2 6842.6 6848.7 6874.2 6884.6 6908.2 6425.5 6438.4 6441.1 6449.8 6450.1 30707.4 31105.1 31661.7 31727.4 31837.4 2437.4 2496.9 2497.3 2498.5 2499.0 20536.5 21069.6 21169.8 21176.3 21185.9 2591.5 2660.8 2674.1 2686.3 2697.6 139109.3 144332.0 144803.0 161811.0 169533.2 16684.2 17372.6 17501.3 17510.9 17659.8 27045.7 27145.2 27266.6 27377.6 27449.9 11406.1 11626.8 11651.3 11689.1 11732.6 10665.2 10707.0 10745.1 10805.4 10806.9 10047.6 10197.3 10262.4 10298.9 10470.5 3013.2 3042.7 3136.9 3136.9 3181.9 1042.0 1053.4 1061.0 1062.0 1078.7 21117.6 21565.1 21588.0 21934.6 22193.2 1142.2 1154.6 1159.7 1163.6 1166.1 11922.2 11949.3 12129.7 12248.6 12261.2 548873.0 586415.0 590360.0 595626.0 622828.0 128243.4 130226.3 136140.0 138562.0 138610.3 1282.7 1284.2 1312.7 1313.1 1316.8 18997.8 19262.2 19267.6 19412.2 19442.6 62515.1 62702.4 63555.7 64048.0 64407.7 76822.2 77808.0 80439.6 81274.2 81853.6 16405.2 16507.4 16552.7 16686.0 16893.7 24757.6 24802.8 25045.5 25120.5 25417.2 20572.7 20580.3 20600.6 20693.0 20900.0 17837.8 18071.0 18198.9 18211.5 18766.4 20723.6 20875.0 21153.8 21164.5 21327.3 16229.7 16350.3 16423.4 16442.4 16454.2 20321.4 20462.4 20576.2 20649.7 20757.7 11:23:49 INFO - PID 29252 | 11:23:49 INFO - PID 29252 | [#3] mootools.html Cycles:180 Average:10948.07 Median:26793.83 stddev:8187.93 (30.6%) stddev-sans-first:8179.76 11:23:49 INFO - PID 29252 | Values: 1443.4 1504.8 1517.2 1518.1 1526.3 16958.0 17916.3 17927.7 17956.8 17982.6 17287.3 17427.6 17490.7 17502.6 17557.9 2945.2 2998.1 3039.6 3046.8 3048.2 2817.1 2865.3 2872.8 2874.8 2877.9 2938.9 2940.4 2988.4 2991.0 2995.8 2786.0 2805.5 2811.6 2814.7 2818.7 2793.7 2830.8 2833.6 2834.7 2836.2 16623.3 17001.0 17029.7 17035.3 17036.1 8334.7 8383.0 8591.4 8620.3 8665.4 5433.3 5497.8 5645.0 5858.4 6161.8 2209.2 2215.3 2217.6 2251.1 2254.3 27610.4 28861.7 30891.0 32201.2 32261.0 7430.1 7439.2 7594.5 7609.4 7743.5 23958.2 24085.8 24169.0 24178.2 24184.6 8593.9 8676.7 8737.1 8783.3 8943.3 7647.5 8046.1 8168.8 8198.1 8263.7 6220.6 6273.2 6344.8 6402.0 6402.2 1900.9 1918.8 1920.6 1930.9 1933.6 1018.7 1029.1 1034.4 1034.5 1049.6 9144.3 9166.7 9238.4 9241.3 9311.9 832.4 847.4 850.0 852.9 873.8 5523.8 5575.8 5648.5 5662.3 5678.9 25883.4 26218.6 27481.7 27498.6 27528.9 25479.0 26449.2 26658.9 26773.3 26814.3 11095.1 12880.6 12953.0 12979.6 13116.5 10748.5 10826.4 10834.8 10898.8 10909.0 22024.4 22469.4 22535.7 22626.5 23321.4 22573.8 22863.3 23065.0 23573.3 23638.0 13859.2 13884.7 13922.7 13968.9 14117.8 16006.4 16121.1 16169.0 16190.2 16262.6 12001.6 12060.3 12179.5 12281.8 12463.0 13004.2 13090.4 13222.7 13293.8 13311.4 10768.2 10896.4 10920.9 10952.8 10958.2 8272.3 8281.3 8336.1 8361.4 8371.3 8347.2 8426.5 8453.8 8515.4 8535.2 11:23:49 INFO - PID 29252 | 11:23:49 INFO - PID 29252 | [#4] prototype.html Cycles:180 Average:5804.65 Median:6405.45 stddev:1601.09 (25.0%) stddev-sans-first:1556.50 11:23:49 INFO - PID 29252 | Values: 563.5 579.7 585.2 602.9 610.4 6393.7 6424.3 6492.8 6542.1 6543.7 6369.7 6402.4 6413.2 6421.4 6486.7 5311.2 5316.7 5322.6 5327.7 5341.1 5034.1 5170.6 5274.3 5308.7 5338.4 5163.3 5169.2 5183.6 5200.5 5204.1 5056.8 5105.9 5132.5 5149.4 5181.5 4713.2 4752.4 4761.4 4767.5 4780.6 6314.5 6337.4 6341.9 6378.7 6408.5 6067.4 6073.2 6120.3 6123.0 6123.9 6824.5 6836.2 6853.6 6855.9 6856.3 5208.9 5242.6 5264.9 5265.4 5268.0 6918.3 6927.9 7087.3 7088.4 7108.1 5331.8 5362.4 5363.9 5401.7 5433.7 5441.3 5483.4 5512.8 5518.7 5528.8 5991.7 6000.1 6018.0 6035.5 6112.5 6757.9 6844.7 6867.6 6920.9 6955.7 1872.9 1875.7 1898.6 1901.8 1916.2 1301.7 1307.9 1350.8 1362.9 1366.6 6294.1 6380.6 6382.2 6387.3 6400.6 6728.2 6848.8 6868.2 6890.6 6944.8 6255.6 6313.4 6356.1 6395.2 6412.8 3652.9 3658.8 3662.2 3663.3 3677.8 7161.6 7186.5 7191.1 7200.4 7249.6 6963.2 7018.9 7031.3 7066.3 7076.8 7101.6 7146.4 7175.7 7194.7 7212.6 6903.6 6971.3 7013.2 7014.0 7014.9 6806.3 6901.7 6911.7 6921.8 6958.4 7205.5 7226.7 7237.6 7240.5 7283.0 5337.8 5373.3 5420.4 5429.5 5453.5 6511.0 6629.1 6883.6 6970.0 6974.8 6605.2 6609.6 6715.3 6741.5 6746.7 6581.4 6648.4 6697.8 6699.8 6802.2 6490.2 6574.6 6683.9 6685.0 6707.6 6668.2 6689.5 6718.4 6775.6 6792.8 6567.0 6592.7 6609.5 6611.3 6647.0 11:23:49 INFO - PID 29252 | 11:23:49 INFO - PID 29252 | [#5] yui.html Cycles:180 Average:28273.89 Median:92044.66 stddev:43408.33 (47.2%) stddev-sans-first:43481.76 11:23:49 INFO - PID 29252 | Values: 988.7 1018.3 1021.3 1045.6 1063.2 20302.5 20744.4 20775.8 20811.9 20872.0 17260.0 17544.9 17636.5 17824.5 18047.5 1048.5 1068.4 1068.9 1074.5 1075.1 1055.0 1091.0 1091.4 1093.8 1097.5 1163.7 1166.1 1166.5 1167.0 1167.5 1158.5 1162.5 1163.5 1165.0 1165.5 861.1 862.6 864.0 865.4 866.4 18524.7 20169.2 20724.1 20897.8 21007.4 20967.3 21099.9 21580.5 21584.0 21630.1 16381.3 16492.7 17106.3 17210.3 17285.7 3994.1 4141.6 4159.5 4165.2 4174.1 164729.0 167336.0 167812.2 168839.2 169924.0 17948.9 18419.7 18449.4 18539.3 18548.4 36018.6 36559.5 36745.1 36959.0 37054.6 9786.6 9823.0 10043.1 10050.2 10056.0 5065.0 5093.7 5119.9 5149.4 5151.7 6246.5 6316.1 6345.7 6363.3 6430.6 1165.6 1167.5 1196.6 1199.5 1199.7 671.2 680.6 687.5 689.4 695.2 11591.9 11606.8 11829.2 11907.1 11931.0 759.9 763.8 765.8 766.5 771.8 5740.5 5759.9 5812.3 5885.4 5914.1 149193.0 149673.0 151034.0 153512.0 153671.0 127536.4 128463.0 128714.0 129946.4 130486.0 113893.0 114225.4 115154.0 117225.0 117617.0 10963.0 11077.6 11200.6 11229.1 11421.9 59974.7 60113.4 60457.0 60742.0 60971.4 75091.9 75762.0 76503.6 78485.0 79470.2 15058.5 15172.2 15224.9 15289.2 15299.8 16753.3 16838.3 16850.1 16853.9 16880.3 15165.6 15721.0 15773.1 15923.1 15968.6 14058.3 14180.9 14181.5 14243.4 14377.0 15252.8 15328.2 15344.8 15459.7 15476.6 11329.7 11351.5 11592.2 12007.9 12115.9 12001.2 12128.8 12194.1 12484.9 12546.9 11:23:49 INFO - PID 29252 | -------- Summary: end -------- 11:23:49 INFO - PID 29252 | 11:23:50 INFO - TEST-INFO | 29252: exit 0 11:23:50 INFO - TEST-OK | dromaeo_css | took 1106384ms 11:23:50 INFO - TEST-START | kraken 11:23:50 INFO - Initialising browser for kraken test... 11:23:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40388/getInfo.html -profile /tmp/tmpijCbSI/profile 11:23:50 INFO - TEST-INFO | started process 29617 (/builds/slave/test/build/application/firefox/firefox http://localhost:40388/getInfo.html) 11:23:55 INFO - TEST-INFO | 29617: exit 0 11:23:55 INFO - Browser initialized. 11:23:55 INFO - Running cycle 1/1 for kraken test... 11:23:55 INFO - Using env: {'DISPLAY': ':0', 11:23:55 INFO - 'HOME': '/home/cltbld', 11:23:55 INFO - 'JSGC_DISABLE_POISONING': '1', 11:23:55 INFO - 'LANG': 'en_US.UTF-8', 11:23:55 INFO - 'LANGUAGE': 'en_US:en', 11:23:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:23:55 INFO - 'LOGNAME': 'cltbld', 11:23:55 INFO - 'MAIL': '/var/mail/cltbld', 11:23:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:23:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:23:55 INFO - 'MOZ_CRASHREPORTER': '1', 11:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:23:55 INFO - 'MOZ_NO_REMOTE': '1', 11:23:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:23:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:55 INFO - 'NO_EM_RESTART': '1', 11:23:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:55 INFO - 'PWD': '/builds/slave/test', 11:23:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:23:55 INFO - 'RUST_BACKTRACE': 'full', 11:23:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:23:55 INFO - 'SHELL': '/bin/bash', 11:23:55 INFO - 'SHLVL': '1', 11:23:55 INFO - 'TERM': 'linux', 11:23:55 INFO - 'TMOUT': '86400', 11:23:55 INFO - 'USER': 'cltbld', 11:23:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262', 11:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:55 INFO - '_': '/tools/buildbot/bin/python'} 11:23:55 INFO - TEST-INFO | started process 29807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpijCbSI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:24:06 INFO - PID 29807 | RSS: Main: 144515072 11:24:06 INFO - PID 29807 | 11:24:09 INFO - PID 29807 | Cycle 1(1): loaded http://localhost:40388/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40388/tests/kraken/driver.html?testName=audio-beat-detection) 11:24:09 INFO - PID 29807 | RSS: Main: 150130688 11:24:09 INFO - PID 29807 | 11:24:12 INFO - PID 29807 | Cycle 1(1): loaded http://localhost:40388/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40388/tests/kraken/driver.html?testName=audio-dft) 11:24:13 INFO - PID 29807 | RSS: Main: 150302720 11:24:13 INFO - PID 29807 | 11:24:15 INFO - PID 29807 | Cycle 1(1): loaded http://localhost:40388/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40388/tests/kraken/driver.html?testName=audio-fft) 11:24:16 INFO - PID 29807 | RSS: Main: 152498176 11:24:16 INFO - PID 29807 | 11:24:18 INFO - PID 29807 | Cycle 1(1): loaded http://localhost:40388/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40388/tests/kraken/driver.html?testName=audio-oscillator) 11:24:19 INFO - PID 29807 | RSS: Main: 152244224 11:24:19 INFO - PID 29807 | 11:24:21 INFO - PID 29807 | Cycle 1(1): loaded http://localhost:40388/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40388/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:24:21 INFO - PID 29807 | RSS: Main: 152363008 11:24:21 INFO - PID 29807 | 11:24:24 INFO - PID 29807 | Cycle 1(1): loaded http://localhost:40388/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40388/tests/kraken/driver.html?testName=imaging-darkroom) 11:24:25 INFO - PID 29807 | RSS: Main: 151453696 11:24:25 INFO - PID 29807 | 11:24:28 INFO - PID 29807 | Cycle 1(1): loaded http://localhost:40388/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40388/tests/kraken/driver.html?testName=imaging-desaturate) 11:24:29 INFO - PID 29807 | RSS: Main: 154275840 11:24:29 INFO - PID 29807 | 11:24:32 INFO - PID 29807 | Cycle 1(1): loaded http://localhost:40388/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40388/tests/kraken/driver.html?testName=json-parse-financial) 11:24:32 INFO - PID 29807 | RSS: Main: 154972160 11:24:32 INFO - PID 29807 | 11:24:34 INFO - PID 29807 | Cycle 1(1): loaded http://localhost:40388/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40388/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:24:34 INFO - PID 29807 | RSS: Main: 154660864 11:24:34 INFO - PID 29807 | 11:24:36 INFO - PID 29807 | Cycle 1(1): loaded http://localhost:40388/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40388/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:24:37 INFO - PID 29807 | RSS: Main: 154656768 11:24:37 INFO - PID 29807 | 11:24:39 INFO - PID 29807 | Cycle 1(1): loaded http://localhost:40388/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40388/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:24:39 INFO - PID 29807 | RSS: Main: 151568384 11:24:39 INFO - PID 29807 | 11:24:42 INFO - PID 29807 | Cycle 1(1): loaded http://localhost:40388/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40388/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:24:42 INFO - PID 29807 | RSS: Main: 151588864 11:24:42 INFO - PID 29807 | 11:24:45 INFO - PID 29807 | Cycle 1(1): loaded http://localhost:40388/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40388/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:24:45 INFO - PID 29807 | RSS: Main: 152252416 11:24:45 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | Cycle 1(1): loaded http://localhost:40388/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40388/tests/kraken/driver.html?testName=ai-astar) 11:24:47 INFO - PID 29807 | RSS: Main: 154206208 11:24:47 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | __start_tp_report 11:24:47 INFO - PID 29807 | _x_x_mozilla_page_load 11:24:47 INFO - PID 29807 | _x_x_mozilla_page_load_details 11:24:47 INFO - PID 29807 | |i|pagename|runs| 11:24:47 INFO - PID 29807 | |0;ai-astar;105;106;105;105;105;106;106;107;105;105 11:24:47 INFO - PID 29807 | |1;audio-beat-detection;112;114;111;112;113;136;124;115;110;111 11:24:47 INFO - PID 29807 | |2;audio-dft;162;160;163;162;161;161;161;163;162;160 11:24:47 INFO - PID 29807 | |3;audio-fft;72;73;73;76;73;72;74;73;73;73 11:24:47 INFO - PID 29807 | |4;audio-oscillator;77;78;77;77;77;77;77;77;78;77 11:24:47 INFO - PID 29807 | |5;imaging-gaussian-blur;114;113;113;113;113;114;114;113;113;114 11:24:47 INFO - PID 29807 | |6;imaging-darkroom;150;148;147;150;149;147;149;148;147;148 11:24:47 INFO - PID 29807 | |7;imaging-desaturate;96;93;94;94;98;94;94;94;94;94 11:24:47 INFO - PID 29807 | |8;json-parse-financial;42;44;43;44;44;42;45;44;45;45 11:24:47 INFO - PID 29807 | |9;json-stringify-tinderbox;38;38;39;38;38;39;38;42;39;38 11:24:47 INFO - PID 29807 | |10;stanford-crypto-aes;74;69;72;69;70;69;68;69;69;69 11:24:47 INFO - PID 29807 | |11;stanford-crypto-ccm;108;103;102;108;104;105;110;102;101;97 11:24:47 INFO - PID 29807 | |12;stanford-crypto-pbkdf2;144;143;148;148;146;148;142;145;150;149 11:24:47 INFO - PID 29807 | |13;stanford-crypto-sha256-iterative;61;56;61;64;54;62;61;58;59;60 11:24:47 INFO - PID 29807 | __end_tp_report 11:24:47 INFO - PID 29807 | __start_cc_report 11:24:47 INFO - PID 29807 | _x_x_mozilla_cycle_collect,694 11:24:47 INFO - PID 29807 | __end_cc_report 11:24:47 INFO - PID 29807 | __startTimestamp1506104687853__endTimestamp 11:24:47 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | ------- Summary: start ------- 11:24:47 INFO - PID 29807 | Number of tests: 14 11:24:47 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | [#0] ai-astar Cycles:10 Average:105.50 Median:105.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 11:24:47 INFO - PID 29807 | Values: 105.0 106.0 105.0 105.0 105.0 106.0 106.0 107.0 105.0 105.0 11:24:47 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | [#1] audio-beat-detection Cycles:10 Average:115.80 Median:113.50 stddev:8.13 (7.2%) stddev-sans-first:8.51 11:24:47 INFO - PID 29807 | Values: 112.0 114.0 111.0 112.0 113.0 136.0 124.0 115.0 110.0 111.0 11:24:47 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 11:24:47 INFO - PID 29807 | Values: 162.0 160.0 163.0 162.0 161.0 161.0 161.0 163.0 162.0 160.0 11:24:47 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | [#3] audio-fft Cycles:10 Average:73.20 Median:73.00 stddev:1.14 (1.6%) stddev-sans-first:1.12 11:24:47 INFO - PID 29807 | Values: 72.0 73.0 73.0 76.0 73.0 72.0 74.0 73.0 73.0 73.0 11:24:47 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:77.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 11:24:47 INFO - PID 29807 | Values: 77.0 78.0 77.0 77.0 77.0 77.0 77.0 77.0 78.0 77.0 11:24:47 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:24:47 INFO - PID 29807 | Values: 114.0 113.0 113.0 113.0 113.0 114.0 114.0 113.0 113.0 114.0 11:24:47 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:1.16 (0.8%) stddev-sans-first:1.05 11:24:47 INFO - PID 29807 | Values: 150.0 148.0 147.0 150.0 149.0 147.0 149.0 148.0 147.0 148.0 11:24:47 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.43 (1.5%) stddev-sans-first:1.41 11:24:47 INFO - PID 29807 | Values: 96.0 93.0 94.0 94.0 98.0 94.0 94.0 94.0 94.0 94.0 11:24:47 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | [#8] json-parse-financial Cycles:10 Average:43.80 Median:44.00 stddev:1.14 (2.6%) stddev-sans-first:1.00 11:24:47 INFO - PID 29807 | Values: 42.0 44.0 43.0 44.0 44.0 42.0 45.0 44.0 45.0 45.0 11:24:47 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | [#9] json-stringify-tinderbox Cycles:10 Average:38.70 Median:38.50 stddev:1.25 (3.3%) stddev-sans-first:1.30 11:24:47 INFO - PID 29807 | Values: 38.0 38.0 39.0 38.0 38.0 39.0 38.0 42.0 39.0 38.0 11:24:47 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | [#10] stanford-crypto-aes Cycles:10 Average:69.80 Median:69.00 stddev:1.81 (2.6%) stddev-sans-first:1.12 11:24:47 INFO - PID 29807 | Values: 74.0 69.0 72.0 69.0 70.0 69.0 68.0 69.0 69.0 69.0 11:24:47 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | [#11] stanford-crypto-ccm Cycles:10 Average:104.00 Median:106.50 stddev:3.89 (3.7%) stddev-sans-first:3.84 11:24:47 INFO - PID 29807 | Values: 108.0 103.0 102.0 108.0 104.0 105.0 110.0 102.0 101.0 97.0 11:24:47 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:148.00 stddev:2.71 (1.8%) stddev-sans-first:2.74 11:24:47 INFO - PID 29807 | Values: 144.0 143.0 148.0 148.0 146.0 148.0 142.0 145.0 150.0 149.0 11:24:47 INFO - PID 29807 | 11:24:47 INFO - PID 29807 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.60 Median:61.00 stddev:2.95 (4.8%) stddev-sans-first:3.09 11:24:47 INFO - PID 29807 | Values: 61.0 56.0 61.0 64.0 54.0 62.0 61.0 58.0 59.0 60.0 11:24:47 INFO - PID 29807 | -------- Summary: end -------- 11:24:47 INFO - PID 29807 | 11:24:48 INFO - PID 29807 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:24:48 INFO - TEST-INFO | 29807: exit 0 11:24:48 INFO - TEST-OK | kraken | took 58365ms 11:24:48 INFO - SUITE-END | took 1164s 11:24:48 INFO - Completed test suite (00:19:24) 11:24:48 INFO - javascript benchmark 11:24:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9362.02382943615, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4007.659348955339, 4016.859409920653, 4065.654419374351, 4072.3484242521204, 4078.306687863063, 6642.601443913362, 6657.367550082747, 6700.798976030721, 6725.394714475696, 6747.493937954649, 6621.933780662204, 6691.799246022615, 6701.2963638817955, 6712.194536655608, 6728.0, 5947.316058653256, 5959.553033522481, 6050.788222412217, 6065.454109130177, 6073.969630151865, 5959.672218028007, 5973.4623883850445, 5982.3120341160675, 6039.6980150992495, 6122.785702500413, 6025.035994240922, 6093.207882975207, 6102.267727872661, 6118.235220597426, 6136.294326152505, 5922.082077277985, 6026.728797204137, 6042.486388656969, 6116.602420842631, 6120.051392034242, 5751.626144300607, 5796.043652797283, 5887.0, 5940.46535811779, 5955.225820643289, 6518.967405162991, 6544.770933017321, 6566.606003639797, 6603.438707709851, 6628.005799130169, 7078.292170782932, 7155.964220178866, 7177.031100801377, 7227.205007449176, 7245.601491917942, 7109.8222544436285, 7210.242924492957, 7210.67551960163, 7212.963935180343, 7304.74433394834, 6684.799456016327, 6686.0, 6690.33096690332, 6690.632015239111, 6691.063251144844, 7236.312550307713, 7353.0, 7370.8894366584545, 7456.962715186498, 7469.701211951461, 7036.542624729376, 7077.646117694095, 7099.148102227766, 7101.076860008269, 7167.784966451015, 7115.181754098241, 7186.46101542376, 7282.927170728331, 7338.192798792129, 7349.889751653729, 7114.395276401564, 7145.571265723969, 7152.356287934111, 7174.461915356369, 7188.784336469915, 7106.538075025107, 7144.535605185646, 7227.710891564278, 7230.0, 7231.602261875542, 5349.759260833272, 5358.54452371545, 5409.513143817076, 5428.619996600279, 5443.891122177534, 4848.5636292733825, 4853.150698627726, 4862.489438608965, 4915.827946021872, 4998.350214472095, 6743.325667433218, 6774.525783195228, 6777.322267773183, 6786.151731033621, 6792.184937807495, 7160.713571457188, 7174.282571742784, 7178.820529486805, 7180.102487189101, 7258.129024517092, 6530.738770449128, 6592.80221593353, 6678.79963601083, 6768.357006084414, 6770.255271920085, 6009.879802404015, 6021.638701677914, 6033.215681961317, 6042.577019608585, 6059.697015149225, 7437.739679111205, 7439.851202976019, 7511.737089201852, 7536.24637536242, 7574.356179724675, 7046.436285097282, 7066.293370662893, 7167.247439018828, 7193.820154496179, 7195.568265904062, 7364.079490063527, 7366.889496657447, 7450.888236676563, 7475.925240747523, 7481.738139165103, 7124.358807707331, 7148.249433809375, 7178.856422871618, 7188.173360063451, 7197.712091516491, 7233.493655444279, 7323.487355885037, 7325.194228634952, 7345.742898998509, 7346.228645992308, 6942.757003504853, 6960.756373526902, 7032.331928466788, 7053.224145344111, 7060.8940865886025, 6694.59832410057, 6761.256261811295, 6917.619530925847, 6922.965385173244, 7008.544444611084, 6896.793096207121, 6920.515563910478, 6925.238223795479, 6928.653567321715, 6929.02993580889, 6912.758053468105, 7053.435725142079, 7059.18819335783, 7071.36357727807, 7081.468889833386, 6764.255931847394, 6785.982102684637, 6789.253182149861, 6884.621345826027, 6907.481938854506], "value": 6596.143389784146, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [967.540418301307, 974.2839013325209, 994.4729293474458, 1015.6800607808535, 1028.126092821102, 45637.57718171134, 46083.76958115213, 46386.30420543694, 46419.0, 46544.999999999956, 43505.78247108768, 43559.78220108895, 43566.0, 43830.0, 43959.78020109895, 8185.386096042806, 8280.792980175484, 8291.33669306454, 8307.127751586087, 8307.543085130315, 8095.6761729531045, 8112.067112282075, 8132.674693012273, 8136.14570470101, 8162.6734930603, 8510.48937063775, 8819.118088191162, 8839.95580022099, 8842.336824738139, 8848.646054157825, 8701.738947831544, 8771.868421973675, 8772.03507614162, 8773.078826723166, 8783.560821958908, 8712.172343627408, 8721.258693011101, 8763.211310982042, 8798.252148567379, 8813.779655508664, 41655.58344416547, 41673.583264167275, 41912.79043604793, 41942.58057419417, 42020.78989605063, 3810.8856734297738, 3848.172642881766, 3848.288066707668, 3849.441830934527, 3855.2289542091694, 33270.667293327, 33299.167520811934, 33408.33183336344, 33487.66512334894, 33510.49734253988, 5423.674579525241, 5512.310961129859, 5564.081926482126, 5568.749406276727, 5574.554035677136, 226176.0, 226228.0, 226559.0, 227315.86342068348, 227516.0, 52643.210351844755, 52744.20883686748, 52978.20532692013, 53003.734981325615, 53008.734956325745, 54869.0, 55283.72358138183, 55402.72298638481, 55591.72204139034, 55616.443835561935, 17622.91188544049, 18087.276508939496, 18133.0, 18139.818601814077, 18141.0, 14847.554573362817, 14956.0, 15033.323500442506, 15050.247487625575, 15073.924630376778, 15096.698066038618, 15526.9223653881, 15638.765418518731, 15644.530664080095, 15651.921740391454, 5981.850453738692, 6002.6698531580305, 6020.759169633166, 6023.518118550505, 6243.875122497525, 1088.1240601316017, 1091.5197313182175, 1094.7865166292656, 1103.2773533335678, 1108.684025052856, 26370.20889373322, 26460.47079058408, 26540.60189097165, 26597.867010664824, 26597.86701066521, 1189.5598628507335, 1217.4764851113928, 1219.2379762648345, 1234.5802427174804, 1239.4980033086615, 13961.371738271802, 14013.859861401255, 14063.85936140646, 14067.226302553254, 14086.366113524917, 271192.0, 302213.0, 304039.0, 308830.0, 309180.0, 63925.36074639287, 64369.67815160894, 64664.0, 64899.67550162219, 64955.0, 1512.3345727879698, 1542.437010491185, 1550.9146996915051, 1559.8518140776607, 1566.8511491408299, 31003.069907902798, 31292.374152516368, 31598.36803263876, 31604.0, 32384.0, 44702.55297447114, 44975.550244497135, 45113.32330015118, 45125.77437112793, 45177.774111129234, 269600.0, 271238.0, 271258.0, 271272.0, 271614.0, 37696.246075078896, 38737.80631096826, 38829.6117038826, 39273.80363098166, 39286.607133929436, 46996.295055574876, 48356.274655880894, 49049.75475122601, 49116.75441622769, 49211.75394123006, 35444.0, 35650.643493564734, 35707.82146089253, 36115.458268125476, 36185.81907090448, 35139.82430087936, 35607.82196089003, 35682.0, 35833.64166358407, 36158.457623135146, 41364.79317603393, 41411.378829318186, 41578.37632435576, 41752.58247417487, 41993.160136797705, 34554.13614659654, 34779.82610086934, 34850.0, 35035.29929401448, 35139.82430087833, 26091.73908260969, 26693.599596006465, 26836.038532265477, 26984.32539186536, 27241.182764517096], "value": 19434.573711379126, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.0891586033831, 635.4579746590582, 637.1338658920358, 642.2739229954561, 648.0280516252484, 24613.507729845416, 25518.362040948963, 25613.231603051892, 25621.743782562167, 25643.23070307889, 27842.30394240145, 28178.154655360373, 28462.146135615963, 28491.287717807012, 28515.287117822012, 6328.588641738295, 6803.285655006227, 6841.62371069591, 6842.0, 6842.178938527383, 6643.933560664404, 6706.865862682744, 6714.160729908762, 6714.19429668438, 6724.932750672504, 6526.379993900572, 6695.296993815652, 6696.83257918551, 6762.628055456948, 6782.152230971129, 6842.623655698934, 6848.6918088686125, 6874.243833178346, 6884.621345825977, 6908.240093589701, 6425.485961123146, 6438.3883531064475, 6441.0982462455295, 6449.774257900951, 6450.096986421858, 30707.385852283052, 31105.066847994596, 31661.683383166102, 31727.365452690818, 31837.363252734816, 2437.402836305099, 2496.9375765605823, 2497.2757900208917, 2498.5002999400194, 2499.0378704198833, 20536.486587835276, 21069.5786084279, 21169.788302116936, 21176.258830941, 21185.89407052955, 2591.5335239656856, 2660.773834224093, 2674.1041751013436, 2686.3418462476625, 2697.581874809388, 139109.3044534771, 144332.0, 144803.0, 161811.0, 169533.15233423753, 16684.24920878539, 17372.565685857702, 17501.299948002194, 17510.91244543769, 17659.823401766076, 27045.729542704714, 27145.185644430305, 27266.591001135, 27377.589336159974, 27449.86275068612, 11406.144539159597, 11626.76746465066, 11651.30092194471, 11689.123315751352, 11732.648020559396, 10665.200109991782, 10707.0, 10745.14038876888, 10805.405702686428, 10806.945965270123, 10047.598096076075, 10197.286189966779, 10262.384256944608, 10298.867124616287, 10470.528826202839, 3013.246688327918, 3042.680518545565, 3136.8745250190195, 3136.9372612547622, 3181.920451988719, 1041.953112109957, 1053.3574519543072, 1060.9734756630992, 1062.0229388962018, 1078.735709751116, 21117.577648446946, 21565.13739450436, 21588.0, 21934.561308773737, 22193.22323718662, 1142.2404101272728, 1154.6478324111226, 1159.7390587117832, 1163.5811108001112, 1166.1079274355125, 11922.225055371373, 11949.283043017447, 12129.696757580954, 12248.571300004634, 12261.203021803554, 548873.0, 586415.0, 590360.0, 595626.0, 622828.0, 128243.35878320549, 130226.34886825505, 136140.0, 138562.0, 138610.30694846663, 1282.7242142939313, 1284.1524593768067, 1312.652147181017, 1313.0677219174493, 1316.7827308494184, 18997.810021899604, 19262.24411113632, 19267.614647706687, 19412.2235110594, 19442.611147776683, 62515.062274065014, 62702.37297627148, 63555.6822215886, 64048.0, 64407.677961609894, 76822.23177768374, 77808.0, 80439.59780201061, 81274.18725812667, 81853.59073204595, 16405.179741012664, 16507.422240221535, 16552.66894662076, 16686.0, 16893.66212675764, 24757.62863557012, 24802.751972480044, 25045.49909001846, 25120.497590047733, 25417.237482875542, 20572.69140962857, 20580.27969021077, 20600.55796094259, 20693.0, 20900.0, 17837.821621783616, 18071.0, 18198.909005454887, 18211.54471138232, 18766.437006889813, 20723.585528289652, 20875.0, 21153.788462115182, 21164.4708882273, 21327.253546125812, 16229.67540649204, 16350.264238109075, 16423.42518011864, 16442.424515141913, 16454.177291135635, 20321.390358289274, 20462.386128416172, 20576.176952921716, 20649.69025464589, 20757.688634670794], "value": 13284.149815090632, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.408202636919, 1504.811898512686, 1517.1883042572226, 1518.1270769307644, 1526.2521364531376, 16958.0, 17916.28334866607, 17927.731084033734, 17956.82043179571, 17982.5504362391, 17287.30850765971, 17427.5643108922, 17490.737638935396, 17502.562435939075, 17557.91221043893, 2945.2195168280423, 2998.0705981145916, 3039.60485136933, 3046.84765761711, 3048.2074660588187, 2817.0844475545528, 2865.28367908023, 2872.827630342176, 2874.78439117066, 2877.9136625901256, 2938.8824447022203, 2940.3825196708717, 2988.357503136825, 2991.0, 2995.8052726572705, 2786.0, 2805.4529366773486, 2811.550151975674, 2814.7326004029583, 2818.6758522769837, 2793.69269380368, 2830.80184387093, 2833.5607980763016, 2834.6598408190944, 2836.2342167614834, 16623.335066597323, 17001.0, 17029.65940681192, 17035.318587256494, 17036.14819259032, 8334.708285210048, 8383.035950865667, 8591.3556483264, 8620.310375169971, 8665.39342246043, 5433.266509021271, 5497.833572949573, 5644.971775141139, 5858.41415858415, 6161.845953851145, 2209.193644319828, 2215.3021798133536, 2217.6049866144685, 2251.110811229555, 2254.334971183505, 27610.447791044066, 28861.71138288611, 30891.0, 32201.1949701257, 32261.0, 7430.108386993596, 7439.181690014094, 7594.544327340377, 7609.391248700091, 7743.4966727162555, 23958.161464348665, 24085.7591424087, 24169.0, 24178.153764618153, 24184.637230441556, 8593.871091933626, 8676.652933882575, 8737.126287371211, 8783.341249406192, 8943.329250306253, 7647.502912310682, 8046.131820880027, 8168.795780105426, 8198.057223419264, 8263.710770123016, 6220.595661282002, 6273.1844860167885, 6344.809655710336, 6402.0, 6402.231732192166, 1900.923963041463, 1918.7793403758467, 1920.5909510618762, 1930.8744931579402, 1933.58427937994, 1018.7045756730613, 1029.1149611334247, 1034.3897100710617, 1034.4775888176423, 1049.559185142242, 9144.268458523302, 9166.679166229284, 9238.399504032217, 9241.260699144052, 9311.860322095174, 832.3549249331817, 847.372944021432, 849.9957500212583, 852.9019162796358, 873.8121303919688, 5523.834284971457, 5575.804846830341, 5648.519875810603, 5662.320521537442, 5678.914816277759, 25883.352916177246, 26218.606720899203, 27481.725182747916, 27498.587521187197, 27528.862355688092, 25479.0, 26449.206523804318, 26658.866705666347, 26773.330666733487, 26814.329641758723, 11095.098708979223, 12880.613581592566, 12953.028522860823, 12979.610611681665, 13116.475340986253, 10748.516316765608, 10826.350418974887, 10834.837477437686, 10898.782024359627, 10909.0, 22024.44938876477, 22469.43826404353, 22535.661965070864, 22626.547469050856, 23321.416964576023, 22573.774262257168, 22863.31410057701, 23065.0, 23573.29280121599, 23638.0, 13859.168449893039, 13884.652883677989, 13922.72154556883, 13968.930155349159, 14117.788233176716, 16006.439774607832, 16121.113338766012, 16169.0, 16190.190490475665, 16262.593435164215, 12001.63995080114, 12060.276383417024, 12179.512819487121, 12281.815772763237, 12463.0, 13004.21974681522, 13090.410931507915, 13222.669433264246, 13293.80059299092, 13311.400986955803, 10768.246222764332, 10896.400697961371, 10920.890791091988, 10952.780944381228, 10958.178136639943, 8272.33821294307, 8281.29608983243, 8336.124706905688, 8361.414700971118, 8371.288440482627, 8347.207015333533, 8426.536540490331, 8453.830923381622, 8515.446495977742, 8535.189157030072], "value": 7609.091664279104, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.5435297409101, 579.6927628356972, 585.1690599348923, 602.912577676237, 610.3865615056867, 6393.680315984206, 6424.2612099608505, 6492.772752953648, 6542.149520562332, 6543.738250469975, 6369.681515924197, 6402.390278999125, 6413.198350206224, 6421.389967953037, 6486.708098135583, 5311.2298716686055, 5316.680999140045, 5322.574194064485, 5327.653702509344, 5341.145416733323, 5034.144195486776, 5170.603936937025, 5274.26160337553, 5308.734563271841, 5338.386085600167, 5163.302954101186, 5169.224616307546, 5183.611229157809, 5200.479952004807, 5204.141316682742, 5056.8482945511505, 5105.923411148836, 5132.486751324856, 5149.356330458692, 5181.53366197044, 4713.198756211452, 4752.358431611723, 4761.428628564595, 4767.499412561666, 4780.641451891087, 6314.463270621956, 6337.397947195009, 6341.904871426932, 6378.744850205986, 6408.519361047894, 6067.362926892657, 6073.240844894388, 6120.326764055951, 6122.96938515309, 6123.87752244957, 6824.522283440161, 6836.179658440969, 6853.623050732208, 6855.897161542581, 6856.314368563154, 5208.869778255536, 5242.580593552507, 5264.947350526484, 5265.3681558212875, 5268.0, 6918.273581273944, 6927.896081558781, 7087.3267039631155, 7088.3974862136265, 7108.075950126502, 5331.840044798662, 5362.383325917569, 5363.919541206885, 5401.702906340189, 5433.67397956116, 5441.265429167091, 5483.369412517612, 5512.751926163332, 5518.696471694015, 5528.75120619573, 5991.670458124845, 6000.129981152709, 6017.969910150508, 6035.486983606354, 6112.51099912006, 6757.8648427031185, 6844.726210951606, 6867.587944723333, 6920.861582768316, 6955.6869940852785, 1872.8969906655266, 1875.681134207188, 1898.642470633476, 1901.7622797150357, 1916.1951980168362, 1301.6875949771986, 1307.8692130787035, 1350.770369037266, 1362.8841548468292, 1366.631009627395, 6294.0558916162945, 6380.617162970237, 6382.234131904202, 6387.265464471552, 6400.615963042233, 6728.226253980855, 6848.794536163923, 6868.210155832143, 6890.586564806128, 6944.791656250321, 6255.593386429868, 6313.40022697843, 6356.141920840627, 6395.232572091379, 6412.839679008062, 3652.926941461156, 3658.7804731716183, 3662.1760103976394, 3663.3405986922608, 3677.7793332400142, 7161.606111663804, 7186.496945213889, 7191.065161528968, 7200.387967022757, 7249.637518124073, 6963.1644202696, 7018.859622807618, 7031.296870312928, 7066.258042905523, 7076.752313668997, 7101.62095697947, 7146.3568278855155, 7175.748848790267, 7194.676239569128, 7212.639368031578, 6903.551269167488, 6971.337722916315, 7013.22854485996, 7014.0, 7014.929850701427, 6806.319368063154, 6901.689423975833, 6911.688973996082, 6921.757738479129, 6958.443324534126, 7205.531640443354, 7226.74706385274, 7237.63811809418, 7240.52936559122, 7282.980382746526, 5337.8131765388025, 5373.328333958255, 5420.4037555868035, 5429.53848922846, 5453.454654534515, 6510.967445162744, 6629.105070815378, 6883.552569082994, 6969.965150174216, 6974.79075627732, 6605.207375115017, 6609.570377925419, 6715.26132125456, 6741.460683145238, 6746.6626668665385, 6581.407673309425, 6648.434883034996, 6697.7655782047395, 6699.76550820719, 6802.217744959195, 6490.221173459215, 6574.572652777554, 6683.8663226734225, 6685.0306705526455, 6707.631080290631, 6668.233153187445, 6689.464842812466, 6718.361755633207, 6775.559588626724, 6792.762253321308, 6566.967165164335, 6592.70332835014, 6609.537332386687, 6611.305812889577, 6647.0], "value": 5346.543353735627, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [988.6836212412031, 1018.2973748113801, 1021.3361315145155, 1045.5504133222717, 1063.2132222155606, 20302.492437689045, 20744.377668669964, 20775.792242077576, 20811.895940520313, 20872.0, 17260.0, 17544.912275438637, 17636.47090587281, 17824.465266042007, 18047.458576242734, 1048.543883410715, 1068.4070340960764, 1068.9412082335468, 1074.457399013499, 1075.1237741240902, 1054.9894501055007, 1091.0, 1091.3942761767216, 1093.830456279274, 1097.5280629329386, 1163.7323415614414, 1166.125405945541, 1166.5450474314982, 1166.9824952625718, 1167.474636413613, 1158.5481662151767, 1162.517555214585, 1163.5345861655405, 1165.021382039087, 1165.4697112813649, 861.1302584389749, 862.598891515442, 864.0236532717988, 865.3812524045275, 866.3632230310717, 18524.722129168073, 20169.193232270693, 20724.067416966274, 20897.791022089736, 21007.369778906657, 20967.26614568483, 21099.894500527553, 21580.460488487755, 21584.0, 21630.134794608195, 16381.262843172086, 16492.670146597, 17106.31574737009, 17210.311587536482, 17285.740713889303, 3994.141259629194, 4141.627253547195, 4159.500859896802, 4165.187788381237, 4174.08170202558, 164729.0, 167336.0, 167812.16093919575, 168839.15580422143, 169924.0, 17948.910255448638, 18419.72370414445, 18449.354272600394, 18539.258429662932, 18548.350807721665, 36018.63981360153, 36559.4516082259, 36745.08137296589, 36959.0, 37054.62945370566, 9786.608535658635, 9823.0, 10043.146332561668, 10050.195984321237, 10056.0, 5064.974675126675, 5093.694378337312, 5119.897602047939, 5149.433562308143, 5151.6908985461, 6246.500279977591, 6316.115743795872, 6345.746170153142, 6363.268224154189, 6430.614163150226, 1165.5862168929907, 1167.5096459486865, 1196.6469891382062, 1199.4962115911337, 1199.7120691034263, 671.1878626861454, 680.6290571638469, 687.4809518813264, 689.4484412470003, 695.2109355881112, 11591.884081159249, 11606.825897611543, 11829.171957963032, 11907.106966977512, 11931.04551635867, 759.8860170974287, 763.8319569694659, 765.762613589789, 766.4864540757706, 771.7877583664538, 5740.454656807597, 5759.913601295984, 5812.331581868055, 5885.411458854081, 5914.0537513998415, 149193.0, 149673.0, 151034.0, 153512.0, 153671.0, 127536.36231818967, 128463.0, 128714.0, 129946.35026824805, 130486.0, 113893.0, 114225.4288728551, 115154.0, 117225.0, 117617.0, 10963.0, 11077.612283570037, 11200.551977921117, 11229.101671866069, 11421.942890285496, 59974.70012649909, 60113.39886601078, 60457.0, 60742.0, 60971.39028609657, 75091.87362189681, 75762.0, 76503.61748191224, 78485.0, 79470.20529794628, 15058.472953446577, 15172.165530895907, 15224.923875380553, 15289.159096249814, 15299.77050344268, 16753.329866805678, 16838.326466941184, 16850.07324597159, 16853.915730421268, 16880.324787008383, 15165.620859478602, 15721.0, 15773.132477713836, 15923.124228167562, 15968.600784980468, 14058.297085145497, 14180.929095354457, 14181.503647372292, 14243.430262789372, 14377.0, 15252.847471525587, 15328.156951367337, 15344.846551534341, 15459.690806184039, 15476.613084672974, 11329.69708483535, 11351.48918298695, 11592.188546801643, 12007.939960300142, 12115.878841211475, 12001.219920705475, 12128.757424851277, 12194.085443591943, 12484.937575312066, 12546.87453125457], "value": 9718.251610478448, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1351.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 106.0, 105.0, 105.0, 105.0, 106.0, 106.0, 107.0, 105.0, 105.0], "value": 105.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 111.0, 112.0, 113.0, 136.0, 124.0, 115.0, 110.0, 111.0], "value": 115.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 163.0, 162.0, 161.0, 161.0, 161.0, 163.0, 162.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 76.0, 73.0, 72.0, 74.0, 73.0, 73.0, 73.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 77.0, 77.0, 77.0, 77.0, 77.0, 78.0, 77.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 147.0, 150.0, 149.0, 147.0, 149.0, 148.0, 147.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 93.0, 94.0, 94.0, 98.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 44.0, 43.0, 44.0, 44.0, 42.0, 45.0, 44.0, 45.0, 45.0], "value": 43.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 39.0, 38.0, 38.0, 39.0, 38.0, 42.0, 39.0, 38.0], "value": 38.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 69.0, 72.0, 69.0, 70.0, 69.0, 68.0, 69.0, 69.0, 69.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 103.0, 102.0, 108.0, 104.0, 105.0, 110.0, 102.0, 101.0, 97.0], "value": 104.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 143.0, 148.0, 148.0, 146.0, 148.0, 142.0, 145.0, 150.0, 149.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 56.0, 61.0, 64.0, 54.0, 62.0, 61.0, 58.0, 59.0, 60.0], "value": 59.6, "unit": "score"}]}]} 11:24:48 INFO - Return code: 0 11:24:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:24:48 INFO - # TBPL SUCCESS # 11:24:48 INFO - Running post-action listener: _package_coverage_data 11:24:48 INFO - Running post-action listener: _resource_record_post_action 11:24:48 INFO - [mozharness: 2017-09-22 18:24:48.670749Z] Finished run-tests step (success) 11:24:48 INFO - Running post-run listener: _resource_record_post_run 11:24:48 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291790848; Read time: 20; Write time: 199880 11:24:48 INFO - TinderboxPrint: CPU usage
13.0% 11:24:48 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 11:24:48 INFO - TinderboxPrint: I/O write bytes / time
291,790,848 / 199,880 11:24:48 INFO - TinderboxPrint: CPU idle
8,181.5 (86.9%) 11:24:48 INFO - TinderboxPrint: CPU user
1,177.7 (12.5%) 11:24:48 INFO - TinderboxPrint: Swap in / out
0 / 0 11:24:48 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 8986624; Read time: 0; Write time: 628 11:24:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:24:48 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 8192; Write bytes: 282804224; Read time: 20; Write time: 199252 11:24:49 INFO - Running post-run listener: _upload_blobber_files 11:24:49 INFO - Blob upload gear active. 11:24:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:24:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:24:49 INFO - (blobuploader) - INFO - Open directory for files ... 11:24:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:24:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:24:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:50 INFO - (blobuploader) - INFO - Done attempting. 11:24:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:24:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:24:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:51 INFO - (blobuploader) - INFO - Done attempting. 11:24:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:24:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:24:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:55 INFO - (blobuploader) - INFO - Done attempting. 11:24:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:24:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:24:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:56 INFO - (blobuploader) - INFO - Done attempting. 11:24:56 INFO - (blobuploader) - INFO - Iteration through files over. 11:24:56 INFO - Return code: 0 11:24:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:24:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:24:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/31dff6c6de774adb938bc459cf14698e32c3035ee8da5de62bf6719695a47a9b1e0eb68d01b666bde1b3c75efbfa1c1ec923999e5a42f9c18dc4df1be42ae351", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e160577d6ad1773692fd0aa89a2b16844d4ca3747af3ea3a2814dfd00f1ec2ebf6938598e8043b8c7dcdfedd533c7eb9844849b1c888f4c61cb37f63cfc23b00", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e3cbc343d611ec91f7180a3ed96415db7ea18ce5f01abc8ee890453921afd85901d4351204cc226961832a8f620b84d8ac861622db74402ddf0f31448e8f7181", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6a75a49475257d712d67a07693ad6a5e68835578eea0af10afb2c189a4aaaec9ac684ade2f82f41238c5efe8afb93a807c35e5f1c0ababf45acd8693804a5e79"} 11:24:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:24:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:24:56 INFO - Contents: 11:24:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/31dff6c6de774adb938bc459cf14698e32c3035ee8da5de62bf6719695a47a9b1e0eb68d01b666bde1b3c75efbfa1c1ec923999e5a42f9c18dc4df1be42ae351", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e160577d6ad1773692fd0aa89a2b16844d4ca3747af3ea3a2814dfd00f1ec2ebf6938598e8043b8c7dcdfedd533c7eb9844849b1c888f4c61cb37f63cfc23b00", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e3cbc343d611ec91f7180a3ed96415db7ea18ce5f01abc8ee890453921afd85901d4351204cc226961832a8f620b84d8ac861622db74402ddf0f31448e8f7181", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6a75a49475257d712d67a07693ad6a5e68835578eea0af10afb2c189a4aaaec9ac684ade2f82f41238c5efe8afb93a807c35e5f1c0ababf45acd8693804a5e79"} 11:24:56 INFO - Running post-run listener: copy_logs_to_upload_dir 11:24:56 INFO - Copying logs to upload dir... 11:24:56 INFO - mkdir: /builds/slave/test/build/upload/logs 11:24:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.944362 ========= master_lag: 2.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-09-22 11:24:58.810683) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-09-22 11:24:58.814935) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/31dff6c6de774adb938bc459cf14698e32c3035ee8da5de62bf6719695a47a9b1e0eb68d01b666bde1b3c75efbfa1c1ec923999e5a42f9c18dc4df1be42ae351", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e160577d6ad1773692fd0aa89a2b16844d4ca3747af3ea3a2814dfd00f1ec2ebf6938598e8043b8c7dcdfedd533c7eb9844849b1c888f4c61cb37f63cfc23b00", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e3cbc343d611ec91f7180a3ed96415db7ea18ce5f01abc8ee890453921afd85901d4351204cc226961832a8f620b84d8ac861622db74402ddf0f31448e8f7181", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6a75a49475257d712d67a07693ad6a5e68835578eea0af10afb2c189a4aaaec9ac684ade2f82f41238c5efe8afb93a807c35e5f1c0ababf45acd8693804a5e79"} build_url:https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/AZ65th0vQIiBXDGdF3v13Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/31dff6c6de774adb938bc459cf14698e32c3035ee8da5de62bf6719695a47a9b1e0eb68d01b666bde1b3c75efbfa1c1ec923999e5a42f9c18dc4df1be42ae351", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e160577d6ad1773692fd0aa89a2b16844d4ca3747af3ea3a2814dfd00f1ec2ebf6938598e8043b8c7dcdfedd533c7eb9844849b1c888f4c61cb37f63cfc23b00", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e3cbc343d611ec91f7180a3ed96415db7ea18ce5f01abc8ee890453921afd85901d4351204cc226961832a8f620b84d8ac861622db74402ddf0f31448e8f7181", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6a75a49475257d712d67a07693ad6a5e68835578eea0af10afb2c189a4aaaec9ac684ade2f82f41238c5efe8afb93a807c35e5f1c0ababf45acd8693804a5e79"}' ========= master_lag: 1.49 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-09-22 11:25:00.321199) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:25:00.321609) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1506100723.675535-1256169262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:25:00.469521) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 11:25:00.469868) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 11:25:00.945877) ========= ========= Total master_lag: 4.15 =========