builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-040 starttime: 1505342543.2 results: success (0) revision: b9ffb07cf8e71b1f4285ec7741f6b2f8256dc79d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:23.199673) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:23.200101) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:23.202434) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:23.221624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:23.221974) ========= 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-1505342541.595682-1789722209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 15:42:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.3M=0s 2017-09-13 15:42:23 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.079943 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:23.318833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:23.319140) ========= 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-1505342541.595682-1789722209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022225 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:23.375217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:23.375572) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b9ffb07cf8e71b1f4285ec7741f6b2f8256dc79d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev b9ffb07cf8e71b1f4285ec7741f6b2f8256dc79d --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-1505342541.595682-1789722209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 15:42:23,460 truncating revision to first 12 chars 2017-09-13 15:42:23,460 Setting DEBUG logging. 2017-09-13 15:42:23,460 attempt 1/10 2017-09-13 15:42:23,460 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b9ffb07cf8e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 15:42:23,949 unpacking tar archive at: mozilla-central-b9ffb07cf8e7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.764113 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:24.161117) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:24.161431) ========= script_repo_revision: b9ffb07cf8e71b1f4285ec7741f6b2f8256dc79d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:24.162935) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:24.163206) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:24.178488) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-13 15:42:24.178769) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1505342541.595682-1789722209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:42:24 INFO - MultiFileLogger online at 20170913 15:42:24 in /builds/slave/test 15:42:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:42:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:42:24 INFO - {'append_to_log': False, 15:42:24 INFO - 'base_work_dir': '/builds/slave/test', 15:42:24 INFO - 'blob_upload_branch': 'Firefox', 15:42:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:42:24 INFO - 'branch': 'Firefox', 15:42:24 INFO - 'buildbot_json_path': 'buildprops.json', 15:42:24 INFO - 'code_coverage': False, 15:42:24 INFO - 'config_files': ('talos/linux_config.py',), 15:42:24 INFO - 'default_actions': ('clobber', 15:42:24 INFO - 'read-buildbot-config', 15:42:24 INFO - 'download-and-extract', 15:42:24 INFO - 'populate-webroot', 15:42:24 INFO - 'create-virtualenv', 15:42:24 INFO - 'install', 15:42:24 INFO - 'setup-mitmproxy', 15:42:24 INFO - 'run-tests'), 15:42:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:42:24 INFO - 'disable_ccov_upload': False, 15:42:24 INFO - 'disable_stylo': False, 15:42:24 INFO - 'download_minidump_stackwalk': True, 15:42:24 INFO - 'download_symbols': 'ondemand', 15:42:24 INFO - 'enable_stylo': False, 15:42:24 INFO - 'enable_webrender': False, 15:42:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:42:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:42:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:42:24 INFO - 'gecko_profile': False, 15:42:24 INFO - 'gecko_profile_interval': 0, 15:42:24 INFO - 'installer_path': 'installer.exe', 15:42:24 INFO - 'log_level': 'info', 15:42:24 INFO - 'log_name': 'talos', 15:42:24 INFO - 'log_to_console': True, 15:42:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:42:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:42:24 INFO - 'opt_config_files': (), 15:42:24 INFO - 'pip_index': False, 15:42:24 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:42:24 INFO - 'system_bits': '32', 15:42:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:42:24 INFO - 'title': 'talos-linux64-ix-040', 15:42:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:42:24 INFO - 'use_talos_json': True, 15:42:24 INFO - 'verify': 'False', 15:42:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:42:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:42:24 INFO - 'work_dir': 'build'} 15:42:24 INFO - [mozharness: 2017-09-13 22:42:24.397680Z] Running clobber step. 15:42:24 INFO - Running pre-action listener: _resource_record_pre_action 15:42:24 INFO - Running main action method: clobber 15:42:24 INFO - rmtree: /builds/slave/test/build 15:42:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:42:25 INFO - Running post-action listener: _resource_record_post_action 15:42:25 INFO - [mozharness: 2017-09-13 22:42:25.934229Z] Finished clobber step (success) 15:42:25 INFO - [mozharness: 2017-09-13 22:42:25.934342Z] Running read-buildbot-config step. 15:42:25 INFO - Running pre-action listener: _resource_record_pre_action 15:42:25 INFO - Running main action method: read_buildbot_config 15:42:25 INFO - Using buildbot properties: 15:42:25 INFO - { 15:42:25 INFO - "project": "", 15:42:25 INFO - "product": "firefox", 15:42:25 INFO - "who": "kwierso@gmail.com", 15:42:25 INFO - "installer_path": "public/build/target.tar.bz2", 15:42:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:42:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:42:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 15:42:25 INFO - "stage_platform": "linux64-pgo", 15:42:25 INFO - "basedir": "/builds/slave/test", 15:42:25 INFO - "buildnumber": 6, 15:42:25 INFO - "platform": "ubuntu64_hw", 15:42:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:42:25 INFO - "slavebuilddir": "test", 15:42:25 INFO - "taskId": "MRLqzTDlSzqv3e6rQu9p1g", 15:42:25 INFO - "branch": "mozilla-central", 15:42:25 INFO - "script_repo_revision": "production", 15:42:25 INFO - "revision": "b9ffb07cf8e71b1f4285ec7741f6b2f8256dc79d", 15:42:25 INFO - "slavename": "talos-linux64-ix-040", 15:42:25 INFO - "repo_path": "mozilla-central" 15:42:25 INFO - } 15:42:25 INFO - Finding installer, test and symbols from parent task. 15:42:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MRLqzTDlSzqv3e6rQu9p1g'}, attempt #1 15:42:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MRLqzTDlSzqv3e6rQu9p1g'}, attempt #1 15:42:26 INFO - Task dependencies: HsqTY3hiS4-L2Rh95Ht4ag 15:42:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag'}, attempt #1 15:42:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.tar.bz2 15:42:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.test_packages.json 15:42:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.crashreporter-symbols.zip 15:42:27 INFO - Running post-action listener: _resource_record_post_action 15:42:27 INFO - [mozharness: 2017-09-13 22:42:27.358615Z] Finished read-buildbot-config step (success) 15:42:27 INFO - [mozharness: 2017-09-13 22:42:27.358830Z] Running download-and-extract step. 15:42:27 INFO - Running pre-action listener: _resource_record_pre_action 15:42:27 INFO - Running main action method: download_and_extract 15:42:27 INFO - mkdir: /builds/slave/test/build/tests 15:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:27 INFO - trying https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.test_packages.json 15:42:27 INFO - Downloading https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:42:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:42:27 INFO - Downloaded 989 bytes. 15:42:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:42:27 INFO - Using the following test package requirements: 15:42:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:42:27 INFO - u'common': [u'target.common.tests.zip'], 15:42:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:42:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:42:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:42:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:42:27 INFO - u'mozbase': [u'target.common.tests.zip'], 15:42:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:42:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:42:27 INFO - u'web-platform': [u'target.common.tests.zip', 15:42:27 INFO - u'target.web-platform.tests.tar.gz'], 15:42:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:42:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:42:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.common.tests.zip 15:42:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:42:27 INFO - Fetch https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.common.tests.zip into memory 15:42:29 INFO - Content-Length response header: 55126825 15:42:29 INFO - Bytes received: 55126825 15:42:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.talos.tests.zip 15:42:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:42:39 INFO - Fetch https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.talos.tests.zip into memory 15:42:40 INFO - Content-Length response header: 14499226 15:42:40 INFO - Bytes received: 14499226 15:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:40 INFO - trying https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.tar.bz2 15:42:40 INFO - Downloading https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:42:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:42:42 INFO - Downloaded 62205794 bytes. 15:42:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.tar.bz2 15:42:42 INFO - mkdir: /builds/slave/test/properties 15:42:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:42:42 INFO - Writing to file /builds/slave/test/properties/build_url 15:42:42 INFO - Contents: 15:42:42 INFO - build_url:https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.tar.bz2 15:42:42 INFO - Running post-action listener: _resource_record_post_action 15:42:42 INFO - Running post-action listener: find_tests_for_verification 15:42:42 INFO - Running post-action listener: set_extra_try_arguments 15:42:42 INFO - [mozharness: 2017-09-13 22:42:42.521844Z] Finished download-and-extract step (success) 15:42:42 INFO - [mozharness: 2017-09-13 22:42:42.521945Z] Running populate-webroot step. 15:42:42 INFO - Running pre-action listener: _resource_record_pre_action 15:42:42 INFO - Running main action method: populate_webroot 15:42:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:42:42 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:42:42 INFO - 'tests': ['tresize', 15:42:42 INFO - 'tcanvasmark']}, 15:42:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:42:42 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:42:42 INFO - 'tests': ['dromaeo_css', 15:42:42 INFO - 'kraken']}, 15:42:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:42:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:42:42 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:42:42 INFO - 'talos_options': ['--disable-stylo'], 15:42:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:42:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:42:42 INFO - 'tests': ['damp', 'tps']}, 15:42:42 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:42:42 INFO - 'talos_options': ['--disable-stylo'], 15:42:42 INFO - 'tests': ['damp', 'tps']}, 15:42:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:42:42 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:42:42 INFO - 'tests': ['dromaeo_dom']}, 15:42:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:42:42 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:42:42 INFO - 'tests': ['basic_compositor_video', 15:42:42 INFO - 'glvideo']}, 15:42:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:42:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:42:42 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:42:42 INFO - 'talos_options': ['--disable-stylo'], 15:42:42 INFO - 'tests': ['ts_paint_webext', 15:42:42 INFO - 'tp5o_webext']}, 15:42:42 INFO - 'other-e10s': {'tests': ['a11yr', 15:42:42 INFO - 'ts_paint', 15:42:42 INFO - 'tpaint', 15:42:42 INFO - 'sessionrestore', 15:42:42 INFO - 'sessionrestore_many_windows', 15:42:42 INFO - 'sessionrestore_no_auto_restore', 15:42:42 INFO - 'tabpaint']}, 15:42:42 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:42:42 INFO - 'tests': ['a11yr', 15:42:42 INFO - 'ts_paint', 15:42:42 INFO - 'tpaint', 15:42:42 INFO - 'sessionrestore', 15:42:42 INFO - 'sessionrestore_many_windows', 15:42:42 INFO - 'sessionrestore_no_auto_restore', 15:42:42 INFO - 'tabpaint']}, 15:42:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:42:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:42:42 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:42:42 INFO - 'tests': ['bloom_basic_singleton']}, 15:42:42 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:42:42 INFO - 'tests': ['bloom_basic']}, 15:42:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:42:42 INFO - 'tsvgr_opacity', 15:42:42 INFO - 'tart', 15:42:42 INFO - 'tscrollx', 15:42:42 INFO - 'tsvg_static']}, 15:42:42 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:42:42 INFO - 'tests': ['tsvgx', 15:42:42 INFO - 'tsvgr_opacity', 15:42:42 INFO - 'tart', 15:42:42 INFO - 'tscrollx', 15:42:42 INFO - 'tsvg_static']}, 15:42:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:42:42 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:42:42 INFO - 'talos_options': ['--disable-stylo'], 15:42:42 INFO - 'tests': ['tp5o']}, 15:42:42 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:42:42 INFO - 'talos_options': ['--mitmproxy', 15:42:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:42:42 INFO - '--firstNonBlankPaint'], 15:42:42 INFO - 'tests': ['tp6_google', 15:42:42 INFO - 'tp6_youtube', 15:42:42 INFO - 'tp6_amazon', 15:42:42 INFO - 'tp6_facebook']}, 15:42:42 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:42:42 INFO - 'talos_options': ['--disable-stylo', 15:42:42 INFO - '--mitmproxy', 15:42:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:42:42 INFO - '--firstNonBlankPaint'], 15:42:42 INFO - 'tests': ['tp6_google', 15:42:42 INFO - 'tp6_youtube', 15:42:42 INFO - 'tp6_amazon', 15:42:42 INFO - 'tp6_facebook']}, 15:42:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:42:42 INFO - 'talos_options': ['--stylo-threads=1', 15:42:42 INFO - '--mitmproxy', 15:42:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:42:42 INFO - '--firstNonBlankPaint'], 15:42:42 INFO - 'tests': ['tp6_google', 15:42:42 INFO - 'tp6_youtube', 15:42:42 INFO - 'tp6_amazon', 15:42:42 INFO - 'tp6_facebook']}, 15:42:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:42:42 INFO - 'talos_options': ['--xperf_path', 15:42:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:42:42 INFO - 'tests': ['tp5n']}, 15:42:42 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:42:42 INFO - 'talos_options': ['--disable-stylo', 15:42:42 INFO - '--xperf_path', 15:42:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:42:42 INFO - 'tests': ['tp5n']}}} 15:42:42 INFO - Running post-action listener: _resource_record_post_action 15:42:42 INFO - [mozharness: 2017-09-13 22:42:42.537220Z] Finished populate-webroot step (success) 15:42:42 INFO - [mozharness: 2017-09-13 22:42:42.537309Z] Running create-virtualenv step. 15:42:42 INFO - Running pre-action listener: _resource_record_pre_action 15:42:42 INFO - Running main action method: create_virtualenv 15:42:42 INFO - Creating virtualenv /builds/slave/test/build/venv 15:42:42 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:42:42 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:42:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:42:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:42:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:42:43 INFO - Installing distribute.............................................................................................................................................................................................done. 15:42:43 INFO - Installing pip...............done. 15:42:43 INFO - Return code: 0 15:42:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:42:43 INFO - Reading from file tmpfile_stdout 15:42:43 INFO - Output received: 15:42:43 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:42:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:42:43 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')]} 15:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:43 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')]} 15:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:43 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 0xf5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1126a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd090>, '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 0x12cdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c7f90>, '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-1505342541.595682-1789722209', '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 15:42:43 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 15:42:43 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 15:42:43 INFO - Using env: {'DISPLAY': ':0', 15:42:43 INFO - 'HOME': '/home/cltbld', 15:42:43 INFO - 'LANG': 'en_US.UTF-8', 15:42:43 INFO - 'LANGUAGE': 'en_US:en', 15:42:43 INFO - 'LOGNAME': 'cltbld', 15:42:43 INFO - 'MAIL': '/var/mail/cltbld', 15:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:43 INFO - 'MOZ_NO_REMOTE': '1', 15:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:43 INFO - 'NO_EM_RESTART': '1', 15:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:43 INFO - 'PWD': '/builds/slave/test', 15:42:43 INFO - 'SHELL': '/bin/bash', 15:42:43 INFO - 'SHLVL': '1', 15:42:43 INFO - 'TERM': 'linux', 15:42:43 INFO - 'TMOUT': '86400', 15:42:43 INFO - 'USER': 'cltbld', 15:42:43 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1505342541.595682-1789722209', 15:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:43 INFO - '_': '/tools/buildbot/bin/python'} 15:42:44 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:42:44 INFO - Downloading/unpacking pip>=1.5 15:42:44 INFO - Running setup.py egg_info for package pip 15:42:44 INFO - warning: no files found matching 'pip/cacert.pem' 15:42:44 INFO - warning: no files found matching '*.html' under directory 'docs' 15:42:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:42:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:42:44 INFO - Installing collected packages: pip 15:42:44 INFO - Found existing installation: pip 1.1 15:42:44 INFO - Uninstalling pip: 15:42:44 INFO - Successfully uninstalled pip 15:42:44 INFO - Running setup.py install for pip 15:42:44 INFO - warning: no files found matching 'pip/cacert.pem' 15:42:44 INFO - warning: no files found matching '*.html' under directory 'docs' 15:42:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:42:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:42:44 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:42:44 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:42:44 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:42:44 INFO - Successfully installed pip 15:42:44 INFO - Cleaning up... 15:42:44 INFO - Return code: 0 15:42:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:42:44 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')]} 15:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:44 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')]} 15:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:44 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 0xf5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1126a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd090>, '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 0x12cdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c7f90>, '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-1505342541.595682-1789722209', '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 15:42:44 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 15:42:44 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 15:42:44 INFO - Using env: {'DISPLAY': ':0', 15:42:44 INFO - 'HOME': '/home/cltbld', 15:42:44 INFO - 'LANG': 'en_US.UTF-8', 15:42:44 INFO - 'LANGUAGE': 'en_US:en', 15:42:44 INFO - 'LOGNAME': 'cltbld', 15:42:44 INFO - 'MAIL': '/var/mail/cltbld', 15:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:44 INFO - 'MOZ_NO_REMOTE': '1', 15:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:44 INFO - 'NO_EM_RESTART': '1', 15:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:44 INFO - 'PWD': '/builds/slave/test', 15:42:44 INFO - 'SHELL': '/bin/bash', 15:42:44 INFO - 'SHLVL': '1', 15:42:44 INFO - 'TERM': 'linux', 15:42:44 INFO - 'TMOUT': '86400', 15:42:44 INFO - 'USER': 'cltbld', 15:42:44 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1505342541.595682-1789722209', 15:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:44 INFO - '_': '/tools/buildbot/bin/python'} 15:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:44 INFO - Downloading/unpacking psutil>=3.1.1 15:42:44 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 15:42:44 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 15:42:44 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 15:42:44 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 15:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:42:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:42:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:42:46 INFO - Installing collected packages: psutil 15:42:46 INFO - Running setup.py install for psutil 15:42:46 INFO - building 'psutil._psutil_linux' extension 15:42:46 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 15:42:46 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 15:42:46 INFO - building 'psutil._psutil_posix' extension 15:42:46 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 15:42:46 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 15:42:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:42:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:42:46 INFO - Successfully installed psutil 15:42:46 INFO - Cleaning up... 15:42:46 INFO - Return code: 0 15:42:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:42:46 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')]} 15:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:46 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')]} 15:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:46 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 0xf5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1126a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd090>, '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 0x12cdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c7f90>, '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-1505342541.595682-1789722209', '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 15:42:46 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 15:42:46 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 15:42:46 INFO - Using env: {'DISPLAY': ':0', 15:42:46 INFO - 'HOME': '/home/cltbld', 15:42:46 INFO - 'LANG': 'en_US.UTF-8', 15:42:46 INFO - 'LANGUAGE': 'en_US:en', 15:42:46 INFO - 'LOGNAME': 'cltbld', 15:42:46 INFO - 'MAIL': '/var/mail/cltbld', 15:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:46 INFO - 'MOZ_NO_REMOTE': '1', 15:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:46 INFO - 'NO_EM_RESTART': '1', 15:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:46 INFO - 'PWD': '/builds/slave/test', 15:42:46 INFO - 'SHELL': '/bin/bash', 15:42:46 INFO - 'SHLVL': '1', 15:42:46 INFO - 'TERM': 'linux', 15:42:46 INFO - 'TMOUT': '86400', 15:42:46 INFO - 'USER': 'cltbld', 15:42:46 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1505342541.595682-1789722209', 15:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:46 INFO - '_': '/tools/buildbot/bin/python'} 15:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:42:46 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 15:42:46 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 15:42:46 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 15:42:46 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 15:42:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:42:48 INFO - Installing collected packages: mozsystemmonitor 15:42:48 INFO - Running setup.py install for mozsystemmonitor 15:42:48 INFO - Successfully installed mozsystemmonitor 15:42:48 INFO - Cleaning up... 15:42:48 INFO - Return code: 0 15:42:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:42: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')]} 15:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42: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')]} 15:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42: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', '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 0xf5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1126a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd090>, '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 0x12cdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c7f90>, '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-1505342541.595682-1789722209', '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 15:42: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:42: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 jsonschema==2.5.1 15:42:48 INFO - Using env: {'DISPLAY': ':0', 15:42:48 INFO - 'HOME': '/home/cltbld', 15:42:48 INFO - 'LANG': 'en_US.UTF-8', 15:42:48 INFO - 'LANGUAGE': 'en_US:en', 15:42:48 INFO - 'LOGNAME': 'cltbld', 15:42:48 INFO - 'MAIL': '/var/mail/cltbld', 15:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:48 INFO - 'MOZ_NO_REMOTE': '1', 15:42:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:48 INFO - 'NO_EM_RESTART': '1', 15:42:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:48 INFO - 'PWD': '/builds/slave/test', 15:42:48 INFO - 'SHELL': '/bin/bash', 15:42:48 INFO - 'SHLVL': '1', 15:42:48 INFO - 'TERM': 'linux', 15:42:48 INFO - 'TMOUT': '86400', 15:42:48 INFO - 'USER': 'cltbld', 15:42:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1505342541.595682-1789722209', 15:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:48 INFO - '_': '/tools/buildbot/bin/python'} 15:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:49 INFO - Downloading/unpacking jsonschema==2.5.1 15:42: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 15:42: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 15:42: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 15:42: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 15:42:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:42:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:42: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 15:42: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 15:42: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 15:42: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 15:42:51 INFO - Downloading functools32-3.2.3-2.tar.gz 15:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:42:51 INFO - warning: no files found matching '*.txt' 15:42:51 INFO - no previously-included directories found matching 'build' 15:42:51 INFO - no previously-included directories found matching 'dist' 15:42:51 INFO - no previously-included directories found matching '.git*' 15:42:51 INFO - Installing collected packages: jsonschema, functools32 15:42:51 INFO - Running setup.py install for functools32 15:42:51 INFO - warning: no files found matching '*.txt' 15:42:51 INFO - no previously-included directories found matching 'build' 15:42:51 INFO - no previously-included directories found matching 'dist' 15:42:51 INFO - no previously-included directories found matching '.git*' 15:42:51 INFO - Successfully installed jsonschema functools32 15:42:51 INFO - Cleaning up... 15:42:51 INFO - Return code: 0 15:42:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:42: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')]} 15:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42: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')]} 15:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42: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', '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 0xf5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1126a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd090>, '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 0x12cdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c7f90>, '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-1505342541.595682-1789722209', '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 15:42: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:42: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 functools32==3.2.3-2 15:42:51 INFO - Using env: {'DISPLAY': ':0', 15:42:51 INFO - 'HOME': '/home/cltbld', 15:42:51 INFO - 'LANG': 'en_US.UTF-8', 15:42:51 INFO - 'LANGUAGE': 'en_US:en', 15:42:51 INFO - 'LOGNAME': 'cltbld', 15:42:51 INFO - 'MAIL': '/var/mail/cltbld', 15:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:51 INFO - 'MOZ_NO_REMOTE': '1', 15:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:51 INFO - 'NO_EM_RESTART': '1', 15:42:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:51 INFO - 'PWD': '/builds/slave/test', 15:42:51 INFO - 'SHELL': '/bin/bash', 15:42:51 INFO - 'SHLVL': '1', 15:42:51 INFO - 'TERM': 'linux', 15:42:51 INFO - 'TMOUT': '86400', 15:42:51 INFO - 'USER': 'cltbld', 15:42:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1505342541.595682-1789722209', 15:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:51 INFO - '_': '/tools/buildbot/bin/python'} 15:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:42:51 INFO - Cleaning up... 15:42:51 INFO - Return code: 0 15:42:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:42: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')]} 15:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42: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')]} 15:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1126a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd090>, '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 0x12cdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c7f90>, '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-1505342541.595682-1789722209', '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 15:42:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:42:51 INFO - Using env: {'DISPLAY': ':0', 15:42:51 INFO - 'HOME': '/home/cltbld', 15:42:51 INFO - 'LANG': 'en_US.UTF-8', 15:42:51 INFO - 'LANGUAGE': 'en_US:en', 15:42:51 INFO - 'LOGNAME': 'cltbld', 15:42:51 INFO - 'MAIL': '/var/mail/cltbld', 15:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:51 INFO - 'MOZ_NO_REMOTE': '1', 15:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:51 INFO - 'NO_EM_RESTART': '1', 15:42:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:51 INFO - 'PWD': '/builds/slave/test', 15:42:51 INFO - 'SHELL': '/bin/bash', 15:42:51 INFO - 'SHLVL': '1', 15:42:51 INFO - 'TERM': 'linux', 15:42:51 INFO - 'TMOUT': '86400', 15:42:51 INFO - 'USER': 'cltbld', 15:42:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1505342541.595682-1789722209', 15:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:51 INFO - '_': '/tools/buildbot/bin/python'} 15:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:51 INFO - Downloading/unpacking blobuploader==1.2.4 15:42: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 15:42: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 15:42: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 15:42: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 15:42:53 INFO - Downloading blobuploader-1.2.4.tar.gz 15:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:42:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:42:53 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 15:42:53 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 15:42:53 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 15:42:53 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 15:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:42:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:42:53 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 15:42:53 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 15:42:53 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 15:42:53 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 15:42:53 INFO - Downloading docopt-0.6.1.tar.gz 15:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:42:53 INFO - Installing collected packages: blobuploader, requests, docopt 15:42:53 INFO - Running setup.py install for blobuploader 15:42:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:42:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:42:53 INFO - Running setup.py install for requests 15:42:54 INFO - Running setup.py install for docopt 15:42:54 INFO - Successfully installed blobuploader requests docopt 15:42:54 INFO - Cleaning up... 15:42:54 INFO - Return code: 0 15:42:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:42: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')]} 15:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42: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')]} 15:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:54 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 0xf5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1126a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd090>, '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 0x12cdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c7f90>, '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-1505342541.595682-1789722209', '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 15:42:54 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 15:42:54 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 15:42:54 INFO - Using env: {'DISPLAY': ':0', 15:42:54 INFO - 'HOME': '/home/cltbld', 15:42:54 INFO - 'LANG': 'en_US.UTF-8', 15:42:54 INFO - 'LANGUAGE': 'en_US:en', 15:42:54 INFO - 'LOGNAME': 'cltbld', 15:42:54 INFO - 'MAIL': '/var/mail/cltbld', 15:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:54 INFO - 'MOZ_NO_REMOTE': '1', 15:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:54 INFO - 'NO_EM_RESTART': '1', 15:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:54 INFO - 'PWD': '/builds/slave/test', 15:42:54 INFO - 'SHELL': '/bin/bash', 15:42:54 INFO - 'SHLVL': '1', 15:42:54 INFO - 'TERM': 'linux', 15:42:54 INFO - 'TMOUT': '86400', 15:42:54 INFO - 'USER': 'cltbld', 15:42:54 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1505342541.595682-1789722209', 15:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:54 INFO - '_': '/tools/buildbot/bin/python'} 15:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:42:54 INFO - Running setup.py (path:/tmp/pip-SHRr_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:42:54 INFO - Running setup.py (path:/tmp/pip-fi6uqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:42:54 INFO - Running setup.py (path:/tmp/pip-PTOloq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:42:54 INFO - Running setup.py (path:/tmp/pip-eKRniG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:42:54 INFO - Running setup.py (path:/tmp/pip-0rQQL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:42:54 INFO - Running setup.py (path:/tmp/pip-i8Z6Ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:42:54 INFO - Running setup.py (path:/tmp/pip-RcNZ7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:42:54 INFO - Running setup.py (path:/tmp/pip-pajzNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:42:55 INFO - Running setup.py (path:/tmp/pip-HWJ2Oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:42:55 INFO - Running setup.py (path:/tmp/pip-JdZZwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:42:55 INFO - Running setup.py (path:/tmp/pip-dF0QmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:42:55 INFO - Running setup.py (path:/tmp/pip-eY1Rt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:42:55 INFO - Running setup.py (path:/tmp/pip-RHV0ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:42:55 INFO - Running setup.py (path:/tmp/pip-SE4_Sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:55 INFO - Running setup.py (path:/tmp/pip-AOvMLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:42:55 INFO - Running setup.py (path:/tmp/pip-BhvuRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:42:55 INFO - Running setup.py (path:/tmp/pip-W0peio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:42:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:42:55 INFO - Running setup.py install for manifestparser 15:42:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:42:55 INFO - Running setup.py install for mozcrash 15:42:55 INFO - Running setup.py install for mozdebug 15:42:55 INFO - Running setup.py install for mozdevice 15:42:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:42:56 INFO - Running setup.py install for mozfile 15:42:56 INFO - Running setup.py install for mozhttpd 15:42:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:42:56 INFO - Running setup.py install for mozinfo 15:42:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:42:56 INFO - Running setup.py install for mozInstall 15:42:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:42:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:42:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:42:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:42:56 INFO - Running setup.py install for mozleak 15:42:56 INFO - Running setup.py install for mozlog 15:42:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:42:56 INFO - Running setup.py install for moznetwork 15:42:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:42:56 INFO - Running setup.py install for mozprocess 15:42:56 INFO - Running setup.py install for mozprofile 15:42:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:42:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:42:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:42:57 INFO - Running setup.py install for mozrunner 15:42:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:42:57 INFO - Running setup.py install for mozscreenshot 15:42:57 INFO - Running setup.py install for moztest 15:42:57 INFO - Running setup.py install for mozversion 15:42:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:42:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:42:57 INFO - Cleaning up... 15:42:57 INFO - Return code: 0 15:42:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:57 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 0xf5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1126a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd090>, '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 0x12cdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c7f90>, '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-1505342541.595682-1789722209', '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 15:42:57 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 15:42:57 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 15:42:57 INFO - Using env: {'DISPLAY': ':0', 15:42:57 INFO - 'HOME': '/home/cltbld', 15:42:57 INFO - 'LANG': 'en_US.UTF-8', 15:42:57 INFO - 'LANGUAGE': 'en_US:en', 15:42:57 INFO - 'LOGNAME': 'cltbld', 15:42:57 INFO - 'MAIL': '/var/mail/cltbld', 15:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:57 INFO - 'MOZ_NO_REMOTE': '1', 15:42:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:57 INFO - 'NO_EM_RESTART': '1', 15:42:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:57 INFO - 'PWD': '/builds/slave/test', 15:42:57 INFO - 'SHELL': '/bin/bash', 15:42:57 INFO - 'SHLVL': '1', 15:42:57 INFO - 'TERM': 'linux', 15:42:57 INFO - 'TMOUT': '86400', 15:42:57 INFO - 'USER': 'cltbld', 15:42:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1505342541.595682-1789722209', 15:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:57 INFO - '_': '/tools/buildbot/bin/python'} 15:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:42:57 INFO - Running setup.py (path:/tmp/pip-wzATVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:42:57 INFO - Running setup.py (path:/tmp/pip-IdEKcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:42:57 INFO - Running setup.py (path:/tmp/pip-mvFfyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:42:57 INFO - Running setup.py (path:/tmp/pip-SVfnUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:42:57 INFO - Running setup.py (path:/tmp/pip-o78zMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:42:58 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)) 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:42:58 INFO - Running setup.py (path:/tmp/pip-1ILhd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:42:58 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)) 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:42:58 INFO - Running setup.py (path:/tmp/pip-S2fwJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:42:58 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)) 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:42:58 INFO - Running setup.py (path:/tmp/pip-UV3gwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:42:58 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)) 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:42:58 INFO - Running setup.py (path:/tmp/pip-CWIGhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:42:58 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)) 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:42:58 INFO - Running setup.py (path:/tmp/pip-0VnB20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:42:58 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)) 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:42:58 INFO - Running setup.py (path:/tmp/pip-2oRL4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:42:58 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)) 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:42:58 INFO - Running setup.py (path:/tmp/pip-Op0nD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:42:58 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)) 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:42:58 INFO - Running setup.py (path:/tmp/pip-aDRKbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:42:58 INFO - Running setup.py (path:/tmp/pip-Dad7zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:58 INFO - Running setup.py (path:/tmp/pip-m3BF26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:42:58 INFO - Running setup.py (path:/tmp/pip-QFN3Dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:42:58 INFO - Running setup.py (path:/tmp/pip-vlR1H6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:42:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:42: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 15:42: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 15:42: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 15:42: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 15:42:59 INFO - Downloading blessings-1.6.tar.gz 15:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:43:00 INFO - Installing collected packages: blessings 15:43:00 INFO - Running setup.py install for blessings 15:43:00 INFO - Successfully installed blessings 15:43:00 INFO - Cleaning up... 15:43:00 INFO - Return code: 0 15:43:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:43:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:00 INFO - Reading from file tmpfile_stdout 15:43:00 INFO - Current package versions: 15:43:00 INFO - argparse == 1.2.1 15:43:00 INFO - blessings == 1.6 15:43:00 INFO - blobuploader == 1.2.4 15:43:00 INFO - docopt == 0.6.1 15:43:00 INFO - functools32 == 3.2.3-2 15:43:00 INFO - jsonschema == 2.5.1 15:43:00 INFO - manifestparser == 1.1 15:43:00 INFO - mozInstall == 1.13 15:43:00 INFO - mozcrash == 1.0 15:43:00 INFO - mozdebug == 0.1 15:43:00 INFO - mozdevice == 0.51 15:43:00 INFO - mozfile == 1.2 15:43:00 INFO - mozhttpd == 0.7 15:43:00 INFO - mozinfo == 0.10 15:43:00 INFO - mozleak == 0.1 15:43:00 INFO - mozlog == 3.5 15:43:00 INFO - moznetwork == 0.27 15:43:00 INFO - mozprocess == 0.25 15:43:00 INFO - mozprofile == 0.28 15:43:00 INFO - mozrunner == 6.13 15:43:00 INFO - mozscreenshot == 0.1 15:43:00 INFO - mozsystemmonitor == 0.3 15:43:00 INFO - moztest == 0.8 15:43:00 INFO - mozversion == 1.4 15:43:00 INFO - psutil == 3.1.1 15:43:00 INFO - requests == 1.2.3 15:43:00 INFO - wsgiref == 0.1.2 15:43:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:00 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')]} 15:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:00 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')]} 15:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:00 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 0xf5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1126a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd090>, '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 0x12cdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c7f90>, '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-1505342541.595682-1789722209', '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 15:43:00 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 15:43:00 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 15:43:00 INFO - Using env: {'DISPLAY': ':0', 15:43:00 INFO - 'HOME': '/home/cltbld', 15:43:00 INFO - 'LANG': 'en_US.UTF-8', 15:43:00 INFO - 'LANGUAGE': 'en_US:en', 15:43:00 INFO - 'LOGNAME': 'cltbld', 15:43:00 INFO - 'MAIL': '/var/mail/cltbld', 15:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:00 INFO - 'MOZ_NO_REMOTE': '1', 15:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:00 INFO - 'NO_EM_RESTART': '1', 15:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:00 INFO - 'PWD': '/builds/slave/test', 15:43:00 INFO - 'SHELL': '/bin/bash', 15:43:00 INFO - 'SHLVL': '1', 15:43:00 INFO - 'TERM': 'linux', 15:43:00 INFO - 'TMOUT': '86400', 15:43:00 INFO - 'USER': 'cltbld', 15:43:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1505342541.595682-1789722209', 15:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:00 INFO - '_': '/tools/buildbot/bin/python'} 15:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:43:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:43:01 INFO - Installing collected packages: simplejson 15:43:01 INFO - Running setup.py install for simplejson 15:43:01 INFO - building 'simplejson._speedups' extension 15:43:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:43:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:43:02 INFO - Successfully installed simplejson 15:43:02 INFO - Cleaning up... 15:43:02 INFO - Return code: 0 15:43:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:43: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')]} 15:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43: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')]} 15:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1126a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cd090>, '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 0x12cdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c7f90>, '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-1505342541.595682-1789722209', '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 15:43:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:43:02 INFO - Using env: {'DISPLAY': ':0', 15:43:02 INFO - 'HOME': '/home/cltbld', 15:43:02 INFO - 'LANG': 'en_US.UTF-8', 15:43:02 INFO - 'LANGUAGE': 'en_US:en', 15:43:02 INFO - 'LOGNAME': 'cltbld', 15:43:02 INFO - 'MAIL': '/var/mail/cltbld', 15:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:02 INFO - 'MOZ_NO_REMOTE': '1', 15:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:02 INFO - 'NO_EM_RESTART': '1', 15:43:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:02 INFO - 'PWD': '/builds/slave/test', 15:43:02 INFO - 'SHELL': '/bin/bash', 15:43:02 INFO - 'SHLVL': '1', 15:43:02 INFO - 'TERM': 'linux', 15:43:02 INFO - 'TMOUT': '86400', 15:43:02 INFO - 'USER': 'cltbld', 15:43:02 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1505342541.595682-1789722209', 15:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:02 INFO - '_': '/tools/buildbot/bin/python'} 15:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:43:03 INFO - Cleaning up... 15:43:03 INFO - Return code: 0 15:43:03 INFO - Running post-action listener: _resource_record_post_action 15:43:03 INFO - Running post-action listener: _start_resource_monitoring 15:43:03 INFO - Starting resource monitoring. 15:43:03 INFO - [mozharness: 2017-09-13 22:43:03.154618Z] Finished create-virtualenv step (success) 15:43:03 INFO - [mozharness: 2017-09-13 22:43:03.155209Z] Running install step. 15:43:03 INFO - Running pre-action listener: _resource_record_pre_action 15:43:03 INFO - Running main action method: install 15:43:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:03 INFO - Reading from file tmpfile_stdout 15:43:03 INFO - Detecting whether we're running mozinstall >=1.0... 15:43:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:43:03 INFO - Reading from file tmpfile_stdout 15:43:03 INFO - Output received: 15:43:03 INFO - Usage: mozinstall [options] installer 15:43:03 INFO - Options: 15:43:03 INFO - -h, --help show this help message and exit 15:43:03 INFO - -d DEST, --destination=DEST 15:43:03 INFO - Directory to install application into. [default: 15:43:03 INFO - "/builds/slave/test"] 15:43:03 INFO - --app=APP Application being installed. [default: firefox] 15:43:03 INFO - mkdir: /builds/slave/test/build/application 15:43:03 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'] 15:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:43:21 INFO - Reading from file tmpfile_stdout 15:43:21 INFO - Output received: 15:43:21 INFO - /builds/slave/test/build/application/firefox/firefox 15:43:21 INFO - Running post-action listener: _resource_record_post_action 15:43:21 INFO - [mozharness: 2017-09-13 22:43:21.134018Z] Finished install step (success) 15:43:21 INFO - [mozharness: 2017-09-13 22:43:21.134269Z] Running setup-mitmproxy step. 15:43:21 INFO - Running pre-action listener: _resource_record_pre_action 15:43:21 INFO - Running main action method: setup_mitmproxy 15:43:21 INFO - Skipping: mitmproxy is not required 15:43:21 INFO - Running post-action listener: _resource_record_post_action 15:43:21 INFO - [mozharness: 2017-09-13 22:43:21.135476Z] Finished setup-mitmproxy step (success) 15:43:21 INFO - [mozharness: 2017-09-13 22:43:21.135697Z] Running run-tests step. 15:43:21 INFO - Running pre-action listener: _resource_record_pre_action 15:43:21 INFO - Running pre-action listener: _set_gcov_prefix 15:43:21 INFO - Running main action method: run_tests 15:43:21 WARNING - Try message not found. 15:43:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:43:21 INFO - Python 2.7.3 15:43:21 INFO - Return code: 0 15:43:21 INFO - grabbing minidump binary from tooltool 15:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:21 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 0x12cd090>, '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 0x12cdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c7f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:43:21 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 15:43:21 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 15:43:21 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 15:43:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:43:21 INFO - Return code: 0 15:43:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:43:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:43:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:43:21 INFO - ENV: RUST_BACKTRACE is now full 15:43:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:43:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:43:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/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-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 15:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/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-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 15:43:21 INFO - Using env: {'DISPLAY': ':0', 15:43:21 INFO - 'HOME': '/home/cltbld', 15:43:21 INFO - 'LANG': 'en_US.UTF-8', 15:43:21 INFO - 'LANGUAGE': 'en_US:en', 15:43:21 INFO - 'LOGNAME': 'cltbld', 15:43:21 INFO - 'MAIL': '/var/mail/cltbld', 15:43:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:43:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:21 INFO - 'MOZ_NO_REMOTE': '1', 15:43:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:21 INFO - 'NO_EM_RESTART': '1', 15:43:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:21 INFO - 'PWD': '/builds/slave/test', 15:43:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:43:21 INFO - 'RUST_BACKTRACE': 'full', 15:43:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:43:21 INFO - 'SHELL': '/bin/bash', 15:43:21 INFO - 'SHLVL': '1', 15:43:21 INFO - 'TERM': 'linux', 15:43:21 INFO - 'TMOUT': '86400', 15:43:21 INFO - 'USER': 'cltbld', 15:43:21 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1505342541.595682-1789722209', 15:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:21 INFO - '_': '/tools/buildbot/bin/python'} 15:43:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/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-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 15:43:21 INFO - mozversion application_buildid: 20170913212101 15:43:21 INFO - mozversion application_changeset: b9ffb07cf8e71b1f4285ec7741f6b2f8256dc79d 15:43:21 INFO - mozversion application_display_name: Nightly 15:43:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:43:21 INFO - mozversion application_name: Firefox 15:43:21 INFO - mozversion application_remotingname: firefox 15:43:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:43:21 INFO - mozversion application_vendor: Mozilla 15:43:21 INFO - mozversion application_version: 57.0a1 15:43:21 INFO - mozversion platform_buildid: 20170913212101 15:43:21 INFO - mozversion platform_changeset: b9ffb07cf8e71b1f4285ec7741f6b2f8256dc79d 15:43:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:43:21 INFO - mozversion platform_version: 57.0a1 15:43:21 INFO - using testdate: 1505342601 15:43:21 INFO - actual date: 1505342601 15:43:21 INFO - starting webserver on 'localhost:60078' 15:43:21 INFO - SUITE-START | Running 2 tests 15:43:21 INFO - TEST-START | dromaeo_css 15:43:21 INFO - Initialising browser for dromaeo_css test... 15:43:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60078/getInfo.html -profile /tmp/tmpZVtCUx/profile 15:43:21 INFO - TEST-INFO | started process 5828 (/builds/slave/test/build/application/firefox/firefox http://localhost:60078/getInfo.html) 15:43:27 INFO - TEST-INFO | 5828: exit 0 15:43:27 INFO - Browser initialized. 15:43:27 INFO - Running cycle 1/1 for dromaeo_css test... 15:43:27 INFO - Using env: {'DISPLAY': ':0', 15:43:27 INFO - 'HOME': '/home/cltbld', 15:43:27 INFO - 'JSGC_DISABLE_POISONING': '1', 15:43:27 INFO - 'LANG': 'en_US.UTF-8', 15:43:27 INFO - 'LANGUAGE': 'en_US:en', 15:43:27 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:43:27 INFO - 'LOGNAME': 'cltbld', 15:43:27 INFO - 'MAIL': '/var/mail/cltbld', 15:43:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:43:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:43:27 INFO - 'MOZ_CRASHREPORTER': '1', 15:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:27 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:43:27 INFO - 'MOZ_NO_REMOTE': '1', 15:43:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:27 INFO - 'NO_EM_RESTART': '1', 15:43:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:27 INFO - 'PWD': '/builds/slave/test', 15:43:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:43:27 INFO - 'RUST_BACKTRACE': 'full', 15:43:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:43:27 INFO - 'SHELL': '/bin/bash', 15:43:27 INFO - 'SHLVL': '1', 15:43:27 INFO - 'STYLO_FORCE_DISABLED': '1', 15:43:27 INFO - 'TERM': 'linux', 15:43:27 INFO - 'TMOUT': '86400', 15:43:27 INFO - 'USER': 'cltbld', 15:43:27 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1505342541.595682-1789722209', 15:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:27 INFO - '_': '/tools/buildbot/bin/python'} 15:43:27 INFO - TEST-INFO | started process 6064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZVtCUx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:43:28 INFO - PID 6064 | 15:43:28 INFO - PID 6064 | (/builds/slave/test/build/application/firefox/firefox:6114): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:43:28 INFO - PID 6064 | 15:43:38 INFO - PID 6064 | RSS: Main: 161329152 15:43:38 INFO - PID 6064 | 15:46:36 INFO - PID 6064 | Cycle 1(1): loaded http://localhost:60078/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60078/tests/dromaeo/cssquery-ext.html) 15:46:37 INFO - PID 6064 | RSS: Main: 168599552 15:46:37 INFO - PID 6064 | 15:49:39 INFO - PID 6064 | Cycle 1(1): loaded http://localhost:60078/tests/dromaeo/cssquery-ext.html (next: http://localhost:60078/tests/dromaeo/cssquery-jquery.html) 15:49:39 INFO - PID 6064 | RSS: Main: 163610624 15:49:39 INFO - PID 6064 | 15:52:41 INFO - PID 6064 | Cycle 1(1): loaded http://localhost:60078/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60078/tests/dromaeo/cssquery-mootools.html) 15:52:41 INFO - PID 6064 | RSS: Main: 166785024 15:52:41 INFO - PID 6064 | 15:55:43 INFO - PID 6064 | Cycle 1(1): loaded http://localhost:60078/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60078/tests/dromaeo/cssquery-prototype.html) 15:55:43 INFO - PID 6064 | RSS: Main: 164610048 15:55:43 INFO - PID 6064 | 15:58:46 INFO - PID 6064 | Cycle 1(1): loaded http://localhost:60078/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60078/tests/dromaeo/cssquery-yui.html) 15:58:47 INFO - PID 6064 | RSS: Main: 166707200 15:58:47 INFO - PID 6064 | 16:01:49 INFO - PID 6064 | Cycle 1(1): loaded http://localhost:60078/tests/dromaeo/cssquery-yui.html (next: http://localhost:60078/tests/dromaeo/cssquery-dojo.html) 16:01:49 INFO - PID 6064 | RSS: Main: 168271872 16:01:49 INFO - PID 6064 | 16:01:49 INFO - PID 6064 | __start_tp_report 16:01:49 INFO - PID 6064 | _x_x_mozilla_page_load 16:01:49 INFO - PID 6064 | _x_x_mozilla_page_load_details 16:01:49 INFO - PID 6064 | |i|pagename|runs| 16:01:49 INFO - PID 6064 | |0;dojo.html;3904.7461914975524;3933.2133573285314;3947.2894878921784;3947.68418526518;3951.6443520083185;6315.400036996478;6323.810285691437;6393.904091438632;6399.912014957456;6486.124373209615;6239.095331176988;6338.873222535546;6367.299597044322;6373.8087857364235;6375.2987171411105;5671.120976248668;5756.050251708484;5787.652740835542;5792.420757924216;5800.071988481844;5462.644928079662;5807.651540907538;5812.215350927613;5859.296884373881;5887.88224235515;5627.184058311563;5646.491815736604;5709.200711900337;5727.140928860684;5732.5987180897355;5643.266375371217;5677.886442271173;5731.742071606787;5759.107338362561;5770.16332631766;5675.404082571312;5682.772689092431;5733.741981610838;5751.453611906904;5753.223314852483;6238.781642642532;6259.812205633838;6370.936290637081;6370.936290637081;6391.45672617828;6895.138107736533;6912.758053468105;6913.032175495435;6922.5154239203275;6986.44108471321;6912.135983002125;6916.930830691679;6922.446204303644;6951.5481493703255;7027.543209691354;6335.461485773715;6356.872862542816;6408.038794180864;6467.579607325509;6482.254540727782;6964.860702785916;7002.404795592432;7067.293270672892;7072.5402848814665;7075.82310442243;6769.018492318586;6774.661266936633;6796.626185559841;6806.727730890808;6838.760643377458;6906.861862762717;6957.199922008933;6976.825579360455;6981.930180698128;6988.6855091521;6838.692258848364;6864.416524595365;6901.240863505011;6909.378155965987;6928.411085057826;6779.2881747416795;6780.355866192704;6863.10779598649;6878.312168783082;6883.414909732629;4977.626677999165;4991.550760431579;4991.850244492671;4999.350084489066;5012.947281071016;4531.342955271467;4564.452265728068;4581.152486789888;4612.815487380534;4624.28323609841;6257.843553911189;6305.905411418832;6408.359164083648;6418.550701450947;6422.967885160544;6788.422984046411;6874.175098988054;6879.759208427681;6885.724571017204;6972.302769722987;6320.810375688737;6358.841028974312;6364.045393191059;6365.618062916147;6369;5544.085225937756;5595.720213989284;5610.691411972381;5618.91571626426;5619.381867994517;7059.788206353817;7139.500234983501;7150.3922166615375;7223.133224013152;7234.855302894018;6783.21992970795;6880.0367948486255;6889.483288753263;6988.965055174692;6990.335918087671;7143.892841607276;7166.677499512639;7179.964100179465;7184.892226616709;7220.38626716735;6799.456043516408;6832.111825462658;6865.107536020286;6909.7581584644295;6921.826954326182;6882.8967565485555;6918.792436226921;7000.50996430245;7008.964955175192;7030.121234845645;6533.67331633407;6608.372204640552;6612.5040621952585;6614.966925165536;6707.396334329934;6599.835004124743;6610.2398224204835;6625.138731964814;6626.4367528760595;6627.403533681992;6529.771457998947;6583.177102862142;6611.570247934062;6614.4708423325055;6651.26836048044;6559.442447392025;6653.866922661423;6679;6729.5625784323865;6730.831729206809;6388.488920886411;6481.5138864584405;6485.708143133476;6575.901361479486;6580.341965803382 16:01:49 INFO - PID 6064 | |1;ext.html;884.7257350221432;949.9287553433494;955.493588398149;993.46849435552;1001.6744558018642;43688;44121.11757764847;44566;44704.77647611757;44846.55153448464;41608.58391416085;41699.37450938238;41968.58031419685;42058.7897060515;42066.7896660517;7193.388561972226;7199.640017999105;7213.206547279795;7226.349628533431;7297.854042919138;7415.443841711894;7426.257374262585;7486.251374862497;7500.662470188828;7523.473356865022;7469.327760501554;8050.959745201295;8184.058833234195;8208.794780130485;8236.917630823675;8093.1502192269845;8135.511869287861;8145.837083258331;8146.75559733209;8175.468594541336;7799.220077992212;7884.935533702934;7890.053193616803;7896.921030789734;8061.193880611951;40627.59372406297;40835;41065;41180;41247;3693.741438099334;3761.699064074895;3765.058735316171;3765.9643598010766;3766.2844059628856;31615.893443729357;31657.84171079153;31723.206919826956;32125;32271.35457290841;5522.088855338864;5558.638688485235;5566.693831839248;5567.749451274703;5655.321361436613;204896;205309;205440;205733.99999999852;205937;51319.48680513147;51408.228876566136;51702.22446663303;51777.22334164991;51841.48158518442;54424.45575544194;54453;54590.18114728282;54635.45364546383;54760;15037.924810376097;15301.770473442908;15314.234288285541;15314.463993760388;15384.38462461489;12378.75242495163;12381.00951923844;12412.875871241173;12444.440000200013;12456.75086498265;14529.78205326921;14657;14682.779758303634;14852.183129927742;14917.850821491864;5727.484526392562;5737.483626473638;5845.590808643439;5870.501007414332;5905.881882362329;1111.3831823337964;1112.0603090388609;1115.754534002518;1125.5722825326325;1128.6049882541208;25623.359416014748;25643.35891602725;25695.357616059748;25817.612735808976;25830.225093247234;1193.8328633991248;1210.6186551236508;1212.2181193130382;1213.1326101837228;1244.147758785235;13684.726305474034;13793.86206137946;13799;13842.16946983164;13954;267648;268796;269493;269933;270387;58303.41696583065;58397.70801145967;62976.685116574125;63634.363656362846;64197;1495.8279797823172;1537.269796846489;1537.3158944269917;1538.538438468455;1543.7761524578873;30703.560789331736;30979.225519362197;31262.53106203454;31452.370952581277;31971.200719982186;42209.57790422056;42446.575534244264;42463.36304955366;42529.787351063045;42577;232861;233208;233510;233658;234458;35516.11209719778;36189;36361.818190908874;36600.63399365972;36911.815440922626;46960;47683.284750728075;47830.28254576254;48489;48636;34764.47853282152;35310;35446.82276588704;35597.644023559435;35641.46537801883;35076.473852891715;35124.82437587796;35130;35286.823565882005;35929.46105808362;42051.7897410511;42177.15645687131;42191.367129493694;42614.36078458888;42686.78656606697;34299.31401372008;34336;34393.14017149491;34798.47802283018;35140.82429587836;26205.868970655025;26245.343866402727;26402.603960940985;26417.735822642295;26610 16:01:49 INFO - PID 6064 | |2;jquery.html;594.1918990173366;595.5414330965154;601.1994077737178;611.1535523300228;625.2403329954105;22972;23539.058437662494;23589;23638.172663956764;23656.408589785242;21523;24729.381765455873;25474.74525254747;25672.871635641797;25691.357716057108;6646.136002319704;6854.074699915523;6855.451563874878;6860;6860.176778786527;6482.189726284215;6622;6719.294474080224;6760.492963027768;6781.050652908572;6716.731330746764;6722.327767223287;6722.462203023771;6729.158855143107;6730.798076057726;6510.674466276667;6731.899021514657;6734.56225345351;6756.560823546478;6762.391384775345;6241.375862413768;6264.21697287839;6279.277883043463;6303.527235457359;6306.274778400497;29396.118116456542;29869.461095806884;29879.701202987908;29902.401951960837;29928;2231.241377931511;2262.3778460923213;2271.0348102056723;2282;2284.9885750571307;19624.901875490676;20533.178672853068;20576.38270851862;20603.175872965065;20629;2515.8490490570443;2525.1288305534745;2601.440690251605;2609.856457894815;2611.764941155286;132302;137746;152756;159457;160223.99999999884;15150.924245378923;15628.4530041448;15805.446809361618;15954.68090638204;17285.91357043207;25353.74646253514;25370.619440708037;25421;25504.489910201693;25533.48933021329;10383.428911409794;10440.269181157399;10502;10539.84190237147;10613.9469302653;9336.786217791643;9386.530673466299;9551.14039736427;9620.13418792298;9623.326367154232;9435.481048542397;9613.903860961302;9674.952389997128;9690.321677482509;9889.80220395588;2792.3577577157366;2891.797574169788;2907.1278616414993;2919.5474701421313;3025.4267780753885;1020.5356562763925;1040.375774535288;1048.114343379843;1063.0910571461288;1063.1282348474176;20253.392398228076;20273.59452810965;20488;20538.69191962122;20612.17551297961;1106.1261603333276;1113.8941800528937;1122.6912599035331;1125.7692173104494;1129.949152288149;11073.778524429466;11147.498362573704;11177.49701263445;11368.886311136948;11391.772164556662;582991;596631;600591;617867;622571;125364;126807;126961.36519317345;128533;130257;1205.4033253539378;1214.502054157791;1246.2896149195053;1254.4166962362544;1258.150748244931;17966;18042;18067.45797626073;18261.54346141357;18347.449576512725;59607.403925960185;60527;62306.37693623006;62936.37063629305;63260.683696581225;77134;78183;78392.60803695946;78594;78716.21283787317;14774;14974.251287435802;15022.248887555359;15186.620334491727;15199.620009499851;23346;23350.53298934046;23424.414389640395;23616.88191559031;23670.763292366857;18352.81647183511;18462.538436539195;18624.534386640444;19430;19678.11448484793;17156.142192890555;17180.39868604593;17559.824401755817;17592;17804.643907121525;18610;19744.21023159115;19895;19969.500762481053;20049.198032078555;14721.484748033767;14880.702385952436;14899.255037248311;14914.328855201325;14928.701425971636;18558.628827423105;18601.720974185668;18804.341848035252;18995.810041899404;19018.42944711661 16:01:49 INFO - PID 6064 | |3;mootools.html;1397.5737400092971;1449.7245523350562;1451.100317802963;1462.5685422800273;1464.39227720496;16502.17489125545;17301.913490432547;17327.826721732763;17470;17517.299308027694;17158.571035724082;17269.568260793454;17285.395011174613;17308.653826923455;17347.39284125056;2659.9734002659966;2800.705925877784;2811.1144989328295;2811.507986102434;2812.5640525718445;2785.958210626842;2868.268591509173;2871.382652729663;2872.152714949095;2873.8850445982134;2672.0514217452815;2728.2770065932546;2730.481208570365;2731.4946734854016;2732.180345896233;2694.488047271022;2696.595510673405;2707.3773032202507;2710.214037928998;2714;2667.679878414583;2674.465106978612;2674.812763106583;2692.434588736368;2695.7034726180104;16758;16849.83150168495;16852.157392130346;17002.149892505324;17057.402990895258;8234.629441675139;8512.914870851275;8514.403991720583;8516.190961858614;8543.188397102265;5399.757010934517;5447.509724124848;5534.0315444797;5681.818181818154;5736.741846616912;2053.5790163016545;2066.5143691232547;2071.1197740960033;2088.289981406329;2120.9469763256043;31510.684893151003;31544.526832097537;31682.841585792154;31855.362892742247;31857.362852742815;7194.460415468756;7225.132984041844;7290.854182916418;7385.7045718170675;7408.9629551851895;19853.404397868086;19894.50263743418;20007.899960500104;20070.89964550168;20082.297119600746;8715.477071375737;8934.329925255632;8935.731928042169;8944.5080520572;8953.776155596162;7682.923170768333;7812.218778122142;7819.022622172229;7840.960795195988;7856.5678887661725;5851.38560451155;6002.69986500682;6032;6063.818085457355;6100.511959043355;1873.6440076385443;1874.925002999892;1883.849292056632;1893.1670065171556;1925.1336898395778;927.5918595817818;947.4978261521404;951.8905325887612;964.6864768950119;965.5461932891529;8506.65973361071;8510.65957361711;8563.186497282748;8617.48295102296;8634.481931084156;772.2470591173561;787.5274835099009;798.7124635131348;804;808.2119933065214;5141.608295871501;5467.917981230285;5832.591718579659;6019.759209631653;6054.152418661391;24492.877535612562;25180.49639007246;25297.367565811;25404.745952540237;25454.74545254561;23271.185508507122;24530.754692452847;24599.262022139006;24611.753882461304;24622.876885615457;12401.62795116148;12517.436715348013;12524.499020039097;12545.811812822632;12610.369481525888;9104.180623743894;9379.155875971195;9380.48407337603;9430.245580353692;9469.289803264644;20517.692234616195;20877.89561052185;21016.789832102095;21128.260510882046;21615.891920540296;21123.366299011053;21526.6770998432;21558.892205538872;21575.892120539924;21628.783712162676;13558.186508809504;13760.17438953666;13781.586552403443;13785.241811700453;13789.448422063406;15659.295331709873;15794.052356858165;15883.444079457626;15891.602709932344;16028.038317700975;12546.372681366078;12566.434510446868;12943.741125177632;12964;12986.220826750425;12149.574764883188;12153.453094610586;12209.755804883675;12224.938875305566;12566.057545684293;10184.490775461345;10256.02567756062;10294.433806140734;10369.481525923522;10448.32085914413;7930.116224086057;7996.56018918965;8011.679532818622;8020.117787043538;8111.918880811352;7234.6744396501235;7422.406207503494;7452.739154129579;7493.475456718195;7497.400207983239 16:01:49 INFO - PID 6064 | |4;prototype.html;542.3654324440404;548.1366847215635;580.303635637235;581.8661707807204;582.7202942587558;6239.594426362283;6242.781502647408;6282.654454005028;6354.80935571933;6370.968145159273;6215.875682486348;6216;6261.780837670683;6294.842628934279;6295.559310848243;5094.235864620318;5100.897982040357;5106.697792063019;5126.92309615356;5141.562967147787;4906.362172917516;4991.301217829507;4999.900001999958;5110.156824124015;5122.436531981479;4987.650864439491;4990.27640992056;4994.550490455858;4996.225585034307;5019.673721208128;4972.950270497285;4979.402471703419;4987.1521841286885;4987.526185012418;4998.925016124761;4411.448568928884;4489.438820147481;4492.820287188509;4519.977400112978;4550.795214215368;6069.848253793646;6126.969365153191;6131.601445906002;6142.907856382158;6169.907451388232;5766.452187042266;5811.535077193815;5843.948089343917;5855.121731740231;5867.3839246879315;6541.411272985454;6566.901496477557;6582.539222254444;6597.954634063456;6604.471642268607;4833.613310935117;4980.975095124538;5009.7495125243595;5016.573591244712;5031.4465408805;6662.734080524685;6773.187217533928;6783.559068660571;6894.586324820477;6954.304569543056;5524.447555244444;5551.72241387929;5585.441455854463;5603.439656034364;5624.409437009055;5672.631278966854;5685.573581981368;5689.459501347365;5701.657900525982;5749.798757043567;6083.239595050619;6113.663748493786;6116.052011938156;6121.234845644294;6124;6652.96673516639;6695.765648202289;6717.832054198684;6730.663466826639;6750;1948.0844003318418;1960.4216756056996;1972.6252012117652;1979.1786408640253;1998.2506560039985;1434.973993594585;1497.4983380567633;1501.6846462242834;1506.9246537673073;1508.9849101508844;5912;5972.492338151305;6001.8896504146;6066;6091.66495842724;6521.315261897527;6529.608223506605;6546.279909209983;6625.801225963229;6690.866182676416;5940.079287710412;6020.608660437058;6052;6056.757729690851;6084.543659225487;3468.8612455502002;3470.722342212617;3471.3057388522398;3492.1793378556017;3543.5924868639922;6739.326067393319;6810.421114205249;6858.9368647859665;6874.553154044971;6903.965480172567;6685.197776266782;6701.5308928375525;6830.146231721035;6839.418649414855;6856.691448884712;6725.125733654593;6728.947670960306;6874.690638921261;6946.79159625212;7018.719251229893;6601.702923368556;6615.966920165561;6663.300353462817;6686.030525573862;6704.497162712913;6670.332966703291;6686.264510903699;6703.162104736908;6772.627505487246;6775.254721980479;6924.134483189601;6925.619090949845;6968.860622787617;6989.405900498515;7031.472639551952;5504.422035686355;5528.253685752372;5562.137868630369;5637.448407503247;5670.262865827416;6476.542777875129;6530.67346632676;6695.598264104169;6761.52669313163;6798.59208447475;6409.583377080475;6460.903086453613;6462.870742585028;6501.804945851632;6510.837229069311;6418.486521078209;6432.131662225727;6450.645214513247;6527.9020814688765;6547.934520654923;6418.518611104279;6434.935650643433;6454.967725161344;6456.225252969673;6469.514786390945;6536.182977127859;6542.44389226902;6553.279139294769;6562.8359291016195;6566.244881838458;6353.777617783356;6358.618482891041;6374.26695929974;6424.201223657384;6434.517411194086 16:01:49 INFO - PID 6064 | |5;yui.html;975.2880397309968;990.440401173337;1003.0721582536153;1006.5621454667221;1011.1859952738043;19592.11835467404;19950.201991920305;19961.500962475944;19962.201511939504;19964.800351996477;16334.754978675299;16349.264283107259;17680;17843.91078044608;17847.55381115473;1069.0805906920043;1084;1084.1164450972433;1084.4631907205944;1084.8860869608657;1073.3935326540518;1075.6289080267334;1077.854489643896;1078.2398409121552;1078.7357097511122;1058.2803693488424;1101.1631160318175;1105.5412004018324;1105.618561596248;1141.6860363400049;1069.1340014588131;1095.5782023920767;1096.1121491591837;1098.1489345757063;1098.6154845803944;827.5903427803215;830.2693629605968;830.5515021888173;831.7546323834483;832.0722394530115;19109.426717198367;19122;19264.036798160036;19267.51831204217;19287.807121928883;21771.67342489848;22661.43346416336;23012.65481017786;23100.306990790305;23179.3046208614;16928.322867085302;17052.48842534726;17098.14509274544;17162.227699753417;17239.13804309792;4002.519697636273;4010.3783913493453;4022.4368588397647;4023.2154729827694;4028.0936789222483;127828;157580.21209893993;160718;160750.19624901918;162605.9999999988;16957.491275261516;17067.317307307567;17224;17388.652226955644;17451.912740436215;34976;34985;35048.64951350454;35245.82377088098;35676.10809729777;9514.809703805886;9533.189678877234;9557.713268601952;9557.952210239044;9569.904300956901;4398.164348773723;4467.508574056851;4508.909821803545;4541.137183935041;4544.091181763661;6122.295935967331;6164.907526387108;6212.316645169028;6216.098665693449;6271.027990661455;1094.7591529863416;1098.3794156301665;1109.2235435195396;1127.6335191062938;1129.7740451909488;738.3428748413916;753.2279413601103;761.6991288441035;767.8349154931605;776.4991580430591;13167.341632918316;13214.273214973076;13263.469461221635;13776.93111534436;14081.929590351983;740.6704016712512;743.7173873927981;751.8308380614427;768.3699366519512;768.3776141325544;6287.685615719196;6384.201974753156;6393.360663933662;6471.514636402195;6586.308437614078;147738.26130869277;150814;151284;151780.2410987938;157458;96744.51627741817;100328.49835750775;120717;131220;139056.30471847576;105192;107361;111104.44447777871;112068;114401.4279928595;13867.167969921433;14638.194899280641;14822.62943426423;14836.629084272548;15087.924560377567;50699.239511406624;52182.47817521928;53764.46235537751;54067.72966135144;55455.445445545025;71521.64239178771;71672;71711;71830.28169718236;72698.63650681713;19536.8046319535;21042.68435973492;21045.368638940858;21068.473288167304;21128.366149015554;22776.430589235402;22899.771002290432;23062;23066.654000190345;23354.299371018897;19823.900880495505;19832.40502784919;19867.304644337957;19961.00974756311;19988.700169497177;20583.58832823365;20630.17479300811;20725.27461538839;20726.79273207309;20980.160793568695;18943;19003.90498047501;19111.713324299868;19128.904355478135;19228.423147305602;13483.932580337036;13738.86261137376;13897.72204555883;13922.025458218233;14176.362063707364;15370.23148842531;15588.76616850771;15735.842641573438;15774.842251577797;15909 16:01:49 INFO - PID 6064 | __end_tp_report 16:01:49 INFO - PID 6064 | __start_cc_report 16:01:49 INFO - PID 6064 | _x_x_mozilla_cycle_collect,348 16:01:49 INFO - PID 6064 | __end_cc_report 16:01:49 INFO - PID 6064 | __startTimestamp1505343709268__endTimestamp 16:01:49 INFO - PID 6064 | 16:01:49 INFO - PID 6064 | ------- Summary: start ------- 16:01:49 INFO - PID 6064 | Number of tests: 6 16:01:49 INFO - PID 6064 | 16:01:49 INFO - PID 6064 | [#0] dojo.html Cycles:165 Average:6342.43 Median:6580.34 stddev:751.97 (11.4%) stddev-sans-first:729.55 16:01:49 INFO - PID 6064 | Values: 3904.7 3933.2 3947.3 3947.7 3951.6 6315.4 6323.8 6393.9 6399.9 6486.1 6239.1 6338.9 6367.3 6373.8 6375.3 5671.1 5756.1 5787.7 5792.4 5800.1 5462.6 5807.7 5812.2 5859.3 5887.9 5627.2 5646.5 5709.2 5727.1 5732.6 5643.3 5677.9 5731.7 5759.1 5770.2 5675.4 5682.8 5733.7 5751.5 5753.2 6238.8 6259.8 6370.9 6370.9 6391.5 6895.1 6912.8 6913.0 6922.5 6986.4 6912.1 6916.9 6922.4 6951.5 7027.5 6335.5 6356.9 6408.0 6467.6 6482.3 6964.9 7002.4 7067.3 7072.5 7075.8 6769.0 6774.7 6796.6 6806.7 6838.8 6906.9 6957.2 6976.8 6981.9 6988.7 6838.7 6864.4 6901.2 6909.4 6928.4 6779.3 6780.4 6863.1 6878.3 6883.4 4977.6 4991.6 4991.9 4999.4 5012.9 4531.3 4564.5 4581.2 4612.8 4624.3 6257.8 6305.9 6408.4 6418.6 6423.0 6788.4 6874.2 6879.8 6885.7 6972.3 6320.8 6358.8 6364.0 6365.6 6369.0 5544.1 5595.7 5610.7 5618.9 5619.4 7059.8 7139.5 7150.4 7223.1 7234.9 6783.2 6880.0 6889.5 6989.0 6990.3 7143.9 7166.7 7180.0 7184.9 7220.4 6799.5 6832.1 6865.1 6909.8 6921.8 6882.9 6918.8 7000.5 7009.0 7030.1 6533.7 6608.4 6612.5 6615.0 6707.4 6599.8 6610.2 6625.1 6626.4 6627.4 6529.8 6583.2 6611.6 6614.5 6651.3 6559.4 6653.9 6679.0 6729.6 6730.8 6388.5 6481.5 6485.7 6575.9 6580.3 16:01:49 INFO - PID 6064 | 16:01:49 INFO - PID 6064 | [#1] ext.html Cycles:180 Average:41880.25 Median:20302.78 stddev:61721.99 (304.0%) stddev-sans-first:61818.37 16:01:49 INFO - PID 6064 | Values: 884.7 949.9 955.5 993.5 1001.7 43688.0 44121.1 44566.0 44704.8 44846.6 41608.6 41699.4 41968.6 42058.8 42066.8 7193.4 7199.6 7213.2 7226.3 7297.9 7415.4 7426.3 7486.3 7500.7 7523.5 7469.3 8051.0 8184.1 8208.8 8236.9 8093.2 8135.5 8145.8 8146.8 8175.5 7799.2 7884.9 7890.1 7896.9 8061.2 40627.6 40835.0 41065.0 41180.0 41247.0 3693.7 3761.7 3765.1 3766.0 3766.3 31615.9 31657.8 31723.2 32125.0 32271.4 5522.1 5558.6 5566.7 5567.7 5655.3 204896.0 205309.0 205440.0 205734.0 205937.0 51319.5 51408.2 51702.2 51777.2 51841.5 54424.5 54453.0 54590.2 54635.5 54760.0 15037.9 15301.8 15314.2 15314.5 15384.4 12378.8 12381.0 12412.9 12444.4 12456.8 14529.8 14657.0 14682.8 14852.2 14917.9 5727.5 5737.5 5845.6 5870.5 5905.9 1111.4 1112.1 1115.8 1125.6 1128.6 25623.4 25643.4 25695.4 25817.6 25830.2 1193.8 1210.6 1212.2 1213.1 1244.1 13684.7 13793.9 13799.0 13842.2 13954.0 267648.0 268796.0 269493.0 269933.0 270387.0 58303.4 58397.7 62976.7 63634.4 64197.0 1495.8 1537.3 1537.3 1538.5 1543.8 30703.6 30979.2 31262.5 31452.4 31971.2 42209.6 42446.6 42463.4 42529.8 42577.0 232861.0 233208.0 233510.0 233658.0 234458.0 35516.1 36189.0 36361.8 36600.6 36911.8 46960.0 47683.3 47830.3 48489.0 48636.0 34764.5 35310.0 35446.8 35597.6 35641.5 35076.5 35124.8 35130.0 35286.8 35929.5 42051.8 42177.2 42191.4 42614.4 42686.8 34299.3 34336.0 34393.1 34798.5 35140.8 26205.9 26245.3 26402.6 26417.7 26610.0 16:01:49 INFO - PID 6064 | 16:01:49 INFO - PID 6064 | [#2] jquery.html Cycles:180 Average:39234.37 Median:12628.49 stddev:101019.38 (799.9%) stddev-sans-first:101261.11 16:01:49 INFO - PID 6064 | Values: 594.2 595.5 601.2 611.2 625.2 22972.0 23539.1 23589.0 23638.2 23656.4 21523.0 24729.4 25474.7 25672.9 25691.4 6646.1 6854.1 6855.5 6860.0 6860.2 6482.2 6622.0 6719.3 6760.5 6781.1 6716.7 6722.3 6722.5 6729.2 6730.8 6510.7 6731.9 6734.6 6756.6 6762.4 6241.4 6264.2 6279.3 6303.5 6306.3 29396.1 29869.5 29879.7 29902.4 29928.0 2231.2 2262.4 2271.0 2282.0 2285.0 19624.9 20533.2 20576.4 20603.2 20629.0 2515.8 2525.1 2601.4 2609.9 2611.8 132302.0 137746.0 152756.0 159457.0 160224.0 15150.9 15628.5 15805.4 15954.7 17285.9 25353.7 25370.6 25421.0 25504.5 25533.5 10383.4 10440.3 10502.0 10539.8 10613.9 9336.8 9386.5 9551.1 9620.1 9623.3 9435.5 9613.9 9675.0 9690.3 9889.8 2792.4 2891.8 2907.1 2919.5 3025.4 1020.5 1040.4 1048.1 1063.1 1063.1 20253.4 20273.6 20488.0 20538.7 20612.2 1106.1 1113.9 1122.7 1125.8 1129.9 11073.8 11147.5 11177.5 11368.9 11391.8 582991.0 596631.0 600591.0 617867.0 622571.0 125364.0 126807.0 126961.4 128533.0 130257.0 1205.4 1214.5 1246.3 1254.4 1258.2 17966.0 18042.0 18067.5 18261.5 18347.4 59607.4 60527.0 62306.4 62936.4 63260.7 77134.0 78183.0 78392.6 78594.0 78716.2 14774.0 14974.3 15022.2 15186.6 15199.6 23346.0 23350.5 23424.4 23616.9 23670.8 18352.8 18462.5 18624.5 19430.0 19678.1 17156.1 17180.4 17559.8 17592.0 17804.6 18610.0 19744.2 19895.0 19969.5 20049.2 14721.5 14880.7 14899.3 14914.3 14928.7 18558.6 18601.7 18804.3 18995.8 19018.4 16:01:49 INFO - PID 6064 | 16:01:49 INFO - PID 6064 | [#3] mootools.html Cycles:180 Average:10459.71 Median:2693.46 stddev:7815.79 (290.2%) stddev-sans-first:7808.06 16:01:49 INFO - PID 6064 | Values: 1397.6 1449.7 1451.1 1462.6 1464.4 16502.2 17301.9 17327.8 17470.0 17517.3 17158.6 17269.6 17285.4 17308.7 17347.4 2660.0 2800.7 2811.1 2811.5 2812.6 2786.0 2868.3 2871.4 2872.2 2873.9 2672.1 2728.3 2730.5 2731.5 2732.2 2694.5 2696.6 2707.4 2710.2 2714.0 2667.7 2674.5 2674.8 2692.4 2695.7 16758.0 16849.8 16852.2 17002.1 17057.4 8234.6 8512.9 8514.4 8516.2 8543.2 5399.8 5447.5 5534.0 5681.8 5736.7 2053.6 2066.5 2071.1 2088.3 2120.9 31510.7 31544.5 31682.8 31855.4 31857.4 7194.5 7225.1 7290.9 7385.7 7409.0 19853.4 19894.5 20007.9 20070.9 20082.3 8715.5 8934.3 8935.7 8944.5 8953.8 7682.9 7812.2 7819.0 7841.0 7856.6 5851.4 6002.7 6032.0 6063.8 6100.5 1873.6 1874.9 1883.8 1893.2 1925.1 927.6 947.5 951.9 964.7 965.5 8506.7 8510.7 8563.2 8617.5 8634.5 772.2 787.5 798.7 804.0 808.2 5141.6 5467.9 5832.6 6019.8 6054.2 24492.9 25180.5 25297.4 25404.7 25454.7 23271.2 24530.8 24599.3 24611.8 24622.9 12401.6 12517.4 12524.5 12545.8 12610.4 9104.2 9379.2 9380.5 9430.2 9469.3 20517.7 20877.9 21016.8 21128.3 21615.9 21123.4 21526.7 21558.9 21575.9 21628.8 13558.2 13760.2 13781.6 13785.2 13789.4 15659.3 15794.1 15883.4 15891.6 16028.0 12546.4 12566.4 12943.7 12964.0 12986.2 12149.6 12153.5 12209.8 12224.9 12566.1 10184.5 10256.0 10294.4 10369.5 10448.3 7930.1 7996.6 8011.7 8020.1 8111.9 7234.7 7422.4 7452.7 7493.5 7497.4 16:01:49 INFO - PID 6064 | 16:01:49 INFO - PID 6064 | [#4] prototype.html Cycles:180 Average:5642.29 Median:6215.94 stddev:1522.06 (24.5%) stddev-sans-first:1477.41 16:01:49 INFO - PID 6064 | Values: 542.4 548.1 580.3 581.9 582.7 6239.6 6242.8 6282.7 6354.8 6371.0 6215.9 6216.0 6261.8 6294.8 6295.6 5094.2 5100.9 5106.7 5126.9 5141.6 4906.4 4991.3 4999.9 5110.2 5122.4 4987.7 4990.3 4994.6 4996.2 5019.7 4973.0 4979.4 4987.2 4987.5 4998.9 4411.4 4489.4 4492.8 4520.0 4550.8 6069.8 6127.0 6131.6 6142.9 6169.9 5766.5 5811.5 5843.9 5855.1 5867.4 6541.4 6566.9 6582.5 6598.0 6604.5 4833.6 4981.0 5009.7 5016.6 5031.4 6662.7 6773.2 6783.6 6894.6 6954.3 5524.4 5551.7 5585.4 5603.4 5624.4 5672.6 5685.6 5689.5 5701.7 5749.8 6083.2 6113.7 6116.1 6121.2 6124.0 6653.0 6695.8 6717.8 6730.7 6750.0 1948.1 1960.4 1972.6 1979.2 1998.3 1435.0 1497.5 1501.7 1506.9 1509.0 5912.0 5972.5 6001.9 6066.0 6091.7 6521.3 6529.6 6546.3 6625.8 6690.9 5940.1 6020.6 6052.0 6056.8 6084.5 3468.9 3470.7 3471.3 3492.2 3543.6 6739.3 6810.4 6858.9 6874.6 6904.0 6685.2 6701.5 6830.1 6839.4 6856.7 6725.1 6728.9 6874.7 6946.8 7018.7 6601.7 6616.0 6663.3 6686.0 6704.5 6670.3 6686.3 6703.2 6772.6 6775.3 6924.1 6925.6 6968.9 6989.4 7031.5 5504.4 5528.3 5562.1 5637.4 5670.3 6476.5 6530.7 6695.6 6761.5 6798.6 6409.6 6460.9 6462.9 6501.8 6510.8 6418.5 6432.1 6450.6 6527.9 6547.9 6418.5 6434.9 6455.0 6456.2 6469.5 6536.2 6542.4 6553.3 6562.8 6566.2 6353.8 6358.6 6374.3 6424.2 6434.5 16:01:49 INFO - PID 6064 | 16:01:49 INFO - PID 6064 | [#5] yui.html Cycles:180 Average:27991.14 Median:19277.66 stddev:40784.20 (211.6%) stddev-sans-first:40848.16 16:01:49 INFO - PID 6064 | Values: 975.3 990.4 1003.1 1006.6 1011.2 19592.1 19950.2 19961.5 19962.2 19964.8 16334.8 16349.3 17680.0 17843.9 17847.6 1069.1 1084.0 1084.1 1084.5 1084.9 1073.4 1075.6 1077.9 1078.2 1078.7 1058.3 1101.2 1105.5 1105.6 1141.7 1069.1 1095.6 1096.1 1098.1 1098.6 827.6 830.3 830.6 831.8 832.1 19109.4 19122.0 19264.0 19267.5 19287.8 21771.7 22661.4 23012.7 23100.3 23179.3 16928.3 17052.5 17098.1 17162.2 17239.1 4002.5 4010.4 4022.4 4023.2 4028.1 127828.0 157580.2 160718.0 160750.2 162606.0 16957.5 17067.3 17224.0 17388.7 17451.9 34976.0 34985.0 35048.6 35245.8 35676.1 9514.8 9533.2 9557.7 9558.0 9569.9 4398.2 4467.5 4508.9 4541.1 4544.1 6122.3 6164.9 6212.3 6216.1 6271.0 1094.8 1098.4 1109.2 1127.6 1129.8 738.3 753.2 761.7 767.8 776.5 13167.3 13214.3 13263.5 13776.9 14081.9 740.7 743.7 751.8 768.4 768.4 6287.7 6384.2 6393.4 6471.5 6586.3 147738.3 150814.0 151284.0 151780.2 157458.0 96744.5 100328.5 120717.0 131220.0 139056.3 105192.0 107361.0 111104.4 112068.0 114401.4 13867.2 14638.2 14822.6 14836.6 15087.9 50699.2 52182.5 53764.5 54067.7 55455.4 71521.6 71672.0 71711.0 71830.3 72698.6 19536.8 21042.7 21045.4 21068.5 21128.4 22776.4 22899.8 23062.0 23066.7 23354.3 19823.9 19832.4 19867.3 19961.0 19988.7 20583.6 20630.2 20725.3 20726.8 20980.2 18943.0 19003.9 19111.7 19128.9 19228.4 13483.9 13738.9 13897.7 13922.0 14176.4 15370.2 15588.8 15735.8 15774.8 15909.0 16:01:49 INFO - PID 6064 | -------- Summary: end -------- 16:01:49 INFO - PID 6064 | 16:01:49 INFO - PID 6064 | 16:01:49 INFO - PID 6064 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 16:01:49 INFO - PID 6064 | 16:01:49 INFO - TEST-INFO | 6064: exit 0 16:01:49 INFO - TEST-OK | dromaeo_css | took 1108457ms 16:01:49 INFO - TEST-START | kraken 16:01:49 INFO - Initialising browser for kraken test... 16:01:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60078/getInfo.html -profile /tmp/tmpq9auac/profile 16:01:49 INFO - TEST-INFO | started process 6431 (/builds/slave/test/build/application/firefox/firefox http://localhost:60078/getInfo.html) 16:01:55 INFO - TEST-INFO | 6431: exit 0 16:01:55 INFO - Browser initialized. 16:01:55 INFO - Running cycle 1/1 for kraken test... 16:01:55 INFO - Using env: {'DISPLAY': ':0', 16:01:55 INFO - 'HOME': '/home/cltbld', 16:01:55 INFO - 'JSGC_DISABLE_POISONING': '1', 16:01:55 INFO - 'LANG': 'en_US.UTF-8', 16:01:55 INFO - 'LANGUAGE': 'en_US:en', 16:01:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:01:55 INFO - 'LOGNAME': 'cltbld', 16:01:55 INFO - 'MAIL': '/var/mail/cltbld', 16:01:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:01:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:01:55 INFO - 'MOZ_CRASHREPORTER': '1', 16:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:01:55 INFO - 'MOZ_NO_REMOTE': '1', 16:01:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:55 INFO - 'NO_EM_RESTART': '1', 16:01:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:55 INFO - 'PWD': '/builds/slave/test', 16:01:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:01:55 INFO - 'RUST_BACKTRACE': 'full', 16:01:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:01:55 INFO - 'SHELL': '/bin/bash', 16:01:55 INFO - 'SHLVL': '1', 16:01:55 INFO - 'STYLO_FORCE_DISABLED': '1', 16:01:55 INFO - 'TERM': 'linux', 16:01:55 INFO - 'TMOUT': '86400', 16:01:55 INFO - 'USER': 'cltbld', 16:01:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1505342541.595682-1789722209', 16:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:55 INFO - '_': '/tools/buildbot/bin/python'} 16:01:55 INFO - TEST-INFO | started process 6661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq9auac/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:01:55 INFO - PID 6661 | 16:01:55 INFO - PID 6661 | (/builds/slave/test/build/application/firefox/firefox:6710): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:01:55 INFO - PID 6661 | 16:02:06 INFO - PID 6661 | RSS: Main: 166752256 16:02:06 INFO - PID 6661 | 16:02:08 INFO - PID 6661 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60078/tests/kraken/driver.html?testName=audio-beat-detection) 16:02:09 INFO - PID 6661 | RSS: Main: 173412352 16:02:09 INFO - PID 6661 | 16:02:12 INFO - PID 6661 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60078/tests/kraken/driver.html?testName=audio-dft) 16:02:13 INFO - PID 6661 | RSS: Main: 173383680 16:02:13 INFO - PID 6661 | 16:02:15 INFO - PID 6661 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60078/tests/kraken/driver.html?testName=audio-fft) 16:02:16 INFO - PID 6661 | RSS: Main: 167526400 16:02:16 INFO - PID 6661 | 16:02:18 INFO - PID 6661 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60078/tests/kraken/driver.html?testName=audio-oscillator) 16:02:19 INFO - PID 6661 | RSS: Main: 169226240 16:02:19 INFO - PID 6661 | 16:02:21 INFO - PID 6661 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60078/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:02:21 INFO - PID 6661 | RSS: Main: 169017344 16:02:21 INFO - PID 6661 | 16:02:24 INFO - PID 6661 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60078/tests/kraken/driver.html?testName=imaging-darkroom) 16:02:25 INFO - PID 6661 | RSS: Main: 170110976 16:02:25 INFO - PID 6661 | 16:02:29 INFO - PID 6661 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60078/tests/kraken/driver.html?testName=imaging-desaturate) 16:02:29 INFO - PID 6661 | RSS: Main: 171081728 16:02:29 INFO - PID 6661 | 16:02:32 INFO - PID 6661 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60078/tests/kraken/driver.html?testName=json-parse-financial) 16:02:33 INFO - PID 6661 | RSS: Main: 171520000 16:02:33 INFO - PID 6661 | 16:02:34 INFO - PID 6661 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60078/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:02:35 INFO - PID 6661 | RSS: Main: 171388928 16:02:35 INFO - PID 6661 | 16:02:37 INFO - PID 6661 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60078/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:02:37 INFO - PID 6661 | RSS: Main: 171298816 16:02:37 INFO - PID 6661 | 16:02:39 INFO - PID 6661 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60078/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:02:40 INFO - PID 6661 | RSS: Main: 168689664 16:02:40 INFO - PID 6661 | 16:02:42 INFO - PID 6661 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:02:43 INFO - PID 6661 | RSS: Main: 168734720 16:02:43 INFO - PID 6661 | 16:02:46 INFO - PID 6661 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:02:46 INFO - PID 6661 | RSS: Main: 169418752 16:02:46 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60078/tests/kraken/driver.html?testName=ai-astar) 16:02:48 INFO - PID 6661 | RSS: Main: 171073536 16:02:48 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | __start_tp_report 16:02:48 INFO - PID 6661 | _x_x_mozilla_page_load 16:02:48 INFO - PID 6661 | _x_x_mozilla_page_load_details 16:02:48 INFO - PID 6661 | |i|pagename|runs| 16:02:48 INFO - PID 6661 | |0;ai-astar;106;106;106;106;105;98;106;107;106;106 16:02:48 INFO - PID 6661 | |1;audio-beat-detection;111;112;112;112;116;112;112;116;136;114 16:02:48 INFO - PID 6661 | |2;audio-dft;163;162;162;163;160;162;161;162;164;173 16:02:48 INFO - PID 6661 | |3;audio-fft;76;72;73;72;75;76;75;74;79;72 16:02:48 INFO - PID 6661 | |4;audio-oscillator;78;78;77;78;78;78;79;84;78;79 16:02:48 INFO - PID 6661 | |5;imaging-gaussian-blur;113;117;117;114;113;113;113;114;113;114 16:02:48 INFO - PID 6661 | |6;imaging-darkroom;149;149;149;154;149;149;149;150;153;151 16:02:48 INFO - PID 6661 | |7;imaging-desaturate;94;94;94;95;94;94;94;95;94;100 16:02:48 INFO - PID 6661 | |8;json-parse-financial;48;46;44;45;58;45;51;44;44;47 16:02:48 INFO - PID 6661 | |9;json-stringify-tinderbox;38;38;42;38;38;38;38;38;38;38 16:02:48 INFO - PID 6661 | |10;stanford-crypto-aes;77;71;71;70;71;73;74;74;71;72 16:02:48 INFO - PID 6661 | |11;stanford-crypto-ccm;113;110;109;106;111;104;103;112;109;101 16:02:48 INFO - PID 6661 | |12;stanford-crypto-pbkdf2;161;153;155;153;160;159;156;169;148;149 16:02:48 INFO - PID 6661 | |13;stanford-crypto-sha256-iterative;60;58;64;62;59;58;61;60;58;59 16:02:48 INFO - PID 6661 | __end_tp_report 16:02:48 INFO - PID 6661 | __start_cc_report 16:02:48 INFO - PID 6661 | _x_x_mozilla_cycle_collect,884 16:02:48 INFO - PID 6661 | __end_cc_report 16:02:48 INFO - PID 6661 | __startTimestamp1505343768707__endTimestamp 16:02:48 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | ------- Summary: start ------- 16:02:48 INFO - PID 6661 | Number of tests: 14 16:02:48 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | [#0] ai-astar Cycles:10 Average:105.20 Median:106.00 stddev:2.57 (2.4%) stddev-sans-first:2.71 16:02:48 INFO - PID 6661 | Values: 106.0 106.0 106.0 106.0 105.0 98.0 106.0 107.0 106.0 106.0 16:02:48 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | [#1] audio-beat-detection Cycles:10 Average:115.30 Median:113.00 stddev:7.48 (6.6%) stddev-sans-first:7.77 16:02:48 INFO - PID 6661 | Values: 111.0 112.0 112.0 112.0 116.0 112.0 112.0 116.0 136.0 114.0 16:02:48 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:3.61 (2.2%) stddev-sans-first:3.83 16:02:48 INFO - PID 6661 | Values: 163.0 162.0 162.0 163.0 160.0 162.0 161.0 162.0 164.0 173.0 16:02:48 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | [#3] audio-fft Cycles:10 Average:74.40 Median:75.00 stddev:2.27 (3.0%) stddev-sans-first:2.33 16:02:48 INFO - PID 6661 | Values: 76.0 72.0 73.0 72.0 75.0 76.0 75.0 74.0 79.0 72.0 16:02:48 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | [#4] audio-oscillator Cycles:10 Average:78.70 Median:78.00 stddev:1.95 (2.5%) stddev-sans-first:2.05 16:02:48 INFO - PID 6661 | Values: 78.0 78.0 77.0 78.0 78.0 78.0 79.0 84.0 78.0 79.0 16:02:48 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.60 (1.4%) stddev-sans-first:1.64 16:02:48 INFO - PID 6661 | Values: 113.0 117.0 117.0 114.0 113.0 113.0 113.0 114.0 113.0 114.0 16:02:48 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:149.50 stddev:1.87 (1.3%) stddev-sans-first:1.94 16:02:48 INFO - PID 6661 | Values: 149.0 149.0 149.0 154.0 149.0 149.0 149.0 150.0 153.0 151.0 16:02:48 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:1.87 (2.0%) stddev-sans-first:1.96 16:02:48 INFO - PID 6661 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 100.0 16:02:48 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | [#8] json-parse-financial Cycles:10 Average:47.20 Median:46.50 stddev:4.39 (9.4%) stddev-sans-first:4.65 16:02:48 INFO - PID 6661 | Values: 48.0 46.0 44.0 45.0 58.0 45.0 51.0 44.0 44.0 47.0 16:02:48 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | [#9] json-stringify-tinderbox Cycles:10 Average:38.40 Median:38.00 stddev:1.26 (3.3%) stddev-sans-first:1.33 16:02:48 INFO - PID 6661 | Values: 38.0 38.0 42.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 16:02:48 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:72.50 stddev:2.12 (2.9%) stddev-sans-first:1.45 16:02:48 INFO - PID 6661 | Values: 77.0 71.0 71.0 70.0 71.0 73.0 74.0 74.0 71.0 72.0 16:02:48 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | [#11] stanford-crypto-ccm Cycles:10 Average:107.80 Median:109.50 stddev:4.08 (3.7%) stddev-sans-first:3.87 16:02:48 INFO - PID 6661 | Values: 113.0 110.0 109.0 106.0 111.0 104.0 103.0 112.0 109.0 101.0 16:02:48 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:157.50 stddev:6.24 (4.0%) stddev-sans-first:6.38 16:02:48 INFO - PID 6661 | Values: 161.0 153.0 155.0 153.0 160.0 159.0 156.0 169.0 148.0 149.0 16:02:48 INFO - PID 6661 | 16:02:48 INFO - PID 6661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.90 Median:60.00 stddev:1.97 (3.3%) stddev-sans-first:2.09 16:02:48 INFO - PID 6661 | Values: 60.0 58.0 64.0 62.0 59.0 58.0 61.0 60.0 58.0 59.0 16:02:48 INFO - PID 6661 | -------- Summary: end -------- 16:02:48 INFO - PID 6661 | 16:02:49 INFO - PID 6661 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:02:49 INFO - TEST-INFO | 6661: exit 0 16:02:49 INFO - TEST-OK | kraken | took 59409ms 16:02:49 INFO - SUITE-END | took 1167s 16:02:49 INFO - Completed test suite (00:19:28) 16:02:49 INFO - javascript benchmark 16:02:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9081.97748184672, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3904.7461914975524, 3933.2133573285314, 3947.2894878921784, 3947.68418526518, 3951.6443520083185, 6315.400036996478, 6323.810285691437, 6393.904091438632, 6399.912014957456, 6486.124373209615, 6239.095331176988, 6338.873222535546, 6367.299597044322, 6373.8087857364235, 6375.2987171411105, 5671.120976248668, 5756.050251708484, 5787.652740835542, 5792.420757924216, 5800.071988481844, 5462.644928079662, 5807.651540907538, 5812.215350927613, 5859.296884373881, 5887.88224235515, 5627.184058311563, 5646.491815736604, 5709.200711900337, 5727.140928860684, 5732.5987180897355, 5643.266375371217, 5677.886442271173, 5731.742071606787, 5759.107338362561, 5770.16332631766, 5675.404082571312, 5682.772689092431, 5733.741981610838, 5751.453611906904, 5753.223314852483, 6238.781642642532, 6259.812205633838, 6370.936290637081, 6370.936290637081, 6391.45672617828, 6895.138107736533, 6912.758053468105, 6913.032175495435, 6922.5154239203275, 6986.44108471321, 6912.135983002125, 6916.930830691679, 6922.446204303644, 6951.5481493703255, 7027.543209691354, 6335.461485773715, 6356.872862542816, 6408.038794180864, 6467.579607325509, 6482.254540727782, 6964.860702785916, 7002.404795592432, 7067.293270672892, 7072.5402848814665, 7075.82310442243, 6769.018492318586, 6774.661266936633, 6796.626185559841, 6806.727730890808, 6838.760643377458, 6906.861862762717, 6957.199922008933, 6976.825579360455, 6981.930180698128, 6988.6855091521, 6838.692258848364, 6864.416524595365, 6901.240863505011, 6909.378155965987, 6928.411085057826, 6779.2881747416795, 6780.355866192704, 6863.10779598649, 6878.312168783082, 6883.414909732629, 4977.626677999165, 4991.550760431579, 4991.850244492671, 4999.350084489066, 5012.947281071016, 4531.342955271467, 4564.452265728068, 4581.152486789888, 4612.815487380534, 4624.28323609841, 6257.843553911189, 6305.905411418832, 6408.359164083648, 6418.550701450947, 6422.967885160544, 6788.422984046411, 6874.175098988054, 6879.759208427681, 6885.724571017204, 6972.302769722987, 6320.810375688737, 6358.841028974312, 6364.045393191059, 6365.618062916147, 6369.0, 5544.085225937756, 5595.720213989284, 5610.691411972381, 5618.91571626426, 5619.381867994517, 7059.788206353817, 7139.500234983501, 7150.3922166615375, 7223.133224013152, 7234.855302894018, 6783.21992970795, 6880.0367948486255, 6889.483288753263, 6988.965055174692, 6990.335918087671, 7143.892841607276, 7166.677499512639, 7179.964100179465, 7184.892226616709, 7220.38626716735, 6799.456043516408, 6832.111825462658, 6865.107536020286, 6909.7581584644295, 6921.826954326182, 6882.8967565485555, 6918.792436226921, 7000.50996430245, 7008.964955175192, 7030.121234845645, 6533.67331633407, 6608.372204640552, 6612.5040621952585, 6614.966925165536, 6707.396334329934, 6599.835004124743, 6610.2398224204835, 6625.138731964814, 6626.4367528760595, 6627.403533681992, 6529.771457998947, 6583.177102862142, 6611.570247934062, 6614.4708423325055, 6651.26836048044, 6559.442447392025, 6653.866922661423, 6679.0, 6729.5625784323865, 6730.831729206809, 6388.488920886411, 6481.5138864584405, 6485.708143133476, 6575.901361479486, 6580.341965803382], "value": 6291.509756216013, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [884.7257350221432, 949.9287553433494, 955.493588398149, 993.46849435552, 1001.6744558018642, 43688.0, 44121.11757764847, 44566.0, 44704.77647611757, 44846.55153448464, 41608.58391416085, 41699.37450938238, 41968.58031419685, 42058.7897060515, 42066.7896660517, 7193.388561972226, 7199.640017999105, 7213.206547279795, 7226.349628533431, 7297.854042919138, 7415.443841711894, 7426.257374262585, 7486.251374862497, 7500.662470188828, 7523.473356865022, 7469.327760501554, 8050.959745201295, 8184.058833234195, 8208.794780130485, 8236.917630823675, 8093.1502192269845, 8135.511869287861, 8145.837083258331, 8146.75559733209, 8175.468594541336, 7799.220077992212, 7884.935533702934, 7890.053193616803, 7896.921030789734, 8061.193880611951, 40627.59372406297, 40835.0, 41065.0, 41180.0, 41247.0, 3693.741438099334, 3761.699064074895, 3765.058735316171, 3765.9643598010766, 3766.2844059628856, 31615.893443729357, 31657.84171079153, 31723.206919826956, 32125.0, 32271.35457290841, 5522.088855338864, 5558.638688485235, 5566.693831839248, 5567.749451274703, 5655.321361436613, 204896.0, 205309.0, 205440.0, 205733.99999999852, 205937.0, 51319.48680513147, 51408.228876566136, 51702.22446663303, 51777.22334164991, 51841.48158518442, 54424.45575544194, 54453.0, 54590.18114728282, 54635.45364546383, 54760.0, 15037.924810376097, 15301.770473442908, 15314.234288285541, 15314.463993760388, 15384.38462461489, 12378.75242495163, 12381.00951923844, 12412.875871241173, 12444.440000200013, 12456.75086498265, 14529.78205326921, 14657.0, 14682.779758303634, 14852.183129927742, 14917.850821491864, 5727.484526392562, 5737.483626473638, 5845.590808643439, 5870.501007414332, 5905.881882362329, 1111.3831823337964, 1112.0603090388609, 1115.754534002518, 1125.5722825326325, 1128.6049882541208, 25623.359416014748, 25643.35891602725, 25695.357616059748, 25817.612735808976, 25830.225093247234, 1193.8328633991248, 1210.6186551236508, 1212.2181193130382, 1213.1326101837228, 1244.147758785235, 13684.726305474034, 13793.86206137946, 13799.0, 13842.16946983164, 13954.0, 267648.0, 268796.0, 269493.0, 269933.0, 270387.0, 58303.41696583065, 58397.70801145967, 62976.685116574125, 63634.363656362846, 64197.0, 1495.8279797823172, 1537.269796846489, 1537.3158944269917, 1538.538438468455, 1543.7761524578873, 30703.560789331736, 30979.225519362197, 31262.53106203454, 31452.370952581277, 31971.200719982186, 42209.57790422056, 42446.575534244264, 42463.36304955366, 42529.787351063045, 42577.0, 232861.0, 233208.0, 233510.0, 233658.0, 234458.0, 35516.11209719778, 36189.0, 36361.818190908874, 36600.63399365972, 36911.815440922626, 46960.0, 47683.284750728075, 47830.28254576254, 48489.0, 48636.0, 34764.47853282152, 35310.0, 35446.82276588704, 35597.644023559435, 35641.46537801883, 35076.473852891715, 35124.82437587796, 35130.0, 35286.823565882005, 35929.46105808362, 42051.7897410511, 42177.15645687131, 42191.367129493694, 42614.36078458888, 42686.78656606697, 34299.31401372008, 34336.0, 34393.14017149491, 34798.47802283018, 35140.82429587836, 26205.868970655025, 26245.343866402727, 26402.603960940985, 26417.735822642295, 26610.0], "value": 18490.119917152497, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.1918990173366, 595.5414330965154, 601.1994077737178, 611.1535523300228, 625.2403329954105, 22972.0, 23539.058437662494, 23589.0, 23638.172663956764, 23656.408589785242, 21523.0, 24729.381765455873, 25474.74525254747, 25672.871635641797, 25691.357716057108, 6646.136002319704, 6854.074699915523, 6855.451563874878, 6860.0, 6860.176778786527, 6482.189726284215, 6622.0, 6719.294474080224, 6760.492963027768, 6781.050652908572, 6716.731330746764, 6722.327767223287, 6722.462203023771, 6729.158855143107, 6730.798076057726, 6510.674466276667, 6731.899021514657, 6734.56225345351, 6756.560823546478, 6762.391384775345, 6241.375862413768, 6264.21697287839, 6279.277883043463, 6303.527235457359, 6306.274778400497, 29396.118116456542, 29869.461095806884, 29879.701202987908, 29902.401951960837, 29928.0, 2231.241377931511, 2262.3778460923213, 2271.0348102056723, 2282.0, 2284.9885750571307, 19624.901875490676, 20533.178672853068, 20576.38270851862, 20603.175872965065, 20629.0, 2515.8490490570443, 2525.1288305534745, 2601.440690251605, 2609.856457894815, 2611.764941155286, 132302.0, 137746.0, 152756.0, 159457.0, 160223.99999999884, 15150.924245378923, 15628.4530041448, 15805.446809361618, 15954.68090638204, 17285.91357043207, 25353.74646253514, 25370.619440708037, 25421.0, 25504.489910201693, 25533.48933021329, 10383.428911409794, 10440.269181157399, 10502.0, 10539.84190237147, 10613.9469302653, 9336.786217791643, 9386.530673466299, 9551.14039736427, 9620.13418792298, 9623.326367154232, 9435.481048542397, 9613.903860961302, 9674.952389997128, 9690.321677482509, 9889.80220395588, 2792.3577577157366, 2891.797574169788, 2907.1278616414993, 2919.5474701421313, 3025.4267780753885, 1020.5356562763925, 1040.375774535288, 1048.114343379843, 1063.0910571461288, 1063.1282348474176, 20253.392398228076, 20273.59452810965, 20488.0, 20538.69191962122, 20612.17551297961, 1106.1261603333276, 1113.8941800528937, 1122.6912599035331, 1125.7692173104494, 1129.949152288149, 11073.778524429466, 11147.498362573704, 11177.49701263445, 11368.886311136948, 11391.772164556662, 582991.0, 596631.0, 600591.0, 617867.0, 622571.0, 125364.0, 126807.0, 126961.36519317345, 128533.0, 130257.0, 1205.4033253539378, 1214.502054157791, 1246.2896149195053, 1254.4166962362544, 1258.150748244931, 17966.0, 18042.0, 18067.45797626073, 18261.54346141357, 18347.449576512725, 59607.403925960185, 60527.0, 62306.37693623006, 62936.37063629305, 63260.683696581225, 77134.0, 78183.0, 78392.60803695946, 78594.0, 78716.21283787317, 14774.0, 14974.251287435802, 15022.248887555359, 15186.620334491727, 15199.620009499851, 23346.0, 23350.53298934046, 23424.414389640395, 23616.88191559031, 23670.763292366857, 18352.81647183511, 18462.538436539195, 18624.534386640444, 19430.0, 19678.11448484793, 17156.142192890555, 17180.39868604593, 17559.824401755817, 17592.0, 17804.643907121525, 18610.0, 19744.21023159115, 19895.0, 19969.500762481053, 20049.198032078555, 14721.484748033767, 14880.702385952436, 14899.255037248311, 14914.328855201325, 14928.701425971636, 18558.628827423105, 18601.720974185668, 18804.341848035252, 18995.810041899404, 19018.42944711661], "value": 12580.93785290361, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1397.5737400092971, 1449.7245523350562, 1451.100317802963, 1462.5685422800273, 1464.39227720496, 16502.17489125545, 17301.913490432547, 17327.826721732763, 17470.0, 17517.299308027694, 17158.571035724082, 17269.568260793454, 17285.395011174613, 17308.653826923455, 17347.39284125056, 2659.9734002659966, 2800.705925877784, 2811.1144989328295, 2811.507986102434, 2812.5640525718445, 2785.958210626842, 2868.268591509173, 2871.382652729663, 2872.152714949095, 2873.8850445982134, 2672.0514217452815, 2728.2770065932546, 2730.481208570365, 2731.4946734854016, 2732.180345896233, 2694.488047271022, 2696.595510673405, 2707.3773032202507, 2710.214037928998, 2714.0, 2667.679878414583, 2674.465106978612, 2674.812763106583, 2692.434588736368, 2695.7034726180104, 16758.0, 16849.83150168495, 16852.157392130346, 17002.149892505324, 17057.402990895258, 8234.629441675139, 8512.914870851275, 8514.403991720583, 8516.190961858614, 8543.188397102265, 5399.757010934517, 5447.509724124848, 5534.0315444797, 5681.818181818154, 5736.741846616912, 2053.5790163016545, 2066.5143691232547, 2071.1197740960033, 2088.289981406329, 2120.9469763256043, 31510.684893151003, 31544.526832097537, 31682.841585792154, 31855.362892742247, 31857.362852742815, 7194.460415468756, 7225.132984041844, 7290.854182916418, 7385.7045718170675, 7408.9629551851895, 19853.404397868086, 19894.50263743418, 20007.899960500104, 20070.89964550168, 20082.297119600746, 8715.477071375737, 8934.329925255632, 8935.731928042169, 8944.5080520572, 8953.776155596162, 7682.923170768333, 7812.218778122142, 7819.022622172229, 7840.960795195988, 7856.5678887661725, 5851.38560451155, 6002.69986500682, 6032.0, 6063.818085457355, 6100.511959043355, 1873.6440076385443, 1874.925002999892, 1883.849292056632, 1893.1670065171556, 1925.1336898395778, 927.5918595817818, 947.4978261521404, 951.8905325887612, 964.6864768950119, 965.5461932891529, 8506.65973361071, 8510.65957361711, 8563.186497282748, 8617.48295102296, 8634.481931084156, 772.2470591173561, 787.5274835099009, 798.7124635131348, 804.0, 808.2119933065214, 5141.608295871501, 5467.917981230285, 5832.591718579659, 6019.759209631653, 6054.152418661391, 24492.877535612562, 25180.49639007246, 25297.367565811, 25404.745952540237, 25454.74545254561, 23271.185508507122, 24530.754692452847, 24599.262022139006, 24611.753882461304, 24622.876885615457, 12401.62795116148, 12517.436715348013, 12524.499020039097, 12545.811812822632, 12610.369481525888, 9104.180623743894, 9379.155875971195, 9380.48407337603, 9430.245580353692, 9469.289803264644, 20517.692234616195, 20877.89561052185, 21016.789832102095, 21128.260510882046, 21615.891920540296, 21123.366299011053, 21526.6770998432, 21558.892205538872, 21575.892120539924, 21628.783712162676, 13558.186508809504, 13760.17438953666, 13781.586552403443, 13785.241811700453, 13789.448422063406, 15659.295331709873, 15794.052356858165, 15883.444079457626, 15891.602709932344, 16028.038317700975, 12546.372681366078, 12566.434510446868, 12943.741125177632, 12964.0, 12986.220826750425, 12149.574764883188, 12153.453094610586, 12209.755804883675, 12224.938875305566, 12566.057545684293, 10184.490775461345, 10256.02567756062, 10294.433806140734, 10369.481525923522, 10448.32085914413, 7930.116224086057, 7996.56018918965, 8011.679532818622, 8020.117787043538, 8111.918880811352, 7234.6744396501235, 7422.406207503494, 7452.739154129579, 7493.475456718195, 7497.400207983239], "value": 7266.802089516941, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.3654324440404, 548.1366847215635, 580.303635637235, 581.8661707807204, 582.7202942587558, 6239.594426362283, 6242.781502647408, 6282.654454005028, 6354.80935571933, 6370.968145159273, 6215.875682486348, 6216.0, 6261.780837670683, 6294.842628934279, 6295.559310848243, 5094.235864620318, 5100.897982040357, 5106.697792063019, 5126.92309615356, 5141.562967147787, 4906.362172917516, 4991.301217829507, 4999.900001999958, 5110.156824124015, 5122.436531981479, 4987.650864439491, 4990.27640992056, 4994.550490455858, 4996.225585034307, 5019.673721208128, 4972.950270497285, 4979.402471703419, 4987.1521841286885, 4987.526185012418, 4998.925016124761, 4411.448568928884, 4489.438820147481, 4492.820287188509, 4519.977400112978, 4550.795214215368, 6069.848253793646, 6126.969365153191, 6131.601445906002, 6142.907856382158, 6169.907451388232, 5766.452187042266, 5811.535077193815, 5843.948089343917, 5855.121731740231, 5867.3839246879315, 6541.411272985454, 6566.901496477557, 6582.539222254444, 6597.954634063456, 6604.471642268607, 4833.613310935117, 4980.975095124538, 5009.7495125243595, 5016.573591244712, 5031.4465408805, 6662.734080524685, 6773.187217533928, 6783.559068660571, 6894.586324820477, 6954.304569543056, 5524.447555244444, 5551.72241387929, 5585.441455854463, 5603.439656034364, 5624.409437009055, 5672.631278966854, 5685.573581981368, 5689.459501347365, 5701.657900525982, 5749.798757043567, 6083.239595050619, 6113.663748493786, 6116.052011938156, 6121.234845644294, 6124.0, 6652.96673516639, 6695.765648202289, 6717.832054198684, 6730.663466826639, 6750.0, 1948.0844003318418, 1960.4216756056996, 1972.6252012117652, 1979.1786408640253, 1998.2506560039985, 1434.973993594585, 1497.4983380567633, 1501.6846462242834, 1506.9246537673073, 1508.9849101508844, 5912.0, 5972.492338151305, 6001.8896504146, 6066.0, 6091.66495842724, 6521.315261897527, 6529.608223506605, 6546.279909209983, 6625.801225963229, 6690.866182676416, 5940.079287710412, 6020.608660437058, 6052.0, 6056.757729690851, 6084.543659225487, 3468.8612455502002, 3470.722342212617, 3471.3057388522398, 3492.1793378556017, 3543.5924868639922, 6739.326067393319, 6810.421114205249, 6858.9368647859665, 6874.553154044971, 6903.965480172567, 6685.197776266782, 6701.5308928375525, 6830.146231721035, 6839.418649414855, 6856.691448884712, 6725.125733654593, 6728.947670960306, 6874.690638921261, 6946.79159625212, 7018.719251229893, 6601.702923368556, 6615.966920165561, 6663.300353462817, 6686.030525573862, 6704.497162712913, 6670.332966703291, 6686.264510903699, 6703.162104736908, 6772.627505487246, 6775.254721980479, 6924.134483189601, 6925.619090949845, 6968.860622787617, 6989.405900498515, 7031.472639551952, 5504.422035686355, 5528.253685752372, 5562.137868630369, 5637.448407503247, 5670.262865827416, 6476.542777875129, 6530.67346632676, 6695.598264104169, 6761.52669313163, 6798.59208447475, 6409.583377080475, 6460.903086453613, 6462.870742585028, 6501.804945851632, 6510.837229069311, 6418.486521078209, 6432.131662225727, 6450.645214513247, 6527.9020814688765, 6547.934520654923, 6418.518611104279, 6434.935650643433, 6454.967725161344, 6456.225252969673, 6469.514786390945, 6536.182977127859, 6542.44389226902, 6553.279139294769, 6562.8359291016195, 6566.244881838458, 6353.777617783356, 6358.618482891041, 6374.26695929974, 6424.201223657384, 6434.517411194086], "value": 5218.874525454006, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [975.2880397309968, 990.440401173337, 1003.0721582536153, 1006.5621454667221, 1011.1859952738043, 19592.11835467404, 19950.201991920305, 19961.500962475944, 19962.201511939504, 19964.800351996477, 16334.754978675299, 16349.264283107259, 17680.0, 17843.91078044608, 17847.55381115473, 1069.0805906920043, 1084.0, 1084.1164450972433, 1084.4631907205944, 1084.8860869608657, 1073.3935326540518, 1075.6289080267334, 1077.854489643896, 1078.2398409121552, 1078.7357097511122, 1058.2803693488424, 1101.1631160318175, 1105.5412004018324, 1105.618561596248, 1141.6860363400049, 1069.1340014588131, 1095.5782023920767, 1096.1121491591837, 1098.1489345757063, 1098.6154845803944, 827.5903427803215, 830.2693629605968, 830.5515021888173, 831.7546323834483, 832.0722394530115, 19109.426717198367, 19122.0, 19264.036798160036, 19267.51831204217, 19287.807121928883, 21771.67342489848, 22661.43346416336, 23012.65481017786, 23100.306990790305, 23179.3046208614, 16928.322867085302, 17052.48842534726, 17098.14509274544, 17162.227699753417, 17239.13804309792, 4002.519697636273, 4010.3783913493453, 4022.4368588397647, 4023.2154729827694, 4028.0936789222483, 127828.0, 157580.21209893993, 160718.0, 160750.19624901918, 162605.9999999988, 16957.491275261516, 17067.317307307567, 17224.0, 17388.652226955644, 17451.912740436215, 34976.0, 34985.0, 35048.64951350454, 35245.82377088098, 35676.10809729777, 9514.809703805886, 9533.189678877234, 9557.713268601952, 9557.952210239044, 9569.904300956901, 4398.164348773723, 4467.508574056851, 4508.909821803545, 4541.137183935041, 4544.091181763661, 6122.295935967331, 6164.907526387108, 6212.316645169028, 6216.098665693449, 6271.027990661455, 1094.7591529863416, 1098.3794156301665, 1109.2235435195396, 1127.6335191062938, 1129.7740451909488, 738.3428748413916, 753.2279413601103, 761.6991288441035, 767.8349154931605, 776.4991580430591, 13167.341632918316, 13214.273214973076, 13263.469461221635, 13776.93111534436, 14081.929590351983, 740.6704016712512, 743.7173873927981, 751.8308380614427, 768.3699366519512, 768.3776141325544, 6287.685615719196, 6384.201974753156, 6393.360663933662, 6471.514636402195, 6586.308437614078, 147738.26130869277, 150814.0, 151284.0, 151780.2410987938, 157458.0, 96744.51627741817, 100328.49835750775, 120717.0, 131220.0, 139056.30471847576, 105192.0, 107361.0, 111104.44447777871, 112068.0, 114401.4279928595, 13867.167969921433, 14638.194899280641, 14822.62943426423, 14836.629084272548, 15087.924560377567, 50699.239511406624, 52182.47817521928, 53764.46235537751, 54067.72966135144, 55455.445445545025, 71521.64239178771, 71672.0, 71711.0, 71830.28169718236, 72698.63650681713, 19536.8046319535, 21042.68435973492, 21045.368638940858, 21068.473288167304, 21128.366149015554, 22776.430589235402, 22899.771002290432, 23062.0, 23066.654000190345, 23354.299371018897, 19823.900880495505, 19832.40502784919, 19867.304644337957, 19961.00974756311, 19988.700169497177, 20583.58832823365, 20630.17479300811, 20725.27461538839, 20726.79273207309, 20980.160793568695, 18943.0, 19003.90498047501, 19111.713324299868, 19128.904355478135, 19228.423147305602, 13483.932580337036, 13738.86261137376, 13897.72204555883, 13922.025458218233, 14176.362063707364, 15370.23148842531, 15588.76616850771, 15735.842641573438, 15774.842251577797, 15909.0], "value": 10109.47641893354, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1377.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 106.0, 106.0, 106.0, 105.0, 98.0, 106.0, 107.0, 106.0, 106.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 112.0, 112.0, 116.0, 112.0, 112.0, 116.0, 136.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 160.0, 162.0, 161.0, 162.0, 164.0, 173.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 73.0, 72.0, 75.0, 76.0, 75.0, 74.0, 79.0, 72.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 78.0, 78.0, 78.0, 79.0, 84.0, 78.0, 79.0], "value": 78.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 117.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 154.0, 149.0, 149.0, 149.0, 150.0, 153.0, 151.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 100.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 46.0, 44.0, 45.0, 58.0, 45.0, 51.0, 44.0, 44.0, 47.0], "value": 47.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 42.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 71.0, 71.0, 70.0, 71.0, 73.0, 74.0, 74.0, 71.0, 72.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 109.0, 106.0, 111.0, 104.0, 103.0, 112.0, 109.0, 101.0], "value": 107.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 153.0, 155.0, 153.0, 160.0, 159.0, 156.0, 169.0, 148.0, 149.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 64.0, 62.0, 59.0, 58.0, 61.0, 60.0, 58.0, 59.0], "value": 59.9, "unit": "score"}]}]} 16:02:49 INFO - Return code: 0 16:02:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:02:49 INFO - # TBPL SUCCESS # 16:02:49 INFO - Running post-action listener: _package_coverage_data 16:02:49 INFO - Running post-action listener: _resource_record_post_action 16:02:49 INFO - [mozharness: 2017-09-13 23:02:49.972007Z] Finished run-tests step (success) 16:02:49 INFO - Running post-run listener: _resource_record_post_run 16:02:50 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 340754432; Read time: 8; Write time: 169616 16:02:50 INFO - TinderboxPrint: CPU usage
13.1% 16:02:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:02:50 INFO - TinderboxPrint: I/O write bytes / time
340,754,432 / 169,616 16:02:50 INFO - TinderboxPrint: CPU idle
8,220.0 (86.9%) 16:02:50 INFO - TinderboxPrint: CPU user
1,187.5 (12.6%) 16:02:50 INFO - TinderboxPrint: Swap in / out
0 / 0 16:02:50 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12742656; Read time: 0; Write time: 1452 16:02:50 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:02:50 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 4096; Write bytes: 327397376; Read time: 8; Write time: 168160 16:02:50 INFO - Running post-run listener: _upload_blobber_files 16:02:50 INFO - Blob upload gear active. 16:02:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:02:50 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 16:02:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:02:51 INFO - (blobuploader) - INFO - Open directory for files ... 16:02:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:02:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:02:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:02:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:02:52 INFO - (blobuploader) - INFO - Done attempting. 16:02:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:02:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:02:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:02:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:02:53 INFO - (blobuploader) - INFO - Done attempting. 16:02:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:02:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:03:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:00 INFO - (blobuploader) - INFO - Done attempting. 16:03:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:03:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:03:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:01 INFO - (blobuploader) - INFO - Done attempting. 16:03:01 INFO - (blobuploader) - INFO - Iteration through files over. 16:03:01 INFO - Return code: 0 16:03:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:03:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:03:01 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae4029388caf18ecf033e6281f000c64f379e81923058d3d917cb1e421c5cd0d6a31d20037656c043deefdb352009b96f1ab089cd10e651de7c66476c3a53a92", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5816f01de748b989c666946e99f5121fb6912aaaab29689036d4f792efa3411b9173cf6e9eedb266f31e2202654d1f995560c77dd4d54c3e544bed458191bc5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f0c24d6af4a7b09433edcd40d56bef00c62940a0f0c512970dbcdb9ea524c52f8a43d84af2d6e572b5677146975aa8d828a35ccccf9fbf88b3bc300ce3312a7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dae929bb03807da2a5a0c1eb5de7f734e3913412ffbd0061cf28681919c1be69a9007882ab468e3bd1a9d48294a0ced89ae5f09bfefa65016bf92763220d4b77"} 16:03:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:03:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:03:01 INFO - Contents: 16:03:01 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae4029388caf18ecf033e6281f000c64f379e81923058d3d917cb1e421c5cd0d6a31d20037656c043deefdb352009b96f1ab089cd10e651de7c66476c3a53a92", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5816f01de748b989c666946e99f5121fb6912aaaab29689036d4f792efa3411b9173cf6e9eedb266f31e2202654d1f995560c77dd4d54c3e544bed458191bc5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f0c24d6af4a7b09433edcd40d56bef00c62940a0f0c512970dbcdb9ea524c52f8a43d84af2d6e572b5677146975aa8d828a35ccccf9fbf88b3bc300ce3312a7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dae929bb03807da2a5a0c1eb5de7f734e3913412ffbd0061cf28681919c1be69a9007882ab468e3bd1a9d48294a0ced89ae5f09bfefa65016bf92763220d4b77"} 16:03:01 INFO - Running post-run listener: copy_logs_to_upload_dir 16:03:01 INFO - Copying logs to upload dir... 16:03:01 INFO - mkdir: /builds/slave/test/build/upload/logs 16:03:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.853805 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-13 16:03:01.097615) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 16:03:01.101867) ========= 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-1505342541.595682-1789722209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae4029388caf18ecf033e6281f000c64f379e81923058d3d917cb1e421c5cd0d6a31d20037656c043deefdb352009b96f1ab089cd10e651de7c66476c3a53a92", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5816f01de748b989c666946e99f5121fb6912aaaab29689036d4f792efa3411b9173cf6e9eedb266f31e2202654d1f995560c77dd4d54c3e544bed458191bc5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f0c24d6af4a7b09433edcd40d56bef00c62940a0f0c512970dbcdb9ea524c52f8a43d84af2d6e572b5677146975aa8d828a35ccccf9fbf88b3bc300ce3312a7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dae929bb03807da2a5a0c1eb5de7f734e3913412ffbd0061cf28681919c1be69a9007882ab468e3bd1a9d48294a0ced89ae5f09bfefa65016bf92763220d4b77"} build_url:https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011514 build_url: 'https://queue.taskcluster.net/v1/task/HsqTY3hiS4-L2Rh95Ht4ag/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae4029388caf18ecf033e6281f000c64f379e81923058d3d917cb1e421c5cd0d6a31d20037656c043deefdb352009b96f1ab089cd10e651de7c66476c3a53a92", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5816f01de748b989c666946e99f5121fb6912aaaab29689036d4f792efa3411b9173cf6e9eedb266f31e2202654d1f995560c77dd4d54c3e544bed458191bc5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f0c24d6af4a7b09433edcd40d56bef00c62940a0f0c512970dbcdb9ea524c52f8a43d84af2d6e572b5677146975aa8d828a35ccccf9fbf88b3bc300ce3312a7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dae929bb03807da2a5a0c1eb5de7f734e3913412ffbd0061cf28681919c1be69a9007882ab468e3bd1a9d48294a0ced89ae5f09bfefa65016bf92763220d4b77"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 16:03:01.134984) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 16:03:01.135404) ========= 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-1505342541.595682-1789722209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 16:03:01.223730) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 16:03:01.224064) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 16:03:01.224404) ========= ========= Total master_lag: 0.24 =========