builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1505779697.06 results: success (0) revision: 30a386ff1192cba08a2f899343f81f6946bc6148 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 17:08:17.058472) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 17:08:17.058899) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 17:08:17.059372) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 17:08:17.261422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 17:08:17.261794) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 17:08:17-- 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% 24.9M=0s 2017-09-18 17:08:17 (24.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162862 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 17:08:17.483350) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 17:08:17.483655) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019648 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 17:08:17.579351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-18 17:08:17.583290) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 30a386ff1192cba08a2f899343f81f6946bc6148 --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 30a386ff1192cba08a2f899343f81f6946bc6148 --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=e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 17:08:17,646 truncating revision to first 12 chars 2017-09-18 17:08:17,647 Setting DEBUG logging. 2017-09-18 17:08:17,647 attempt 1/10 2017-09-18 17:08:17,647 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/30a386ff1192?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 17:08:18,854 unpacking tar archive at: mozilla-central-30a386ff1192/testing/mozharness/ program finished with exit code 0 elapsedTime=1.513203 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-18 17:08:19.123392) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 17:08:19.123687) ========= script_repo_revision: 30a386ff1192cba08a2f899343f81f6946bc6148 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 17:08:19.124045) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 17:08:19.124398) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 17:08:19.137871) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-09-18 17:08:19.138167) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:08:19 INFO - MultiFileLogger online at 20170918 17:08:19 in /builds/slave/test 17:08:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:08:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:08:19 INFO - {'append_to_log': False, 17:08:19 INFO - 'base_work_dir': '/builds/slave/test', 17:08:19 INFO - 'blob_upload_branch': 'Firefox', 17:08:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:08:19 INFO - 'branch': 'Firefox', 17:08:19 INFO - 'buildbot_json_path': 'buildprops.json', 17:08:19 INFO - 'code_coverage': False, 17:08:19 INFO - 'config_files': ('talos/linux_config.py',), 17:08:19 INFO - 'default_actions': ('clobber', 17:08:19 INFO - 'read-buildbot-config', 17:08:19 INFO - 'download-and-extract', 17:08:19 INFO - 'populate-webroot', 17:08:19 INFO - 'create-virtualenv', 17:08:19 INFO - 'install', 17:08:19 INFO - 'setup-mitmproxy', 17:08:19 INFO - 'run-tests'), 17:08:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:08:19 INFO - 'disable_ccov_upload': False, 17:08:19 INFO - 'disable_stylo': False, 17:08:19 INFO - 'download_minidump_stackwalk': True, 17:08:19 INFO - 'download_symbols': 'ondemand', 17:08:19 INFO - 'enable_stylo': False, 17:08:19 INFO - 'enable_webrender': False, 17:08:19 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:08:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:08:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:08:19 INFO - 'gecko_profile': False, 17:08:19 INFO - 'gecko_profile_interval': 0, 17:08:19 INFO - 'installer_path': 'installer.exe', 17:08:19 INFO - 'log_level': 'info', 17:08:19 INFO - 'log_name': 'talos', 17:08:19 INFO - 'log_to_console': True, 17:08:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:08:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:08:19 INFO - 'opt_config_files': (), 17:08:19 INFO - 'pip_index': False, 17:08:19 INFO - 'suite': 'dromaeojs-e10s', 17:08:19 INFO - 'system_bits': '32', 17:08:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:08:19 INFO - 'title': 'talos-linux64-ix-006', 17:08:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:08:19 INFO - 'use_talos_json': True, 17:08:19 INFO - 'verify': 'False', 17:08:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:08:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:08:19 INFO - 'work_dir': 'build'} 17:08:19 INFO - [mozharness: 2017-09-19 00:08:19.332608Z] Running clobber step. 17:08:19 INFO - Running pre-action listener: _resource_record_pre_action 17:08:19 INFO - Running main action method: clobber 17:08:19 INFO - rmtree: /builds/slave/test/build 17:08:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:08:20 INFO - Running post-action listener: _resource_record_post_action 17:08:20 INFO - [mozharness: 2017-09-19 00:08:20.326263Z] Finished clobber step (success) 17:08:20 INFO - [mozharness: 2017-09-19 00:08:20.326360Z] Running read-buildbot-config step. 17:08:20 INFO - Running pre-action listener: _resource_record_pre_action 17:08:20 INFO - Running main action method: read_buildbot_config 17:08:20 INFO - Using buildbot properties: 17:08:20 INFO - { 17:08:20 INFO - "project": "", 17:08:20 INFO - "product": "firefox", 17:08:20 INFO - "who": "kwierso@gmail.com", 17:08:20 INFO - "installer_path": "public/build/target.tar.bz2", 17:08:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 17:08:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:08:20 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 17:08:20 INFO - "stage_platform": "linux64-qr", 17:08:20 INFO - "basedir": "/builds/slave/test", 17:08:20 INFO - "buildnumber": 65, 17:08:20 INFO - "platform": "ubuntu64_hw_qr", 17:08:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:08:20 INFO - "slavebuilddir": "test", 17:08:20 INFO - "taskId": "fUgXPyXBQSavY6Ea9J9-Cg", 17:08:20 INFO - "branch": "mozilla-central", 17:08:20 INFO - "script_repo_revision": "production", 17:08:20 INFO - "revision": "30a386ff1192cba08a2f899343f81f6946bc6148", 17:08:20 INFO - "slavename": "talos-linux64-ix-006", 17:08:20 INFO - "repo_path": "mozilla-central" 17:08:20 INFO - } 17:08:20 INFO - Finding installer, test and symbols from parent task. 17:08:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fUgXPyXBQSavY6Ea9J9-Cg'}, attempt #1 17:08:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fUgXPyXBQSavY6Ea9J9-Cg'}, attempt #1 17:08:21 INFO - Task dependencies: a63eNWFcTpOKhAf9s5Ef0A 17:08:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A'}, attempt #1 17:08:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.tar.bz2 17:08:21 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.test_packages.json 17:08:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.crashreporter-symbols.zip 17:08:21 INFO - Running post-action listener: _resource_record_post_action 17:08:21 INFO - [mozharness: 2017-09-19 00:08:21.671094Z] Finished read-buildbot-config step (success) 17:08:21 INFO - [mozharness: 2017-09-19 00:08:21.671310Z] Running download-and-extract step. 17:08:21 INFO - Running pre-action listener: _resource_record_pre_action 17:08:21 INFO - Running main action method: download_and_extract 17:08:21 INFO - mkdir: /builds/slave/test/build/tests 17:08: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')]} 17:08:21 INFO - trying https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.test_packages.json 17:08:21 INFO - Downloading https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:08:22 INFO - Downloaded 989 bytes. 17:08:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:08:22 INFO - Using the following test package requirements: 17:08:22 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:08:22 INFO - u'common': [u'target.common.tests.zip'], 17:08:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:08:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:08:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:08:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:08:22 INFO - u'mozbase': [u'target.common.tests.zip'], 17:08:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:08:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:08:22 INFO - u'web-platform': [u'target.common.tests.zip', 17:08:22 INFO - u'target.web-platform.tests.tar.gz'], 17:08:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:08:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:08:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.common.tests.zip 17:08:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:08:22 INFO - Fetch https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.common.tests.zip into memory 17:08:26 INFO - Content-Length response header: 54731509 17:08:26 INFO - Bytes received: 54731509 17:08:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.talos.tests.zip 17:08:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:08:36 INFO - Fetch https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.talos.tests.zip into memory 17:08:39 INFO - Content-Length response header: 14508787 17:08:39 INFO - Bytes received: 14508787 17:08: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')]} 17:08:40 INFO - trying https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.tar.bz2 17:08:40 INFO - Downloading https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:08:44 INFO - Downloaded 61432496 bytes. 17:08:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.tar.bz2 17:08:44 INFO - mkdir: /builds/slave/test/properties 17:08:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:08:44 INFO - Writing to file /builds/slave/test/properties/build_url 17:08:44 INFO - Contents: 17:08:44 INFO - build_url:https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.tar.bz2 17:08:44 INFO - Running post-action listener: _resource_record_post_action 17:08:44 INFO - Running post-action listener: find_tests_for_verification 17:08:44 INFO - Running post-action listener: set_extra_try_arguments 17:08:44 INFO - [mozharness: 2017-09-19 00:08:44.863010Z] Finished download-and-extract step (success) 17:08:44 INFO - [mozharness: 2017-09-19 00:08:44.863236Z] Running populate-webroot step. 17:08:44 INFO - Running pre-action listener: _resource_record_pre_action 17:08:44 INFO - Running main action method: populate_webroot 17:08:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:08:44 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:08:44 INFO - 'tests': ['tresize', 17:08:44 INFO - 'tcanvasmark']}, 17:08:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:08:44 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:08:44 INFO - 'tests': ['dromaeo_css', 17:08:44 INFO - 'kraken']}, 17:08:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:08:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:44 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:08:44 INFO - 'talos_options': ['--disable-stylo'], 17:08:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:08:44 INFO - 'tests': ['damp', 'tps']}, 17:08:44 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:08:44 INFO - 'talos_options': ['--disable-stylo'], 17:08:44 INFO - 'tests': ['damp', 'tps']}, 17:08:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:08:44 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:08:44 INFO - 'tests': ['dromaeo_dom']}, 17:08:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:08:44 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:08:44 INFO - 'tests': ['basic_compositor_video', 17:08:44 INFO - 'glvideo']}, 17:08:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:08:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:08:44 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:08:44 INFO - 'talos_options': ['--disable-stylo'], 17:08:44 INFO - 'tests': ['ts_paint_webext', 17:08:44 INFO - 'tp5o_webext']}, 17:08:44 INFO - 'other-e10s': {'tests': ['a11yr', 17:08:44 INFO - 'ts_paint', 17:08:44 INFO - 'tpaint', 17:08:44 INFO - 'sessionrestore', 17:08:44 INFO - 'sessionrestore_many_windows', 17:08:44 INFO - 'sessionrestore_no_auto_restore', 17:08:44 INFO - 'tabpaint']}, 17:08:44 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:08:44 INFO - 'tests': ['a11yr', 17:08:44 INFO - 'ts_paint', 17:08:44 INFO - 'tpaint', 17:08:44 INFO - 'sessionrestore', 17:08:44 INFO - 'sessionrestore_many_windows', 17:08:44 INFO - 'sessionrestore_no_auto_restore', 17:08:44 INFO - 'tabpaint']}, 17:08:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:08:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:08:44 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:08:44 INFO - 'tests': ['perf_reftest_singletons']}, 17:08:44 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:08:44 INFO - 'tests': ['bloom_basic']}, 17:08:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:08:44 INFO - 'tsvgr_opacity', 17:08:44 INFO - 'tart', 17:08:44 INFO - 'tscrollx', 17:08:44 INFO - 'tsvg_static']}, 17:08:44 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:08:44 INFO - 'tests': ['tsvgx', 17:08:44 INFO - 'tsvgr_opacity', 17:08:44 INFO - 'tart', 17:08:44 INFO - 'tscrollx', 17:08:44 INFO - 'tsvg_static']}, 17:08:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:08:44 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:08:44 INFO - 'talos_options': ['--disable-stylo'], 17:08:44 INFO - 'tests': ['tp5o']}, 17:08:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:08:44 INFO - 'talos_options': ['--mitmproxy', 17:08:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:08:44 INFO - '--firstNonBlankPaint'], 17:08:44 INFO - 'tests': ['tp6_google', 17:08:44 INFO - 'tp6_youtube', 17:08:44 INFO - 'tp6_amazon', 17:08:44 INFO - 'tp6_facebook']}, 17:08:44 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:08:44 INFO - 'talos_options': ['--disable-stylo', 17:08:44 INFO - '--mitmproxy', 17:08:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:08:44 INFO - '--firstNonBlankPaint'], 17:08:44 INFO - 'tests': ['tp6_google', 17:08:44 INFO - 'tp6_youtube', 17:08:44 INFO - 'tp6_amazon', 17:08:44 INFO - 'tp6_facebook']}, 17:08:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:08:44 INFO - 'talos_options': ['--stylo-threads=1', 17:08:44 INFO - '--mitmproxy', 17:08:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:08:44 INFO - '--firstNonBlankPaint'], 17:08:44 INFO - 'tests': ['tp6_google', 17:08:44 INFO - 'tp6_youtube', 17:08:44 INFO - 'tp6_amazon', 17:08:44 INFO - 'tp6_facebook']}, 17:08:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:08:44 INFO - 'talos_options': ['--xperf_path', 17:08:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:44 INFO - 'tests': ['tp5n']}, 17:08:44 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:08:44 INFO - 'talos_options': ['--disable-stylo', 17:08:44 INFO - '--xperf_path', 17:08:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:44 INFO - 'tests': ['tp5n']}}} 17:08:44 INFO - Running post-action listener: _resource_record_post_action 17:08:44 INFO - [mozharness: 2017-09-19 00:08:44.878881Z] Finished populate-webroot step (success) 17:08:44 INFO - [mozharness: 2017-09-19 00:08:44.878972Z] Running create-virtualenv step. 17:08:44 INFO - Running pre-action listener: _resource_record_pre_action 17:08:44 INFO - Running main action method: create_virtualenv 17:08:44 INFO - Creating virtualenv /builds/slave/test/build/venv 17:08:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:08:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:08:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:08:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:08:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:08:45 INFO - Installing distribute.............................................................................................................................................................................................done. 17:08:45 INFO - Installing pip...............done. 17:08:45 INFO - Return code: 0 17:08:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:08:45 INFO - Reading from file tmpfile_stdout 17:08:45 INFO - Output received: 17:08:45 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:08:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:45 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 0x299b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d07a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b090>, '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 0x2d0bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d05f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', '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 17:08:45 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 17:08:45 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 17:08:45 INFO - Using env: {'DISPLAY': ':0', 17:08:45 INFO - 'HOME': '/home/cltbld', 17:08:45 INFO - 'LANG': 'en_US.UTF-8', 17:08:45 INFO - 'LANGUAGE': 'en_US:en', 17:08:45 INFO - 'LOGNAME': 'cltbld', 17:08:45 INFO - 'MAIL': '/var/mail/cltbld', 17:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:45 INFO - 'MOZ_NO_REMOTE': '1', 17:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:45 INFO - 'NO_EM_RESTART': '1', 17:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:45 INFO - 'PWD': '/builds/slave/test', 17:08:45 INFO - 'SHELL': '/bin/bash', 17:08:45 INFO - 'SHLVL': '1', 17:08:45 INFO - 'TERM': 'linux', 17:08:45 INFO - 'TMOUT': '86400', 17:08:45 INFO - 'USER': 'cltbld', 17:08:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', 17:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:45 INFO - '_': '/tools/buildbot/bin/python'} 17:08:47 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:08:47 INFO - Downloading/unpacking pip>=1.5 17:08:47 INFO - Running setup.py egg_info for package pip 17:08:47 INFO - warning: no files found matching 'pip/cacert.pem' 17:08:47 INFO - warning: no files found matching '*.html' under directory 'docs' 17:08:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:08:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:08:47 INFO - Installing collected packages: pip 17:08:47 INFO - Found existing installation: pip 1.1 17:08:47 INFO - Uninstalling pip: 17:08:47 INFO - Successfully uninstalled pip 17:08:47 INFO - Running setup.py install for pip 17:08:47 INFO - warning: no files found matching 'pip/cacert.pem' 17:08:47 INFO - warning: no files found matching '*.html' under directory 'docs' 17:08:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:08:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:08:47 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:08:47 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:08:47 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:08:47 INFO - Successfully installed pip 17:08:47 INFO - Cleaning up... 17:08:47 INFO - Return code: 0 17:08:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:08:47 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')]} 17:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:47 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')]} 17:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:47 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 0x299b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d07a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b090>, '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 0x2d0bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d05f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', '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 17:08:47 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 17:08:47 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 17:08:47 INFO - Using env: {'DISPLAY': ':0', 17:08:47 INFO - 'HOME': '/home/cltbld', 17:08:47 INFO - 'LANG': 'en_US.UTF-8', 17:08:47 INFO - 'LANGUAGE': 'en_US:en', 17:08:47 INFO - 'LOGNAME': 'cltbld', 17:08:47 INFO - 'MAIL': '/var/mail/cltbld', 17:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:47 INFO - 'MOZ_NO_REMOTE': '1', 17:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:47 INFO - 'NO_EM_RESTART': '1', 17:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:47 INFO - 'PWD': '/builds/slave/test', 17:08:47 INFO - 'SHELL': '/bin/bash', 17:08:47 INFO - 'SHLVL': '1', 17:08:47 INFO - 'TERM': 'linux', 17:08:47 INFO - 'TMOUT': '86400', 17:08:47 INFO - 'USER': 'cltbld', 17:08:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', 17:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:47 INFO - '_': '/tools/buildbot/bin/python'} 17:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:47 INFO - Downloading/unpacking psutil>=3.1.1 17:08:47 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 17:08:47 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 17:08:47 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 17:08:47 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 17:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:08:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:48 INFO - Installing collected packages: psutil 17:08:48 INFO - Running setup.py install for psutil 17:08:48 INFO - building 'psutil._psutil_linux' extension 17:08:48 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 17:08:48 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 17:08:48 INFO - building 'psutil._psutil_posix' extension 17:08:48 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 17:08:48 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 17:08:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:48 INFO - Successfully installed psutil 17:08:48 INFO - Cleaning up... 17:08:49 INFO - Return code: 0 17:08:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d07a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b090>, '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 0x2d0bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d05f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', '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 17:08:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:08:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:08:49 INFO - Using env: {'DISPLAY': ':0', 17:08:49 INFO - 'HOME': '/home/cltbld', 17:08:49 INFO - 'LANG': 'en_US.UTF-8', 17:08:49 INFO - 'LANGUAGE': 'en_US:en', 17:08:49 INFO - 'LOGNAME': 'cltbld', 17:08:49 INFO - 'MAIL': '/var/mail/cltbld', 17:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:49 INFO - 'MOZ_NO_REMOTE': '1', 17:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:49 INFO - 'NO_EM_RESTART': '1', 17:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:49 INFO - 'PWD': '/builds/slave/test', 17:08:49 INFO - 'SHELL': '/bin/bash', 17:08:49 INFO - 'SHLVL': '1', 17:08:49 INFO - 'TERM': 'linux', 17:08:49 INFO - 'TMOUT': '86400', 17:08:49 INFO - 'USER': 'cltbld', 17:08:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', 17:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:49 INFO - '_': '/tools/buildbot/bin/python'} 17:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:08: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 17:08: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 17:08: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 17:08: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 17:08:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:08:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:08:50 INFO - Installing collected packages: mozsystemmonitor 17:08:50 INFO - Running setup.py install for mozsystemmonitor 17:08:50 INFO - Successfully installed mozsystemmonitor 17:08:50 INFO - Cleaning up... 17:08:51 INFO - Return code: 0 17:08:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08: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')]} 17:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08: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', '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 0x299b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d07a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b090>, '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 0x2d0bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d05f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', '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 17:08: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:08: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 jsonschema==2.5.1 17:08:51 INFO - Using env: {'DISPLAY': ':0', 17:08:51 INFO - 'HOME': '/home/cltbld', 17:08:51 INFO - 'LANG': 'en_US.UTF-8', 17:08:51 INFO - 'LANGUAGE': 'en_US:en', 17:08:51 INFO - 'LOGNAME': 'cltbld', 17:08:51 INFO - 'MAIL': '/var/mail/cltbld', 17:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:51 INFO - 'MOZ_NO_REMOTE': '1', 17:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:51 INFO - 'NO_EM_RESTART': '1', 17:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:51 INFO - 'PWD': '/builds/slave/test', 17:08:51 INFO - 'SHELL': '/bin/bash', 17:08:51 INFO - 'SHLVL': '1', 17:08:51 INFO - 'TERM': 'linux', 17:08:51 INFO - 'TMOUT': '86400', 17:08:51 INFO - 'USER': 'cltbld', 17:08:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', 17:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:51 INFO - '_': '/tools/buildbot/bin/python'} 17:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:51 INFO - Downloading/unpacking jsonschema==2.5.1 17:08: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 17:08: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 17:08: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 17:08: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 17:08:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:08:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:08: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 17:08: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 17:08: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 17:08: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 17:08:53 INFO - Downloading functools32-3.2.3-2.tar.gz 17:08:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:08:53 INFO - warning: no files found matching '*.txt' 17:08:53 INFO - no previously-included directories found matching 'build' 17:08:53 INFO - no previously-included directories found matching 'dist' 17:08:53 INFO - no previously-included directories found matching '.git*' 17:08:53 INFO - Installing collected packages: jsonschema, functools32 17:08:53 INFO - Running setup.py install for functools32 17:08:53 INFO - warning: no files found matching '*.txt' 17:08:53 INFO - no previously-included directories found matching 'build' 17:08:53 INFO - no previously-included directories found matching 'dist' 17:08:53 INFO - no previously-included directories found matching '.git*' 17:08:53 INFO - Successfully installed jsonschema functools32 17:08:53 INFO - Cleaning up... 17:08:53 INFO - Return code: 0 17:08:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:08:53 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')]} 17:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:53 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')]} 17:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:53 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 0x299b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d07a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b090>, '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 0x2d0bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d05f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', '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 17:08:53 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 17:08:53 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 17:08:53 INFO - Using env: {'DISPLAY': ':0', 17:08:53 INFO - 'HOME': '/home/cltbld', 17:08:53 INFO - 'LANG': 'en_US.UTF-8', 17:08:53 INFO - 'LANGUAGE': 'en_US:en', 17:08:53 INFO - 'LOGNAME': 'cltbld', 17:08:53 INFO - 'MAIL': '/var/mail/cltbld', 17:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:53 INFO - 'MOZ_NO_REMOTE': '1', 17:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:53 INFO - 'NO_EM_RESTART': '1', 17:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:53 INFO - 'PWD': '/builds/slave/test', 17:08:53 INFO - 'SHELL': '/bin/bash', 17:08:53 INFO - 'SHLVL': '1', 17:08:53 INFO - 'TERM': 'linux', 17:08:53 INFO - 'TMOUT': '86400', 17:08:53 INFO - 'USER': 'cltbld', 17:08:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', 17:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:53 INFO - '_': '/tools/buildbot/bin/python'} 17:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:08:54 INFO - Cleaning up... 17:08:54 INFO - Return code: 0 17:08:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08: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')]} 17:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x299b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d07a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b090>, '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 0x2d0bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d05f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', '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 17:08:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:08:54 INFO - Using env: {'DISPLAY': ':0', 17:08:54 INFO - 'HOME': '/home/cltbld', 17:08:54 INFO - 'LANG': 'en_US.UTF-8', 17:08:54 INFO - 'LANGUAGE': 'en_US:en', 17:08:54 INFO - 'LOGNAME': 'cltbld', 17:08:54 INFO - 'MAIL': '/var/mail/cltbld', 17:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:54 INFO - 'MOZ_NO_REMOTE': '1', 17:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:54 INFO - 'NO_EM_RESTART': '1', 17:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:54 INFO - 'PWD': '/builds/slave/test', 17:08:54 INFO - 'SHELL': '/bin/bash', 17:08:54 INFO - 'SHLVL': '1', 17:08:54 INFO - 'TERM': 'linux', 17:08:54 INFO - 'TMOUT': '86400', 17:08:54 INFO - 'USER': 'cltbld', 17:08:54 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', 17:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:54 INFO - '_': '/tools/buildbot/bin/python'} 17:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:54 INFO - Downloading/unpacking blobuploader==1.2.4 17:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:55 INFO - Downloading blobuploader-1.2.4.tar.gz 17:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:08:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:08:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:55 INFO - Downloading docopt-0.6.1.tar.gz 17:08:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:08:56 INFO - Installing collected packages: blobuploader, requests, docopt 17:08:56 INFO - Running setup.py install for blobuploader 17:08:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:08:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:08:56 INFO - Running setup.py install for requests 17:08:56 INFO - Running setup.py install for docopt 17:08:56 INFO - Successfully installed blobuploader requests docopt 17:08:56 INFO - Cleaning up... 17:08:56 INFO - Return code: 0 17:08:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:56 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 0x299b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d07a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b090>, '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 0x2d0bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d05f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', '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 17:08:56 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 17:08:56 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 17:08:56 INFO - Using env: {'DISPLAY': ':0', 17:08:56 INFO - 'HOME': '/home/cltbld', 17:08:56 INFO - 'LANG': 'en_US.UTF-8', 17:08:56 INFO - 'LANGUAGE': 'en_US:en', 17:08:56 INFO - 'LOGNAME': 'cltbld', 17:08:56 INFO - 'MAIL': '/var/mail/cltbld', 17:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:56 INFO - 'MOZ_NO_REMOTE': '1', 17:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:56 INFO - 'NO_EM_RESTART': '1', 17:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:56 INFO - 'PWD': '/builds/slave/test', 17:08:56 INFO - 'SHELL': '/bin/bash', 17:08:56 INFO - 'SHLVL': '1', 17:08:56 INFO - 'TERM': 'linux', 17:08:56 INFO - 'TMOUT': '86400', 17:08:56 INFO - 'USER': 'cltbld', 17:08:56 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', 17:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:56 INFO - '_': '/tools/buildbot/bin/python'} 17:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:56 INFO - Running setup.py (path:/tmp/pip-J7FU9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:56 INFO - Running setup.py (path:/tmp/pip-uTo9YI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:57 INFO - Running setup.py (path:/tmp/pip-zZUGeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:57 INFO - Running setup.py (path:/tmp/pip-NPZHi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:57 INFO - Running setup.py (path:/tmp/pip-yQam_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:57 INFO - Running setup.py (path:/tmp/pip-_7ef4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:57 INFO - Running setup.py (path:/tmp/pip-O7KQCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:57 INFO - Running setup.py (path:/tmp/pip-YykarW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:57 INFO - Running setup.py (path:/tmp/pip-5JYoJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:57 INFO - Running setup.py (path:/tmp/pip-rrqmmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:57 INFO - Running setup.py (path:/tmp/pip-JPzKpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:57 INFO - Running setup.py (path:/tmp/pip-xeD6pD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:57 INFO - Running setup.py (path:/tmp/pip-4ezo6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:57 INFO - Running setup.py (path:/tmp/pip-WEwfZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:57 INFO - Running setup.py (path:/tmp/pip-lkOVta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:57 INFO - Running setup.py (path:/tmp/pip-yKutvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:58 INFO - Running setup.py (path:/tmp/pip-8YiHzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:08:58 INFO - Running setup.py install for manifestparser 17:08:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:08:58 INFO - Running setup.py install for mozcrash 17:08:58 INFO - Running setup.py install for mozdebug 17:08:58 INFO - Running setup.py install for mozdevice 17:08:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:08:58 INFO - Running setup.py install for mozfile 17:08:58 INFO - Running setup.py install for mozhttpd 17:08:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:08:58 INFO - Running setup.py install for mozinfo 17:08:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:08:58 INFO - Running setup.py install for mozInstall 17:08:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:08:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:08:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:08:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:08:58 INFO - Running setup.py install for mozleak 17:08:58 INFO - Running setup.py install for mozlog 17:08:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:08:59 INFO - Running setup.py install for moznetwork 17:08:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:08:59 INFO - Running setup.py install for mozprocess 17:08:59 INFO - Running setup.py install for mozprofile 17:08:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:08:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:08:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:08:59 INFO - Running setup.py install for mozrunner 17:08:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:08:59 INFO - Running setup.py install for mozscreenshot 17:08:59 INFO - Running setup.py install for moztest 17:08:59 INFO - Running setup.py install for mozversion 17:08:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:08:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:08:59 INFO - Cleaning up... 17:08:59 INFO - Return code: 0 17:08:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:59 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 0x299b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d07a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b090>, '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 0x2d0bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d05f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', '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 17:08:59 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 17:08:59 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 17:08:59 INFO - Using env: {'DISPLAY': ':0', 17:08:59 INFO - 'HOME': '/home/cltbld', 17:08:59 INFO - 'LANG': 'en_US.UTF-8', 17:08:59 INFO - 'LANGUAGE': 'en_US:en', 17:08:59 INFO - 'LOGNAME': 'cltbld', 17:08:59 INFO - 'MAIL': '/var/mail/cltbld', 17:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:59 INFO - 'MOZ_NO_REMOTE': '1', 17:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:59 INFO - 'NO_EM_RESTART': '1', 17:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:59 INFO - 'PWD': '/builds/slave/test', 17:08:59 INFO - 'SHELL': '/bin/bash', 17:08:59 INFO - 'SHLVL': '1', 17:08:59 INFO - 'TERM': 'linux', 17:08:59 INFO - 'TMOUT': '86400', 17:08:59 INFO - 'USER': 'cltbld', 17:08:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', 17:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:59 INFO - '_': '/tools/buildbot/bin/python'} 17:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:00 INFO - Running setup.py (path:/tmp/pip-PRQxB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:00 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)) 17:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:00 INFO - Running setup.py (path:/tmp/pip-y0X9BB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:00 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)) 17:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:00 INFO - Running setup.py (path:/tmp/pip-HEf2J7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:00 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)) 17:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:00 INFO - Running setup.py (path:/tmp/pip-dq06Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:00 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)) 17:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:00 INFO - Running setup.py (path:/tmp/pip-SbuTyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:00 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)) 17:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:00 INFO - Running setup.py (path:/tmp/pip-lGWK7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:00 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)) 17:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:00 INFO - Running setup.py (path:/tmp/pip-848Wb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:00 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)) 17:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:00 INFO - Running setup.py (path:/tmp/pip-HKnAd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:00 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)) 17:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:00 INFO - Running setup.py (path:/tmp/pip-WcJPI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:00 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)) 17:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:00 INFO - Running setup.py (path:/tmp/pip-xugMqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:00 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)) 17:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:00 INFO - Running setup.py (path:/tmp/pip-96lv87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:00 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)) 17:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:00 INFO - Running setup.py (path:/tmp/pip-JsZmNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:00 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)) 17:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:00 INFO - Running setup.py (path:/tmp/pip-JfoKJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:01 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)) 17:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:01 INFO - Running setup.py (path:/tmp/pip-XLudmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:01 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)) 17:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:01 INFO - Running setup.py (path:/tmp/pip-NYDEY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:01 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)) 17:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:01 INFO - Running setup.py (path:/tmp/pip-im6WqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:01 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)) 17:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:01 INFO - Running setup.py (path:/tmp/pip-2t2SIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:01 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)) 17:09:01 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)) 17:09:01 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)) 17:09:01 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)) 17:09:01 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)) 17:09:01 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)) 17:09:01 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)) 17:09:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:09:01 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 17:09:01 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 17:09:01 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 17:09:01 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 17:09:02 INFO - Downloading blessings-1.6.tar.gz 17:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:09:02 INFO - Installing collected packages: blessings 17:09:02 INFO - Running setup.py install for blessings 17:09:02 INFO - Successfully installed blessings 17:09:02 INFO - Cleaning up... 17:09:02 INFO - Return code: 0 17:09:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:09:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:02 INFO - Reading from file tmpfile_stdout 17:09:02 INFO - Current package versions: 17:09:02 INFO - argparse == 1.2.1 17:09:02 INFO - blessings == 1.6 17:09:02 INFO - blobuploader == 1.2.4 17:09:02 INFO - docopt == 0.6.1 17:09:02 INFO - functools32 == 3.2.3-2 17:09:02 INFO - jsonschema == 2.5.1 17:09:02 INFO - manifestparser == 1.1 17:09:02 INFO - mozInstall == 1.13 17:09:02 INFO - mozcrash == 1.0 17:09:02 INFO - mozdebug == 0.1 17:09:02 INFO - mozdevice == 0.51 17:09:02 INFO - mozfile == 1.2 17:09:02 INFO - mozhttpd == 0.7 17:09:02 INFO - mozinfo == 0.10 17:09:02 INFO - mozleak == 0.1 17:09:02 INFO - mozlog == 3.5 17:09:02 INFO - moznetwork == 0.27 17:09:02 INFO - mozprocess == 0.25 17:09:02 INFO - mozprofile == 0.28 17:09:02 INFO - mozrunner == 6.13 17:09:02 INFO - mozscreenshot == 0.1 17:09:02 INFO - mozsystemmonitor == 0.3 17:09:02 INFO - moztest == 0.8 17:09:02 INFO - mozversion == 1.4 17:09:02 INFO - psutil == 3.1.1 17:09:02 INFO - requests == 1.2.3 17:09:02 INFO - wsgiref == 0.1.2 17:09:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09: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')]} 17:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:02 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 0x299b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d07a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b090>, '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 0x2d0bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d05f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', '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 17:09:02 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 17:09:02 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 17:09:02 INFO - Using env: {'DISPLAY': ':0', 17:09:02 INFO - 'HOME': '/home/cltbld', 17:09:02 INFO - 'LANG': 'en_US.UTF-8', 17:09:02 INFO - 'LANGUAGE': 'en_US:en', 17:09:02 INFO - 'LOGNAME': 'cltbld', 17:09:02 INFO - 'MAIL': '/var/mail/cltbld', 17:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:02 INFO - 'MOZ_NO_REMOTE': '1', 17:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:02 INFO - 'NO_EM_RESTART': '1', 17:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:02 INFO - 'PWD': '/builds/slave/test', 17:09:02 INFO - 'SHELL': '/bin/bash', 17:09:02 INFO - 'SHLVL': '1', 17:09:02 INFO - 'TERM': 'linux', 17:09:02 INFO - 'TMOUT': '86400', 17:09:02 INFO - 'USER': 'cltbld', 17:09:02 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', 17:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:02 INFO - '_': '/tools/buildbot/bin/python'} 17:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:03 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)) 17:09:03 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)) 17:09:03 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)) 17:09:03 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)) 17:09:03 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)) 17:09:03 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)) 17:09:03 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)) 17:09:03 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)) 17:09:03 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)) 17:09:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:09:04 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)) 17:09:04 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)) 17:09:04 INFO - Installing collected packages: simplejson 17:09:04 INFO - Running setup.py install for simplejson 17:09:04 INFO - building 'simplejson._speedups' extension 17:09:04 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 17:09:05 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 17:09:05 INFO - Successfully installed simplejson 17:09:05 INFO - Cleaning up... 17:09:05 INFO - Return code: 0 17:09:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:05 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 0x299b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d07a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b090>, '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 0x2d0bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d05f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', '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 17:09:05 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 17:09:05 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 17:09:05 INFO - Using env: {'DISPLAY': ':0', 17:09:05 INFO - 'HOME': '/home/cltbld', 17:09:05 INFO - 'LANG': 'en_US.UTF-8', 17:09:05 INFO - 'LANGUAGE': 'en_US:en', 17:09:05 INFO - 'LOGNAME': 'cltbld', 17:09:05 INFO - 'MAIL': '/var/mail/cltbld', 17:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:05 INFO - 'MOZ_NO_REMOTE': '1', 17:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:05 INFO - 'NO_EM_RESTART': '1', 17:09:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:05 INFO - 'PWD': '/builds/slave/test', 17:09:05 INFO - 'SHELL': '/bin/bash', 17:09:05 INFO - 'SHLVL': '1', 17:09:05 INFO - 'TERM': 'linux', 17:09:05 INFO - 'TMOUT': '86400', 17:09:05 INFO - 'USER': 'cltbld', 17:09:05 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', 17:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:05 INFO - '_': '/tools/buildbot/bin/python'} 17:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:09:05 INFO - Cleaning up... 17:09:05 INFO - Return code: 0 17:09:05 INFO - Running post-action listener: _resource_record_post_action 17:09:05 INFO - Running post-action listener: _start_resource_monitoring 17:09:05 INFO - Starting resource monitoring. 17:09:05 INFO - [mozharness: 2017-09-19 00:09:05.565928Z] Finished create-virtualenv step (success) 17:09:05 INFO - [mozharness: 2017-09-19 00:09:05.566393Z] Running install step. 17:09:05 INFO - Running pre-action listener: _resource_record_pre_action 17:09:05 INFO - Running main action method: install 17:09:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:05 INFO - Reading from file tmpfile_stdout 17:09:05 INFO - Detecting whether we're running mozinstall >=1.0... 17:09:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:09:05 INFO - Reading from file tmpfile_stdout 17:09:05 INFO - Output received: 17:09:05 INFO - Usage: mozinstall [options] installer 17:09:05 INFO - Options: 17:09:05 INFO - -h, --help show this help message and exit 17:09:05 INFO - -d DEST, --destination=DEST 17:09:05 INFO - Directory to install application into. [default: 17:09:05 INFO - "/builds/slave/test"] 17:09:05 INFO - --app=APP Application being installed. [default: firefox] 17:09:05 INFO - mkdir: /builds/slave/test/build/application 17:09:05 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'] 17:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:09:23 INFO - Reading from file tmpfile_stdout 17:09:23 INFO - Output received: 17:09:23 INFO - /builds/slave/test/build/application/firefox/firefox 17:09:23 INFO - Running post-action listener: _resource_record_post_action 17:09:23 INFO - [mozharness: 2017-09-19 00:09:23.748984Z] Finished install step (success) 17:09:23 INFO - [mozharness: 2017-09-19 00:09:23.749234Z] Running setup-mitmproxy step. 17:09:23 INFO - Running pre-action listener: _resource_record_pre_action 17:09:23 INFO - Running main action method: setup_mitmproxy 17:09:23 INFO - Skipping: mitmproxy is not required 17:09:23 INFO - Running post-action listener: _resource_record_post_action 17:09:23 INFO - [mozharness: 2017-09-19 00:09:23.750349Z] Finished setup-mitmproxy step (success) 17:09:23 INFO - [mozharness: 2017-09-19 00:09:23.750568Z] Running run-tests step. 17:09:23 INFO - Running pre-action listener: _resource_record_pre_action 17:09:23 INFO - Running pre-action listener: _set_gcov_prefix 17:09:23 INFO - Running main action method: run_tests 17:09:23 WARNING - Try message not found. 17:09:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:09:23 INFO - Python 2.7.3 17:09:23 INFO - Return code: 0 17:09:23 INFO - grabbing minidump binary from tooltool 17:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:23 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b090>, '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 0x2d0bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d05f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:09:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:09:23 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:09:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:09:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:09:23 INFO - Return code: 0 17:09:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:09:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:09:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:09:23 INFO - ENV: RUST_BACKTRACE is now full 17:09:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:09:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:09:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:09:23 INFO - Using env: {'DISPLAY': ':0', 17:09:23 INFO - 'HOME': '/home/cltbld', 17:09:23 INFO - 'LANG': 'en_US.UTF-8', 17:09:23 INFO - 'LANGUAGE': 'en_US:en', 17:09:23 INFO - 'LOGNAME': 'cltbld', 17:09:23 INFO - 'MAIL': '/var/mail/cltbld', 17:09:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:09:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:09:23 INFO - 'MOZ_ACCELERATED': '1', 17:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:23 INFO - 'MOZ_NO_REMOTE': '1', 17:09:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:09:23 INFO - 'MOZ_WEBRENDER': '1', 17:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:23 INFO - 'NO_EM_RESTART': '1', 17:09:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:23 INFO - 'PWD': '/builds/slave/test', 17:09:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:09:23 INFO - 'RUST_BACKTRACE': 'full', 17:09:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:09:23 INFO - 'SHELL': '/bin/bash', 17:09:23 INFO - 'SHLVL': '1', 17:09:23 INFO - 'TERM': 'linux', 17:09:23 INFO - 'TMOUT': '86400', 17:09:23 INFO - 'USER': 'cltbld', 17:09:23 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', 17:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:23 INFO - '_': '/tools/buildbot/bin/python'} 17:09:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:09:24 INFO - mozversion application_buildid: 20170918232117 17:09:24 INFO - mozversion application_changeset: 30a386ff1192cba08a2f899343f81f6946bc6148 17:09:24 INFO - mozversion application_display_name: Nightly 17:09:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:09:24 INFO - mozversion application_name: Firefox 17:09:24 INFO - mozversion application_remotingname: firefox 17:09:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:09:24 INFO - mozversion application_vendor: Mozilla 17:09:24 INFO - mozversion application_version: 57.0a1 17:09:24 INFO - mozversion platform_buildid: 20170918232117 17:09:24 INFO - mozversion platform_changeset: 30a386ff1192cba08a2f899343f81f6946bc6148 17:09:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:09:24 INFO - mozversion platform_version: 57.0a1 17:09:24 INFO - using testdate: 1505779764 17:09:24 INFO - actual date: 1505779764 17:09:24 INFO - starting webserver on 'localhost:59919' 17:09:24 INFO - SUITE-START | Running 2 tests 17:09:24 INFO - TEST-START | dromaeo_css 17:09:24 INFO - Initialising browser for dromaeo_css test... 17:09:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59919/getInfo.html -profile /tmp/tmpQdf0gl/profile 17:09:24 INFO - TEST-INFO | started process 20609 (/builds/slave/test/build/application/firefox/firefox http://localhost:59919/getInfo.html) 17:09:30 INFO - TEST-INFO | 20609: exit 0 17:09:30 INFO - Browser initialized. 17:09:30 INFO - Running cycle 1/1 for dromaeo_css test... 17:09:30 INFO - Using env: {'DISPLAY': ':0', 17:09:30 INFO - 'HOME': '/home/cltbld', 17:09:30 INFO - 'JSGC_DISABLE_POISONING': '1', 17:09:30 INFO - 'LANG': 'en_US.UTF-8', 17:09:30 INFO - 'LANGUAGE': 'en_US:en', 17:09:30 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:09:30 INFO - 'LOGNAME': 'cltbld', 17:09:30 INFO - 'MAIL': '/var/mail/cltbld', 17:09:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:09:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:09:30 INFO - 'MOZ_ACCELERATED': '1', 17:09:30 INFO - 'MOZ_CRASHREPORTER': '1', 17:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:30 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:09:30 INFO - 'MOZ_NO_REMOTE': '1', 17:09:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:09:30 INFO - 'MOZ_WEBRENDER': '1', 17:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:30 INFO - 'NO_EM_RESTART': '1', 17:09:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:30 INFO - 'PWD': '/builds/slave/test', 17:09:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:09:30 INFO - 'RUST_BACKTRACE': 'full', 17:09:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:09:30 INFO - 'SHELL': '/bin/bash', 17:09:30 INFO - 'SHLVL': '1', 17:09:30 INFO - 'TERM': 'linux', 17:09:30 INFO - 'TMOUT': '86400', 17:09:30 INFO - 'USER': 'cltbld', 17:09:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', 17:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:30 INFO - '_': '/tools/buildbot/bin/python'} 17:09:30 INFO - TEST-INFO | started process 20853 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQdf0gl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:31 INFO - PID 20853 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:09:31 INFO - PID 20853 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:09:31 INFO - PID 20853 | 17:09:31 INFO - PID 20853 | (/builds/slave/test/build/application/firefox/firefox:20912): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:09:31 INFO - PID 20853 | 17:09:42 INFO - PID 20853 | RSS: Main: 203173888 17:09:42 INFO - PID 20853 | 17:12:39 INFO - PID 20853 | Cycle 1(1): loaded http://localhost:59919/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59919/tests/dromaeo/cssquery-ext.html) 17:12:41 INFO - PID 20853 | RSS: Main: 207298560 17:12:41 INFO - PID 20853 | 17:15:43 INFO - PID 20853 | Cycle 1(1): loaded http://localhost:59919/tests/dromaeo/cssquery-ext.html (next: http://localhost:59919/tests/dromaeo/cssquery-jquery.html) 17:15:43 INFO - PID 20853 | RSS: Main: 208617472 17:15:43 INFO - PID 20853 | 17:18:46 INFO - PID 20853 | Cycle 1(1): loaded http://localhost:59919/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59919/tests/dromaeo/cssquery-mootools.html) 17:18:46 INFO - PID 20853 | RSS: Main: 210501632 17:18:46 INFO - PID 20853 | 17:21:48 INFO - PID 20853 | Cycle 1(1): loaded http://localhost:59919/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59919/tests/dromaeo/cssquery-prototype.html) 17:21:49 INFO - PID 20853 | RSS: Main: 205545472 17:21:49 INFO - PID 20853 | 17:24:52 INFO - PID 20853 | Cycle 1(1): loaded http://localhost:59919/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59919/tests/dromaeo/cssquery-yui.html) 17:24:53 INFO - PID 20853 | RSS: Main: 206860288 17:24:53 INFO - PID 20853 | 17:27:55 INFO - PID 20853 | Cycle 1(1): loaded http://localhost:59919/tests/dromaeo/cssquery-yui.html (next: http://localhost:59919/tests/dromaeo/cssquery-dojo.html) 17:27:55 INFO - PID 20853 | RSS: Main: 209399808 17:27:55 INFO - PID 20853 | 17:27:55 INFO - PID 20853 | __start_tp_report 17:27:55 INFO - PID 20853 | _x_x_mozilla_page_load 17:27:55 INFO - PID 20853 | _x_x_mozilla_page_load_details 17:27:55 INFO - PID 20853 | |i|pagename|runs| 17:27:55 INFO - PID 20853 | |0;dojo.html;3096.953545696814;3104.0842951329355;3135.8275294858786;3137;3142.9842850785744;6237.18916540849;6285.1515045468905;6309.4006069423385;6339.6830158492;6380;6126.571140020189;6268.717907694153;6336.493080553556;6425.228972523304;6441.549091563593;5770.855728606776;5828.388019257981;5845.3862344453855;5873.1190321451695;5939.910901336483;5823.417658234185;5868.41315868414;5921.763129474837;5928.525717942576;5942.435468630473;5618.410066942953;5678.4605462480995;5825.592208545403;5896.646201227919;5904.763809447617;5747.82756517301;5832.154337621064;5838.7080645967535;5838.9124163137585;5846.473817356458;5787.13193021046;5788.392218817005;5790.826275211751;5794.652320860761;5829.242198514208;6265.686715664244;6286.245650521967;6317.968410157966;6415.294317625057;6437.517186211053;6666.166729158856;6792.558483698594;6799.456043516507;6851.9657401713175;6888.104546408985;6702.631355275458;6725.461963042945;6733.562318449285;6781.796546103625;6790.185177778649;6156.630602163885;6191.288001879797;6232.781852635181;6339.809805705836;6367.013112967544;7046.6476676165985;7131.857362852714;7173.390261827699;7179.712811487482;7180.174279957767;6650.501212409089;6713.597184168965;6769.932300677028;6778.22050464193;6809.216940051859;6613.074169616258;6739.595624262462;6835.248122706498;6864.21061577925;6900.758473453506;6635.535512514174;6658.83352916181;6677.165354330708;6689.565178263398;6697;6693.564918280296;6710.127683401127;6736.797896063028;6771.695273712695;6836.350546698056;5235.267062611238;5281.20781882713;5289.973550132225;5322.2282768998275;5322.787088516493;4515.9774201128785;4560.977195114003;4562.24722920721;4570.7257564546235;4619.23782575878;5638.069718496402;5698.430156984351;5707.143928410772;5775.5668324875805;5789.189513468118;6840.828979275459;6847.349501797321;6876.17485901685;6878.38094571491;6894.379505844498;5754.367019627837;5760.279965004374;5846.1523079153285;5865.765369385262;5884.264466941632;5842.649441033552;5851.151583020438;5897.2333596633025;5901.321348044944;5928.288605367297;6408.10286559882;6519.413252807175;6572.14562106923;6590.110335104795;6657.400833924873;6862.107925969592;6872.793816185423;6893.414059804973;6899.206591242071;6906.689198985957;6567.638779867153;6569.080328754074;6620.437262832521;6626.27111017778;6627.304133066152;6680.732770689312;6704.597724136567;6763.458923286027;6788.083608712761;6808.523403361717;6812.182538095262;6871.175458944958;6880.69036893351;6948.930510694829;6961.930380696128;6390.7443702251385;6559.770408035696;6562.212534495891;6563.0811686362995;6565.901511477427;6470.902936456051;6527.2167339919515;6542.1168142300185;6564.212294524496;6572.868542629216;6511.837204069936;6538.378854009052;6633.734650613921;6651.567648103051;6667.866642667216;6553.180852393451;6653.9667301663185;6669.46644268467;6678.365555272241;6728.798136055926;6393.6483493408305;6413.615183089029;6473.708683109366;6478.838029049311;6495.480361570969 17:27:55 INFO - PID 20853 | |1;ext.html;844.6325848256005;873.1617647058823;895.5477483870652;896.4486840593036;898.1736802142028;36793.26413471729;38576;39110.8044459778;39127.21745565087;39192.412113818245;35286.647133528655;36027.81986090072;36130;36244.45633315502;36279.455808162835;6965.164180298371;7031.507794454365;7088.326608972139;7095.8226044348785;7112.359887610114;7015.4036906862975;7078.787636370891;7084.114485689289;7122.358987691106;7137.357637812595;7025.543339682929;7029.718811247544;7051.8589628207665;7077.539959902616;7639.236076392372;7597.050368703912;7714.112877019158;7766.572838493908;7766.766996990099;7835.6473958671995;7694.961525192338;7742.264484873985;7774.416918731118;7782.9610851945945;7800.102988156378;36872;37043;37369.25261494782;37733.81133094344;37766.43350349747;3466.012186526828;3509.052555809917;3530.346885826105;3530.5586801649793;3565.3047655707146;30964.0710778677;31068.844655776804;31128.37743245145;31239.531407028913;31260.37479250425;5053.545180933696;5125.794968201268;5142.948570514284;5154.587632989352;5224.52979231871;186981;187375;199951;201837;202828.98585507125;46886.76556617195;47169;47220.29169562459;47234.76382618065;47268;48053.75973120112;48330.27504587434;48564.271535926986;48686.75656621694;48736;15589.532314030597;15637.84362156364;15681.764773528406;15905.443309484344;15945.601359966093;13123.60629181126;13180.736385272432;13227.272500012592;13245.271510066847;13262;12919.22484650924;12929.612111636667;13003.024773141862;13035.869641303465;13156.40796164175;5220.9738951305;5380.24676545284;5438.809641662523;5477.808276710296;5514;981.2787601113176;1010.8584798128268;1021.0987261146468;1025.3540269630084;1026.6868605075524;22723.318300451014;22727.545449091256;22861.199858005224;22877.428064298525;22998.425039373815;1069.3690722473623;1112.449337577904;1112.8942750438857;1113.7661091170783;1122.9831552526718;11917.70205744846;12056.336901470328;12105.031597472358;12140.696482588006;12240.632781016584;209625;211145;211341;212074;213219;49942.25086623704;50131.498685013416;50258.748706256236;50707.49292507101;50723.23915141276;1393.3520912775607;1450.4923276853017;1451.267110109388;1452.7675571908655;1453.5058080252766;22042.559148816614;22243.888780555993;22578;22766.886165569067;22839.20062797794;35672.464913026844;35923.281534368645;36015.819920901275;36048.81975590105;36084.63915360813;195061;196035;196835;196886;197823;28716.42567148687;29252;29264;31761.20596985094;32048.67951320457;40053.39919901145;40670.59329406786;41673.37489937714;41731.7913410431;41913.79043104887;30378.69621303847;30525;30648.233794155323;31157.532637010918;31457.8427107863;29997.55003674903;30045.69954300429;30080.097597072123;30804.22989425282;31213.68786312108;33847;34063.829680851435;34250.82874585711;34348.31303373868;34558.481622776184;29439.11682649524;29503.85248073746;29682.40635187241;30011.399772004002;30652.08043758691;22450.32649020532;22723.431914201617;22812.543749125256;23098.538029238985;23380.53238935246 17:27:55 INFO - PID 20853 | |2;jquery.html;559.6781850436;562.5049956038686;563.780125750957;570.3526497425426;585.882823435313;21668.349949501502;22544.999999999978;22567.322980310575;22587.661185082197;22605.773942260592;22885.885570572165;23923.282301530937;24208.27375178743;24294.635580466263;24513.387165320877;6160.81517554473;6359.173307470022;6434.646094464802;6435.131257280254;6460.3862633049785;6324.367563243662;6360.109584658151;6410.358964103576;6432.13166222561;6453.677316134198;6248.31268560458;6403.48772098231;6510.511711621623;6519.478441724651;6550;6516.934830651728;6517.478601711851;6520.2175738911155;6553.311902250267;6565.803025909254;6071.362506936796;6113.113598528189;6143.385661433866;6575.802725918183;6838.7264509419565;29512;30103.548446773315;30158.69841301581;30212.395752084834;30263.546046809315;2107.8419118566167;2118;2122.628540005493;2134.413036414983;2145.152664697451;19800.702989455025;20458.897705511525;20774.48063798402;20784.27255046066;20910.895445522827;2469.5184439034397;2525.7347978462362;2536.3278731136265;2556.987215063931;2566.8973241070335;118338;121202.3939880295;124222;126188.99999999908;128514.99999999907;19608.803911960982;19636.70544941827;21124.260650877146;21270.787292127192;21299.148034078775;39948.800255999115;40018;40161.598384015786;40329.39505907414;40602;10754.247202695737;11008.789033206342;11254.15593830466;11319.264247823865;11363.488643011084;9139.72580822563;9185.081491850895;9216.769580760534;9325.487098209664;9338.112879276458;10692.839607405895;11084.113270938306;11199.888001119885;11214.327140371604;11307.547698091985;3756.6431189037;3805.1248212911187;4055.3511438169753;4226.830926762957;4492.618127459203;950.7432993091965;957.6935380678256;968.8982656820932;969.4571040217501;974.2303580171726;18100.547486312684;18510.98189599585;18566.350177743716;18650.906745466185;18656.906715466335;1016.3038318751532;1019.3832731197667;1033.8190816607064;1038.4184856480244;1038.5015192707392;10366.533505992249;10426.27016108865;10578.259521833552;10592.364458132537;10668.946655266674;460450;464767;482183;485675;488597;112353.43823280832;114529.42735286437;115133.42433287947;115395.42302288435;117216;1149.8735139134687;1165.8950694437542;1172.876847930955;1177.7232350397649;1178.4107946026986;16359.918200408922;16566.420175293806;16827.495175144766;16829.326826926786;17068.231929563448;54243;55324.44675553354;55770.16344754751;56423;57950.13074803966;69550.30449695438;69566;69720.30279697341;69985.65007174932;71584.64207679137;18624.348147814762;18856.905715471334;18996.145173467503;19115.808841911403;19141.712874306617;21916.342509724735;22025.779742202372;22074.779252207274;22123.225687100876;22136.667949981085;17280.913595431943;17596.560085997953;17611.295548177928;17614.03122828257;17648.55878603045;15473.5357939262;15808.683826323639;15825.446109386115;16197.59506012359;16373.017618942902;17625.82374176293;17644.911775441553;17815.46553603394;17971.550711232325;18147.18337674834;18581.070946452895;18596.814031859507;18772.342967996054;18802.811971880652;19007.23971041198;17407.47777566675;17448;17579.912100439415;17648.911755441142;17727.11364431799 17:27:55 INFO - PID 20853 | |3;mootools.html;1329.4283458113011;1375.965600859979;1381.585524342697;1382.3295701584732;1399.4262352435503;14923.403063877446;15467.5359739208;15599.688006239869;15605.765913511306;15606.921965390186;15081;15119.319630616621;15222.619434514116;15256.084634921885;15274.84725152748;2651.376926422284;2752.6008728734323;2753.063958254193;2753.9586906196423;2770.6813716422666;2669.8398096114297;2697.9595306070423;2727.890884364623;2732.248631626299;2751.2159034675124;2508.76166764158;2599.272203782944;2609.2041927212194;2611.8171727979047;2704.8918043278245;2693.636359091527;2695.7169497202904;2715.497632937893;2723.9591406128825;2730.385663225778;2549.6048112542585;2593.4424098818845;2643.41844794145;2649.0198626508122;2652.1910817200746;14500.492482763053;14591.70816583673;14653.70692586153;14693.26533673312;14715.264236788225;7897.763067107996;8140.063892652362;8177.5502347370875;8231.95884020576;8237.917620823775;5202.687838729688;5409.783608655649;5411.594130440233;5468.26178465906;5510.421405752419;1855.4804654696572;1867.2344338821017;1887.226237242724;1906.6377388296319;1910.5987742574075;25071.749282507124;25323;25394;25433.87283063591;25444.236672899657;6499;6661;6722.361375669304;6742;6850.417714494324;16755;16767.161641917854;16768.161591920354;16797.58006049834;16817.243224054946;7665.578393188317;7786.299233069051;7803.219678032151;7815.140334563193;7847.254510821463;7153.964230178815;7202.855942881218;7238.638068096574;7273.0908636420445;7305;4939.6542242042715;5101.744912754421;5114.744262786846;5119.1553393690365;5148.819791307286;1511.4558758846806;1528.3504510582957;1548.2800497768367;1552.990556138519;1554.207354249341;855.0807881527383;874.0472884555737;877.5392918717724;889.5329951775241;892.7009451833709;7226.674799634029;7248.782536523912;7303.525270857377;7958;8238.917610823935;708.914930208368;709.4111887133666;719.9496035277481;726.1902978179291;729.5330988167577;4341.918596519262;4361.498427680794;4391.692581519263;5107.642465027412;5383;19890.90054549747;20371;20531.8973405135;20541.178352866016;20704.792952070286;19591.412257632295;19996.111839448913;20583.794162058486;20732.274370396965;20877.89561052185;10645.574177032831;10717.46412679363;10737.892621073846;10816.405097719544;10979.560817567208;8040.195980402147;8140.87788683182;8149.551774652451;8184.263416292324;8261.339092872435;16402.507924762278;16879.66240675155;16913.91543042277;17111.401100961408;17300.13499325054;17550.73673894918;18143.727844082085;18320.45038648843;18442.907785460986;18870.3395381161;10505.737356566147;10632.574697012033;10640.361578305326;10660.413677247825;10667.573297068031;13095.869041309465;13471.12437691547;13483.797743033667;13488.190708557126;13683.657908552366;10848.945755271174;10980.1215902726;11080.722981925517;11181.440927953732;11278.605248816251;11048.613298534512;11065;11078.169137314895;11078.501467433824;11189.104871610089;9097.818043638958;9245.02927192635;9292.95353523228;9334.579943902676;9408.43549387039;6792.72829086831;6924.1997080760375;6948.583085014915;6968.407685346802;7013.193482749345;6994.720211191496;7016.158061032709;7069.787906362817;7082.893756593759;7103.147622285359 17:27:55 INFO - PID 20853 | |4;prototype.html;500.26429056860223;519.047547749879;524.1325606121865;527.8680329917521;529.2035486592678;6266.18021890149;6325.114483972242;6374.585651932621;6392.132759680385;6402.583832050925;6083.78706745264;6176.598521096137;6196.938030619693;6204.689765511717;6294.118823364733;5201.193814958688;5227.869303267411;5233.031889100519;5238.47615238475;5242.606804489659;5176.611754118438;5208.244804503344;5231.346081739783;5236.559946014839;5260.816761044162;4796.736179510125;4971.651984361096;5007.098722229997;5008.724520151391;5024.673396229252;4984.501549845023;5001.774920128603;5031.77357018935;5056.873578160538;5059.1905295152965;4488.124815660947;4495.662825288116;4508.481524624677;4509.413776209105;4543.568361005699;5888.293404791452;6107.328193898667;6188.721507532172;6194.318624951252;6227.657478838662;5715.771369145271;5748.396418376052;5763.538916886639;5763.971180144114;5803.404063882466;6533.640649764261;6559.278479367265;6564.442022428099;6569.244536878225;6598.93401065988;4859.611231101503;4873.6841052915515;4907.828226012072;4912.238603016538;4931.21100623902;6625.304343043959;6780.660966951731;6894;6905;6920.723171073151;4955.231939049453;4971.801127954914;4988.426330971912;5010.49895010496;5020.397552293675;5029.220470827027;5036.143855544567;5063;5090.261912022736;5120.743962801845;5664.8867022659315;5675.744591493392;5704.172894930211;5707.600467967285;5713.371529131792;6606.669666516655;6607.702653380609;6621.271660117383;6654.6672666366485;6663.666816659148;1766.5936834528131;1768.4694591622463;1775.7513948047283;1778.2442461953876;1785.2412724591995;1162.1690491298762;1219.823125646794;1247.5882958623633;1249.7562975219744;1255.1465003797505;5627.690477023803;5648.435156484401;5655.858603534863;5661.547076233891;5666.546676265889;6733.350329169287;6735.663216839139;6749.898751518731;6756.831079223059;6882.449404047664;5668.8866222675315;5673.659580425187;5700.429957004267;5704.71476426177;5785.537157027427;3495.2834668892815;3545.8758943436856;3552.6802587766706;3554.773603106924;3591.3356029134693;6431.839204019937;6445.645489498029;6449.419552240321;6455.7417703292285;6559.638530129149;6413.871722565523;6832.350926661959;6867.553609015398;6903;6955.826104347432;6361.61830290184;6428.55000149985;6460.709268082947;6461;6549.526356569733;6392.968035159794;6524.2823289439075;6546.738130474728;6643.335666433318;6680.164979377578;6556.901646475402;6603.273639899511;6633.237177724431;6652.068710380648;6689.933100668931;6417.812704649655;6549.443297319781;6556.246031706415;6578.967105164444;6594.802155935329;4956.851294461172;4988.650794444354;4989.176785830297;5057.443681194992;5082.745862706924;6605.985174521817;6607.57050791697;6668.766593169215;6671.966640166962;6767.492438067066;6246.718897649525;6550.803475895731;6591.538592298493;6594.505412094016;6604.768833091011;6502.187226596676;6504.577202481823;6567.9014814778775;6569.310222426577;6578.276389597045;6255.78104766331;6282.371762823681;6329.367063293634;6389.648569328731;6399.328070552525;6488.610683359014;6525.282218956006;6551.639659818756;6561.770338038145;6635.469162466895;6280.152179455715;6294.6852657366035;6328.936710632835;6412.39082287182;6506.3493650634555 17:27:55 INFO - PID 20853 | |5;yui.html;894.5706061090672;905.9048799876012;918.4443411735899;923.5382308845577;936.3211671538136;17293.913530432346;17974.37089701859;18036.639267214647;18084.186211620494;18136.81863181368;17111.22999465027;17140.40008599696;17265.654686906255;17564.64870702585;18408.35570755024;915.1671978499584;929.2983797233079;930.3952430919888;934.8924873639517;937.9484128372936;939.9389039712431;943.6319835264252;945.6170251048336;946.0397696338188;958.1759686669493;979.7354714227155;1009.6062535611118;1011.246621267157;1011.4184344002191;1011.6004178349548;992.1616234281984;999.9700008999741;1000.6247657128577;1003.6888564544978;1004.5780772075746;714.3891972363658;729.3399473476459;737.8044818123202;741.3772431157853;749.1160430691782;19450.513737156543;19476.80523194764;19551.511212219666;19632.901835490873;19674.40976770699;21611.351659450243;21653.566928661498;21829.454263643376;21898;22043.66934495984;17040.65918681632;17383.73924391135;17504.21231044606;17691;17929;3793.2223894101644;3802.049487628093;3809.047738065484;3819.751716138442;3834.328992426342;135461;136093.3195334017;138880;139132;141532;16436.342546298016;16488.6702265954;16767.748483772753;16905.661886762195;16940.23768930401;29049;29542.852285738434;29652.40695186084;30851;30932.69067309298;8431.241188293083;8499.065102838806;8517.105703901125;8540.871886921701;8544.658213671384;4174.937375939363;4211.7051806373875;4213.241616508996;4240.469941257343;4250.957490425118;5323.707196104251;5397.892042159135;5445.401005889349;5470.124780035176;5475.945240547623;944.9858252126223;956.9569369378395;974.8342781727123;986.1962500562018;991.7074463033423;668.7325069971953;692.9618870962045;695.6626036372355;696.3210869402292;713.2617740638415;10922.18083643714;11582.826257606142;11594.62295737341;12384.504619815287;13054.54309099177;672.2302963107214;688.6536820515879;695.2977492732376;705.5942832871119;706.1631966120061;5603.047481928082;5616.5787565932715;5642.858928526737;5672.177534257509;5702.657840529581;115682;115732;116768.41615792036;117967;118334;110824.44587777171;111065;113130;114172.42913785377;114452;93353;96651;96794;97866.51066744763;99107.50446247867;10544.736381590215;10563.63027294041;10590.523426445983;10593.576256949636;10605.151587873106;35955.64044359523;38886.222275554894;42362.30550777935;42992.35511467268;44051;58876.70561647164;61042.38957610367;78102.21897780949;78766.60616697109;80481;19123.235070597577;19298.035098244753;19624.9018754911;20127.597448050663;20401.69397459069;19675;20483.180672772924;20502.282420115225;20613.690794637794;20779.8961005194;17731.11344432799;17862.732059019385;19572.706409403585;19798.307059252857;19896;20118.094685738884;20339.288124915558;20494.69257961102;20687;20822.58354832925;18909.338173163873;18964.715529266796;19055.52361190981;19107.426777196706;19286.8071319285;12508.812367814307;12579;12679.112462127563;12823.93588032054;12898.419571119135;13085.476580936656;13811.51659691906;14253.928730356281;14509.274536273355;14529.418823246951 17:27:55 INFO - PID 20853 | __end_tp_report 17:27:55 INFO - PID 20853 | __start_cc_report 17:27:55 INFO - PID 20853 | _x_x_mozilla_cycle_collect,290 17:27:55 INFO - PID 20853 | __end_cc_report 17:27:55 INFO - PID 20853 | __startTimestamp1505780875936__endTimestamp 17:27:55 INFO - PID 20853 | 17:27:55 INFO - PID 20853 | ------- Summary: start ------- 17:27:55 INFO - PID 20853 | Number of tests: 6 17:27:55 INFO - PID 20853 | 17:27:55 INFO - PID 20853 | [#0] dojo.html Cycles:165 Average:6235.11 Median:6495.48 stddev:773.07 (11.9%) stddev-sans-first:735.19 17:27:55 INFO - PID 20853 | Values: 3097.0 3104.1 3135.8 3137.0 3143.0 6237.2 6285.2 6309.4 6339.7 6380.0 6126.6 6268.7 6336.5 6425.2 6441.5 5770.9 5828.4 5845.4 5873.1 5939.9 5823.4 5868.4 5921.8 5928.5 5942.4 5618.4 5678.5 5825.6 5896.6 5904.8 5747.8 5832.2 5838.7 5838.9 5846.5 5787.1 5788.4 5790.8 5794.7 5829.2 6265.7 6286.2 6318.0 6415.3 6437.5 6666.2 6792.6 6799.5 6852.0 6888.1 6702.6 6725.5 6733.6 6781.8 6790.2 6156.6 6191.3 6232.8 6339.8 6367.0 7046.6 7131.9 7173.4 7179.7 7180.2 6650.5 6713.6 6769.9 6778.2 6809.2 6613.1 6739.6 6835.2 6864.2 6900.8 6635.5 6658.8 6677.2 6689.6 6697.0 6693.6 6710.1 6736.8 6771.7 6836.4 5235.3 5281.2 5290.0 5322.2 5322.8 4516.0 4561.0 4562.2 4570.7 4619.2 5638.1 5698.4 5707.1 5775.6 5789.2 6840.8 6847.3 6876.2 6878.4 6894.4 5754.4 5760.3 5846.2 5865.8 5884.3 5842.6 5851.2 5897.2 5901.3 5928.3 6408.1 6519.4 6572.1 6590.1 6657.4 6862.1 6872.8 6893.4 6899.2 6906.7 6567.6 6569.1 6620.4 6626.3 6627.3 6680.7 6704.6 6763.5 6788.1 6808.5 6812.2 6871.2 6880.7 6948.9 6961.9 6390.7 6559.8 6562.2 6563.1 6565.9 6470.9 6527.2 6542.1 6564.2 6572.9 6511.8 6538.4 6633.7 6651.6 6667.9 6553.2 6654.0 6669.5 6678.4 6728.8 6393.6 6413.6 6473.7 6478.8 6495.5 17:27:55 INFO - PID 20853 | 17:27:55 INFO - PID 20853 | [#1] ext.html Cycles:180 Average:36197.99 Median:34157.33 stddev:52133.69 (152.6%) stddev-sans-first:52212.36 17:27:55 INFO - PID 20853 | Values: 844.6 873.2 895.5 896.4 898.2 36793.3 38576.0 39110.8 39127.2 39192.4 35286.6 36027.8 36130.0 36244.5 36279.5 6965.2 7031.5 7088.3 7095.8 7112.4 7015.4 7078.8 7084.1 7122.4 7137.4 7025.5 7029.7 7051.9 7077.5 7639.2 7597.1 7714.1 7766.6 7766.8 7835.6 7695.0 7742.3 7774.4 7783.0 7800.1 36872.0 37043.0 37369.3 37733.8 37766.4 3466.0 3509.1 3530.3 3530.6 3565.3 30964.1 31068.8 31128.4 31239.5 31260.4 5053.5 5125.8 5142.9 5154.6 5224.5 186981.0 187375.0 199951.0 201837.0 202829.0 46886.8 47169.0 47220.3 47234.8 47268.0 48053.8 48330.3 48564.3 48686.8 48736.0 15589.5 15637.8 15681.8 15905.4 15945.6 13123.6 13180.7 13227.3 13245.3 13262.0 12919.2 12929.6 13003.0 13035.9 13156.4 5221.0 5380.2 5438.8 5477.8 5514.0 981.3 1010.9 1021.1 1025.4 1026.7 22723.3 22727.5 22861.2 22877.4 22998.4 1069.4 1112.4 1112.9 1113.8 1123.0 11917.7 12056.3 12105.0 12140.7 12240.6 209625.0 211145.0 211341.0 212074.0 213219.0 49942.3 50131.5 50258.7 50707.5 50723.2 1393.4 1450.5 1451.3 1452.8 1453.5 22042.6 22243.9 22578.0 22766.9 22839.2 35672.5 35923.3 36015.8 36048.8 36084.6 195061.0 196035.0 196835.0 196886.0 197823.0 28716.4 29252.0 29264.0 31761.2 32048.7 40053.4 40670.6 41673.4 41731.8 41913.8 30378.7 30525.0 30648.2 31157.5 31457.8 29997.6 30045.7 30080.1 30804.2 31213.7 33847.0 34063.8 34250.8 34348.3 34558.5 29439.1 29503.9 29682.4 30011.4 30652.1 22450.3 22723.4 22812.5 23098.5 23380.5 17:27:55 INFO - PID 20853 | 17:27:55 INFO - PID 20853 | [#2] jquery.html Cycles:180 Average:34698.93 Median:21792.35 stddev:79870.74 (366.5%) stddev-sans-first:80053.67 17:27:55 INFO - PID 20853 | Values: 559.7 562.5 563.8 570.4 585.9 21668.3 22545.0 22567.3 22587.7 22605.8 22885.9 23923.3 24208.3 24294.6 24513.4 6160.8 6359.2 6434.6 6435.1 6460.4 6324.4 6360.1 6410.4 6432.1 6453.7 6248.3 6403.5 6510.5 6519.5 6550.0 6516.9 6517.5 6520.2 6553.3 6565.8 6071.4 6113.1 6143.4 6575.8 6838.7 29512.0 30103.5 30158.7 30212.4 30263.5 2107.8 2118.0 2122.6 2134.4 2145.2 19800.7 20458.9 20774.5 20784.3 20910.9 2469.5 2525.7 2536.3 2557.0 2566.9 118338.0 121202.4 124222.0 126189.0 128515.0 19608.8 19636.7 21124.3 21270.8 21299.1 39948.8 40018.0 40161.6 40329.4 40602.0 10754.2 11008.8 11254.2 11319.3 11363.5 9139.7 9185.1 9216.8 9325.5 9338.1 10692.8 11084.1 11199.9 11214.3 11307.5 3756.6 3805.1 4055.4 4226.8 4492.6 950.7 957.7 968.9 969.5 974.2 18100.5 18511.0 18566.4 18650.9 18656.9 1016.3 1019.4 1033.8 1038.4 1038.5 10366.5 10426.3 10578.3 10592.4 10668.9 460450.0 464767.0 482183.0 485675.0 488597.0 112353.4 114529.4 115133.4 115395.4 117216.0 1149.9 1165.9 1172.9 1177.7 1178.4 16359.9 16566.4 16827.5 16829.3 17068.2 54243.0 55324.4 55770.2 56423.0 57950.1 69550.3 69566.0 69720.3 69985.7 71584.6 18624.3 18856.9 18996.1 19115.8 19141.7 21916.3 22025.8 22074.8 22123.2 22136.7 17280.9 17596.6 17611.3 17614.0 17648.6 15473.5 15808.7 15825.4 16197.6 16373.0 17625.8 17644.9 17815.5 17971.6 18147.2 18581.1 18596.8 18772.3 18802.8 19007.2 17407.5 17448.0 17579.9 17648.9 17727.1 17:27:55 INFO - PID 20853 | 17:27:55 INFO - PID 20853 | [#3] mootools.html Cycles:180 Average:9005.11 Median:2627.62 stddev:6361.95 (242.1%) stddev-sans-first:6353.66 17:27:55 INFO - PID 20853 | Values: 1329.4 1376.0 1381.6 1382.3 1399.4 14923.4 15467.5 15599.7 15605.8 15606.9 15081.0 15119.3 15222.6 15256.1 15274.8 2651.4 2752.6 2753.1 2754.0 2770.7 2669.8 2698.0 2727.9 2732.2 2751.2 2508.8 2599.3 2609.2 2611.8 2704.9 2693.6 2695.7 2715.5 2724.0 2730.4 2549.6 2593.4 2643.4 2649.0 2652.2 14500.5 14591.7 14653.7 14693.3 14715.3 7897.8 8140.1 8177.6 8232.0 8237.9 5202.7 5409.8 5411.6 5468.3 5510.4 1855.5 1867.2 1887.2 1906.6 1910.6 25071.7 25323.0 25394.0 25433.9 25444.2 6499.0 6661.0 6722.4 6742.0 6850.4 16755.0 16767.2 16768.2 16797.6 16817.2 7665.6 7786.3 7803.2 7815.1 7847.3 7154.0 7202.9 7238.6 7273.1 7305.0 4939.7 5101.7 5114.7 5119.2 5148.8 1511.5 1528.4 1548.3 1553.0 1554.2 855.1 874.0 877.5 889.5 892.7 7226.7 7248.8 7303.5 7958.0 8238.9 708.9 709.4 719.9 726.2 729.5 4341.9 4361.5 4391.7 5107.6 5383.0 19890.9 20371.0 20531.9 20541.2 20704.8 19591.4 19996.1 20583.8 20732.3 20877.9 10645.6 10717.5 10737.9 10816.4 10979.6 8040.2 8140.9 8149.6 8184.3 8261.3 16402.5 16879.7 16913.9 17111.4 17300.1 17550.7 18143.7 18320.5 18442.9 18870.3 10505.7 10632.6 10640.4 10660.4 10667.6 13095.9 13471.1 13483.8 13488.2 13683.7 10848.9 10980.1 11080.7 11181.4 11278.6 11048.6 11065.0 11078.2 11078.5 11189.1 9097.8 9245.0 9293.0 9334.6 9408.4 6792.7 6924.2 6948.6 6968.4 7013.2 6994.7 7016.2 7069.8 7082.9 7103.1 17:27:55 INFO - PID 20853 | 17:27:55 INFO - PID 20853 | [#4] prototype.html Cycles:180 Average:5518.61 Median:6195.63 stddev:1533.10 (24.7%) stddev-sans-first:1490.41 17:27:55 INFO - PID 20853 | Values: 500.3 519.0 524.1 527.9 529.2 6266.2 6325.1 6374.6 6392.1 6402.6 6083.8 6176.6 6196.9 6204.7 6294.1 5201.2 5227.9 5233.0 5238.5 5242.6 5176.6 5208.2 5231.3 5236.6 5260.8 4796.7 4971.7 5007.1 5008.7 5024.7 4984.5 5001.8 5031.8 5056.9 5059.2 4488.1 4495.7 4508.5 4509.4 4543.6 5888.3 6107.3 6188.7 6194.3 6227.7 5715.8 5748.4 5763.5 5764.0 5803.4 6533.6 6559.3 6564.4 6569.2 6598.9 4859.6 4873.7 4907.8 4912.2 4931.2 6625.3 6780.7 6894.0 6905.0 6920.7 4955.2 4971.8 4988.4 5010.5 5020.4 5029.2 5036.1 5063.0 5090.3 5120.7 5664.9 5675.7 5704.2 5707.6 5713.4 6606.7 6607.7 6621.3 6654.7 6663.7 1766.6 1768.5 1775.8 1778.2 1785.2 1162.2 1219.8 1247.6 1249.8 1255.1 5627.7 5648.4 5655.9 5661.5 5666.5 6733.4 6735.7 6749.9 6756.8 6882.4 5668.9 5673.7 5700.4 5704.7 5785.5 3495.3 3545.9 3552.7 3554.8 3591.3 6431.8 6445.6 6449.4 6455.7 6559.6 6413.9 6832.4 6867.6 6903.0 6955.8 6361.6 6428.6 6460.7 6461.0 6549.5 6393.0 6524.3 6546.7 6643.3 6680.2 6556.9 6603.3 6633.2 6652.1 6689.9 6417.8 6549.4 6556.2 6579.0 6594.8 4956.9 4988.7 4989.2 5057.4 5082.7 6606.0 6607.6 6668.8 6672.0 6767.5 6246.7 6550.8 6591.5 6594.5 6604.8 6502.2 6504.6 6567.9 6569.3 6578.3 6255.8 6282.4 6329.4 6389.6 6399.3 6488.6 6525.3 6551.6 6561.8 6635.5 6280.2 6294.7 6328.9 6412.4 6506.3 17:27:55 INFO - PID 20853 | 17:27:55 INFO - PID 20853 | [#5] yui.html Cycles:180 Average:25035.21 Median:20801.24 stddev:35401.81 (170.2%) stddev-sans-first:35454.72 17:27:55 INFO - PID 20853 | Values: 894.6 905.9 918.4 923.5 936.3 17293.9 17974.4 18036.6 18084.2 18136.8 17111.2 17140.4 17265.7 17564.6 18408.4 915.2 929.3 930.4 934.9 937.9 939.9 943.6 945.6 946.0 958.2 979.7 1009.6 1011.2 1011.4 1011.6 992.2 1000.0 1000.6 1003.7 1004.6 714.4 729.3 737.8 741.4 749.1 19450.5 19476.8 19551.5 19632.9 19674.4 21611.4 21653.6 21829.5 21898.0 22043.7 17040.7 17383.7 17504.2 17691.0 17929.0 3793.2 3802.0 3809.0 3819.8 3834.3 135461.0 136093.3 138880.0 139132.0 141532.0 16436.3 16488.7 16767.7 16905.7 16940.2 29049.0 29542.9 29652.4 30851.0 30932.7 8431.2 8499.1 8517.1 8540.9 8544.7 4174.9 4211.7 4213.2 4240.5 4251.0 5323.7 5397.9 5445.4 5470.1 5475.9 945.0 957.0 974.8 986.2 991.7 668.7 693.0 695.7 696.3 713.3 10922.2 11582.8 11594.6 12384.5 13054.5 672.2 688.7 695.3 705.6 706.2 5603.0 5616.6 5642.9 5672.2 5702.7 115682.0 115732.0 116768.4 117967.0 118334.0 110824.4 111065.0 113130.0 114172.4 114452.0 93353.0 96651.0 96794.0 97866.5 99107.5 10544.7 10563.6 10590.5 10593.6 10605.2 35955.6 38886.2 42362.3 42992.4 44051.0 58876.7 61042.4 78102.2 78766.6 80481.0 19123.2 19298.0 19624.9 20127.6 20401.7 19675.0 20483.2 20502.3 20613.7 20779.9 17731.1 17862.7 19572.7 19798.3 19896.0 20118.1 20339.3 20494.7 20687.0 20822.6 18909.3 18964.7 19055.5 19107.4 19286.8 12508.8 12579.0 12679.1 12823.9 12898.4 13085.5 13811.5 14253.9 14509.3 14529.4 17:27:55 INFO - PID 20853 | -------- Summary: end -------- 17:27:55 INFO - PID 20853 | 17:27:56 INFO - TEST-INFO | 20853: exit 0 17:27:56 INFO - TEST-OK | dromaeo_css | took 1112748ms 17:27:56 INFO - TEST-START | kraken 17:27:56 INFO - Initialising browser for kraken test... 17:27:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59919/getInfo.html -profile /tmp/tmpgdQA3N/profile 17:27:56 INFO - TEST-INFO | started process 21238 (/builds/slave/test/build/application/firefox/firefox http://localhost:59919/getInfo.html) 17:28:02 INFO - TEST-INFO | 21238: exit 0 17:28:02 INFO - Browser initialized. 17:28:02 INFO - Running cycle 1/1 for kraken test... 17:28:02 INFO - Using env: {'DISPLAY': ':0', 17:28:02 INFO - 'HOME': '/home/cltbld', 17:28:02 INFO - 'JSGC_DISABLE_POISONING': '1', 17:28:02 INFO - 'LANG': 'en_US.UTF-8', 17:28:02 INFO - 'LANGUAGE': 'en_US:en', 17:28:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:28:02 INFO - 'LOGNAME': 'cltbld', 17:28:02 INFO - 'MAIL': '/var/mail/cltbld', 17:28:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:28:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:28:02 INFO - 'MOZ_ACCELERATED': '1', 17:28:02 INFO - 'MOZ_CRASHREPORTER': '1', 17:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:28:02 INFO - 'MOZ_NO_REMOTE': '1', 17:28:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:28:02 INFO - 'MOZ_WEBRENDER': '1', 17:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:02 INFO - 'NO_EM_RESTART': '1', 17:28:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:02 INFO - 'PWD': '/builds/slave/test', 17:28:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:28:02 INFO - 'RUST_BACKTRACE': 'full', 17:28:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:28:02 INFO - 'SHELL': '/bin/bash', 17:28:02 INFO - 'SHLVL': '1', 17:28:02 INFO - 'TERM': 'linux', 17:28:02 INFO - 'TMOUT': '86400', 17:28:02 INFO - 'USER': 'cltbld', 17:28:02 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258', 17:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:02 INFO - '_': '/tools/buildbot/bin/python'} 17:28:02 INFO - TEST-INFO | started process 21483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgdQA3N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:28:03 INFO - PID 21483 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:28:03 INFO - PID 21483 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:28:04 INFO - PID 21483 | 17:28:04 INFO - PID 21483 | (/builds/slave/test/build/application/firefox/firefox:21544): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:28:04 INFO - PID 21483 | 17:28:14 INFO - PID 21483 | RSS: Main: 206352384 17:28:14 INFO - PID 21483 | 17:28:17 INFO - PID 21483 | Cycle 1(1): loaded http://localhost:59919/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59919/tests/kraken/driver.html?testName=audio-beat-detection) 17:28:17 INFO - PID 21483 | RSS: Main: 205193216 17:28:17 INFO - PID 21483 | 17:28:20 INFO - PID 21483 | Cycle 1(1): loaded http://localhost:59919/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59919/tests/kraken/driver.html?testName=audio-dft) 17:28:21 INFO - PID 21483 | RSS: Main: 204746752 17:28:21 INFO - PID 21483 | 17:28:24 INFO - PID 21483 | Cycle 1(1): loaded http://localhost:59919/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59919/tests/kraken/driver.html?testName=audio-fft) 17:28:24 INFO - PID 21483 | RSS: Main: 202756096 17:28:24 INFO - PID 21483 | 17:28:27 INFO - PID 21483 | Cycle 1(1): loaded http://localhost:59919/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59919/tests/kraken/driver.html?testName=audio-oscillator) 17:28:27 INFO - PID 21483 | RSS: Main: 202657792 17:28:27 INFO - PID 21483 | 17:28:29 INFO - PID 21483 | Cycle 1(1): loaded http://localhost:59919/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59919/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:28:30 INFO - PID 21483 | RSS: Main: 203210752 17:28:30 INFO - PID 21483 | 17:28:33 INFO - PID 21483 | Cycle 1(1): loaded http://localhost:59919/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59919/tests/kraken/driver.html?testName=imaging-darkroom) 17:28:34 INFO - PID 21483 | RSS: Main: 204316672 17:28:34 INFO - PID 21483 | 17:28:38 INFO - PID 21483 | Cycle 1(1): loaded http://localhost:59919/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59919/tests/kraken/driver.html?testName=imaging-desaturate) 17:28:38 INFO - PID 21483 | RSS: Main: 205832192 17:28:38 INFO - PID 21483 | 17:28:41 INFO - PID 21483 | Cycle 1(1): loaded http://localhost:59919/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59919/tests/kraken/driver.html?testName=json-parse-financial) 17:28:42 INFO - PID 21483 | RSS: Main: 205357056 17:28:42 INFO - PID 21483 | 17:28:43 INFO - PID 21483 | Cycle 1(1): loaded http://localhost:59919/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59919/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:28:44 INFO - PID 21483 | RSS: Main: 205258752 17:28:44 INFO - PID 21483 | 17:28:46 INFO - PID 21483 | Cycle 1(1): loaded http://localhost:59919/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59919/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:28:46 INFO - PID 21483 | RSS: Main: 202936320 17:28:46 INFO - PID 21483 | 17:28:49 INFO - PID 21483 | Cycle 1(1): loaded http://localhost:59919/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59919/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:28:49 INFO - PID 21483 | RSS: Main: 202178560 17:28:49 INFO - PID 21483 | 17:28:52 INFO - PID 21483 | Cycle 1(1): loaded http://localhost:59919/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:28:53 INFO - PID 21483 | RSS: Main: 203255808 17:28:53 INFO - PID 21483 | 17:28:55 INFO - PID 21483 | Cycle 1(1): loaded http://localhost:59919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:28:56 INFO - PID 21483 | RSS: Main: 202637312 17:28:56 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | Cycle 1(1): loaded http://localhost:59919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59919/tests/kraken/driver.html?testName=ai-astar) 17:28:58 INFO - PID 21483 | RSS: Main: 205443072 17:28:58 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | __start_tp_report 17:28:58 INFO - PID 21483 | _x_x_mozilla_page_load 17:28:58 INFO - PID 21483 | _x_x_mozilla_page_load_details 17:28:58 INFO - PID 21483 | |i|pagename|runs| 17:28:58 INFO - PID 21483 | |0;ai-astar;108;110;106;114;112;107;106;114;115;110 17:28:58 INFO - PID 21483 | |1;audio-beat-detection;116;117;123;118;119;118;151;119;117;118 17:28:58 INFO - PID 21483 | |2;audio-dft;166;174;166;163;162;165;168;173;162;163 17:28:58 INFO - PID 21483 | |3;audio-fft;76;80;76;79;76;74;74;77;79;80 17:28:58 INFO - PID 21483 | |4;audio-oscillator;80;86;84;79;80;80;83;88;85;87 17:28:58 INFO - PID 21483 | |5;imaging-gaussian-blur;116;119;114;113;115;127;115;119;116;115 17:28:58 INFO - PID 21483 | |6;imaging-darkroom;158;151;149;148;149;152;149;153;151;150 17:28:58 INFO - PID 21483 | |7;imaging-desaturate;94;94;101;95;102;103;95;93;102;99 17:28:58 INFO - PID 21483 | |8;json-parse-financial;60;62;54;61;56;54;55;56;54;55 17:28:58 INFO - PID 21483 | |9;json-stringify-tinderbox;45;38;48;44;39;43;38;38;38;46 17:28:58 INFO - PID 21483 | |10;stanford-crypto-aes;81;80;81;75;75;81;74;82;77;77 17:28:58 INFO - PID 21483 | |11;stanford-crypto-ccm;116;112;112;110;119;117;119;121;114;110 17:28:58 INFO - PID 21483 | |12;stanford-crypto-pbkdf2;174;169;169;169;167;172;168;167;168;177 17:28:58 INFO - PID 21483 | |13;stanford-crypto-sha256-iterative;65;69;65;63;64;66;78;66;66;66 17:28:58 INFO - PID 21483 | __end_tp_report 17:28:58 INFO - PID 21483 | __start_cc_report 17:28:58 INFO - PID 21483 | _x_x_mozilla_cycle_collect,761 17:28:58 INFO - PID 21483 | __end_cc_report 17:28:58 INFO - PID 21483 | __startTimestamp1505780938649__endTimestamp 17:28:58 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | ------- Summary: start ------- 17:28:58 INFO - PID 21483 | Number of tests: 14 17:28:58 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:3.43 (3.1%) stddev-sans-first:3.54 17:28:58 INFO - PID 21483 | Values: 108.0 110.0 106.0 114.0 112.0 107.0 106.0 114.0 115.0 110.0 17:28:58 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | [#1] audio-beat-detection Cycles:10 Average:121.60 Median:118.50 stddev:10.50 (8.9%) stddev-sans-first:10.94 17:28:58 INFO - PID 21483 | Values: 116.0 117.0 123.0 118.0 119.0 118.0 151.0 119.0 117.0 118.0 17:28:58 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | [#2] audio-dft Cycles:10 Average:166.20 Median:166.00 stddev:4.32 (2.6%) stddev-sans-first:4.58 17:28:58 INFO - PID 21483 | Values: 166.0 174.0 166.0 163.0 162.0 165.0 168.0 173.0 162.0 163.0 17:28:58 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | [#3] audio-fft Cycles:10 Average:77.10 Median:78.00 stddev:2.28 (2.9%) stddev-sans-first:2.39 17:28:58 INFO - PID 21483 | Values: 76.0 80.0 76.0 79.0 76.0 74.0 74.0 77.0 79.0 80.0 17:28:58 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | [#4] audio-oscillator Cycles:10 Average:83.20 Median:84.50 stddev:3.29 (3.9%) stddev-sans-first:3.28 17:28:58 INFO - PID 21483 | Values: 80.0 86.0 84.0 79.0 80.0 80.0 83.0 88.0 85.0 87.0 17:28:58 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:116.00 stddev:4.04 (3.5%) stddev-sans-first:4.27 17:28:58 INFO - PID 21483 | Values: 116.0 119.0 114.0 113.0 115.0 127.0 115.0 119.0 116.0 115.0 17:28:58 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:2.91 (1.9%) stddev-sans-first:1.64 17:28:58 INFO - PID 21483 | Values: 158.0 151.0 149.0 148.0 149.0 152.0 149.0 153.0 151.0 150.0 17:28:58 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | [#7] imaging-desaturate Cycles:10 Average:97.80 Median:94.00 stddev:3.97 (4.2%) stddev-sans-first:3.96 17:28:58 INFO - PID 21483 | Values: 94.0 94.0 101.0 95.0 102.0 103.0 95.0 93.0 102.0 99.0 17:28:58 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:3.09 (5.5%) stddev-sans-first:3.04 17:28:58 INFO - PID 21483 | Values: 60.0 62.0 54.0 61.0 56.0 54.0 55.0 56.0 54.0 55.0 17:28:58 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | [#9] json-stringify-tinderbox Cycles:10 Average:41.70 Median:43.50 stddev:3.92 (9.0%) stddev-sans-first:3.97 17:28:58 INFO - PID 21483 | Values: 45.0 38.0 48.0 44.0 39.0 43.0 38.0 38.0 38.0 46.0 17:28:58 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:80.50 stddev:3.02 (3.8%) stddev-sans-first:3.04 17:28:58 INFO - PID 21483 | Values: 81.0 80.0 81.0 75.0 75.0 81.0 74.0 82.0 77.0 77.0 17:28:58 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:116.50 stddev:3.97 (3.4%) stddev-sans-first:4.20 17:28:58 INFO - PID 21483 | Values: 116.0 112.0 112.0 110.0 119.0 117.0 119.0 121.0 114.0 110.0 17:28:58 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:169.00 stddev:3.30 (2.0%) stddev-sans-first:3.17 17:28:58 INFO - PID 21483 | Values: 174.0 169.0 169.0 169.0 167.0 172.0 168.0 167.0 168.0 177.0 17:28:58 INFO - PID 21483 | 17:28:58 INFO - PID 21483 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.00 stddev:4.24 (6.4%) stddev-sans-first:4.44 17:28:58 INFO - PID 21483 | Values: 65.0 69.0 65.0 63.0 64.0 66.0 78.0 66.0 66.0 66.0 17:28:58 INFO - PID 21483 | -------- Summary: end -------- 17:28:58 INFO - PID 21483 | 17:28:59 INFO - PID 21483 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:28:59 INFO - TEST-INFO | 21483: exit 0 17:28:59 INFO - TEST-OK | kraken | took 62701ms 17:28:59 INFO - SUITE-END | took 1175s 17:28:59 INFO - Completed test suite (00:19:35) 17:28:59 INFO - javascript benchmark 17:28:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8521.78216231356, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3096.953545696814, 3104.0842951329355, 3135.8275294858786, 3137.0, 3142.9842850785744, 6237.18916540849, 6285.1515045468905, 6309.4006069423385, 6339.6830158492, 6380.0, 6126.571140020189, 6268.717907694153, 6336.493080553556, 6425.228972523304, 6441.549091563593, 5770.855728606776, 5828.388019257981, 5845.3862344453855, 5873.1190321451695, 5939.910901336483, 5823.417658234185, 5868.41315868414, 5921.763129474837, 5928.525717942576, 5942.435468630473, 5618.410066942953, 5678.4605462480995, 5825.592208545403, 5896.646201227919, 5904.763809447617, 5747.82756517301, 5832.154337621064, 5838.7080645967535, 5838.9124163137585, 5846.473817356458, 5787.13193021046, 5788.392218817005, 5790.826275211751, 5794.652320860761, 5829.242198514208, 6265.686715664244, 6286.245650521967, 6317.968410157966, 6415.294317625057, 6437.517186211053, 6666.166729158856, 6792.558483698594, 6799.456043516507, 6851.9657401713175, 6888.104546408985, 6702.631355275458, 6725.461963042945, 6733.562318449285, 6781.796546103625, 6790.185177778649, 6156.630602163885, 6191.288001879797, 6232.781852635181, 6339.809805705836, 6367.013112967544, 7046.6476676165985, 7131.857362852714, 7173.390261827699, 7179.712811487482, 7180.174279957767, 6650.501212409089, 6713.597184168965, 6769.932300677028, 6778.22050464193, 6809.216940051859, 6613.074169616258, 6739.595624262462, 6835.248122706498, 6864.21061577925, 6900.758473453506, 6635.535512514174, 6658.83352916181, 6677.165354330708, 6689.565178263398, 6697.0, 6693.564918280296, 6710.127683401127, 6736.797896063028, 6771.695273712695, 6836.350546698056, 5235.267062611238, 5281.20781882713, 5289.973550132225, 5322.2282768998275, 5322.787088516493, 4515.9774201128785, 4560.977195114003, 4562.24722920721, 4570.7257564546235, 4619.23782575878, 5638.069718496402, 5698.430156984351, 5707.143928410772, 5775.5668324875805, 5789.189513468118, 6840.828979275459, 6847.349501797321, 6876.17485901685, 6878.38094571491, 6894.379505844498, 5754.367019627837, 5760.279965004374, 5846.1523079153285, 5865.765369385262, 5884.264466941632, 5842.649441033552, 5851.151583020438, 5897.2333596633025, 5901.321348044944, 5928.288605367297, 6408.10286559882, 6519.413252807175, 6572.14562106923, 6590.110335104795, 6657.400833924873, 6862.107925969592, 6872.793816185423, 6893.414059804973, 6899.206591242071, 6906.689198985957, 6567.638779867153, 6569.080328754074, 6620.437262832521, 6626.27111017778, 6627.304133066152, 6680.732770689312, 6704.597724136567, 6763.458923286027, 6788.083608712761, 6808.523403361717, 6812.182538095262, 6871.175458944958, 6880.69036893351, 6948.930510694829, 6961.930380696128, 6390.7443702251385, 6559.770408035696, 6562.212534495891, 6563.0811686362995, 6565.901511477427, 6470.902936456051, 6527.2167339919515, 6542.1168142300185, 6564.212294524496, 6572.868542629216, 6511.837204069936, 6538.378854009052, 6633.734650613921, 6651.567648103051, 6667.866642667216, 6553.180852393451, 6653.9667301663185, 6669.46644268467, 6678.365555272241, 6728.798136055926, 6393.6483493408305, 6413.615183089029, 6473.708683109366, 6478.838029049311, 6495.480361570969], "value": 6174.026898124447, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [844.6325848256005, 873.1617647058823, 895.5477483870652, 896.4486840593036, 898.1736802142028, 36793.26413471729, 38576.0, 39110.8044459778, 39127.21745565087, 39192.412113818245, 35286.647133528655, 36027.81986090072, 36130.0, 36244.45633315502, 36279.455808162835, 6965.164180298371, 7031.507794454365, 7088.326608972139, 7095.8226044348785, 7112.359887610114, 7015.4036906862975, 7078.787636370891, 7084.114485689289, 7122.358987691106, 7137.357637812595, 7025.543339682929, 7029.718811247544, 7051.8589628207665, 7077.539959902616, 7639.236076392372, 7597.050368703912, 7714.112877019158, 7766.572838493908, 7766.766996990099, 7835.6473958671995, 7694.961525192338, 7742.264484873985, 7774.416918731118, 7782.9610851945945, 7800.102988156378, 36872.0, 37043.0, 37369.25261494782, 37733.81133094344, 37766.43350349747, 3466.012186526828, 3509.052555809917, 3530.346885826105, 3530.5586801649793, 3565.3047655707146, 30964.0710778677, 31068.844655776804, 31128.37743245145, 31239.531407028913, 31260.37479250425, 5053.545180933696, 5125.794968201268, 5142.948570514284, 5154.587632989352, 5224.52979231871, 186981.0, 187375.0, 199951.0, 201837.0, 202828.98585507125, 46886.76556617195, 47169.0, 47220.29169562459, 47234.76382618065, 47268.0, 48053.75973120112, 48330.27504587434, 48564.271535926986, 48686.75656621694, 48736.0, 15589.532314030597, 15637.84362156364, 15681.764773528406, 15905.443309484344, 15945.601359966093, 13123.60629181126, 13180.736385272432, 13227.272500012592, 13245.271510066847, 13262.0, 12919.22484650924, 12929.612111636667, 13003.024773141862, 13035.869641303465, 13156.40796164175, 5220.9738951305, 5380.24676545284, 5438.809641662523, 5477.808276710296, 5514.0, 981.2787601113176, 1010.8584798128268, 1021.0987261146468, 1025.3540269630084, 1026.6868605075524, 22723.318300451014, 22727.545449091256, 22861.199858005224, 22877.428064298525, 22998.425039373815, 1069.3690722473623, 1112.449337577904, 1112.8942750438857, 1113.7661091170783, 1122.9831552526718, 11917.70205744846, 12056.336901470328, 12105.031597472358, 12140.696482588006, 12240.632781016584, 209625.0, 211145.0, 211341.0, 212074.0, 213219.0, 49942.25086623704, 50131.498685013416, 50258.748706256236, 50707.49292507101, 50723.23915141276, 1393.3520912775607, 1450.4923276853017, 1451.267110109388, 1452.7675571908655, 1453.5058080252766, 22042.559148816614, 22243.888780555993, 22578.0, 22766.886165569067, 22839.20062797794, 35672.464913026844, 35923.281534368645, 36015.819920901275, 36048.81975590105, 36084.63915360813, 195061.0, 196035.0, 196835.0, 196886.0, 197823.0, 28716.42567148687, 29252.0, 29264.0, 31761.20596985094, 32048.67951320457, 40053.39919901145, 40670.59329406786, 41673.37489937714, 41731.7913410431, 41913.79043104887, 30378.69621303847, 30525.0, 30648.233794155323, 31157.532637010918, 31457.8427107863, 29997.55003674903, 30045.69954300429, 30080.097597072123, 30804.22989425282, 31213.68786312108, 33847.0, 34063.829680851435, 34250.82874585711, 34348.31303373868, 34558.481622776184, 29439.11682649524, 29503.85248073746, 29682.40635187241, 30011.399772004002, 30652.08043758691, 22450.32649020532, 22723.431914201617, 22812.543749125256, 23098.538029238985, 23380.53238935246], "value": 16548.42405200291, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.6781850436, 562.5049956038686, 563.780125750957, 570.3526497425426, 585.882823435313, 21668.349949501502, 22544.999999999978, 22567.322980310575, 22587.661185082197, 22605.773942260592, 22885.885570572165, 23923.282301530937, 24208.27375178743, 24294.635580466263, 24513.387165320877, 6160.81517554473, 6359.173307470022, 6434.646094464802, 6435.131257280254, 6460.3862633049785, 6324.367563243662, 6360.109584658151, 6410.358964103576, 6432.13166222561, 6453.677316134198, 6248.31268560458, 6403.48772098231, 6510.511711621623, 6519.478441724651, 6550.0, 6516.934830651728, 6517.478601711851, 6520.2175738911155, 6553.311902250267, 6565.803025909254, 6071.362506936796, 6113.113598528189, 6143.385661433866, 6575.802725918183, 6838.7264509419565, 29512.0, 30103.548446773315, 30158.69841301581, 30212.395752084834, 30263.546046809315, 2107.8419118566167, 2118.0, 2122.628540005493, 2134.413036414983, 2145.152664697451, 19800.702989455025, 20458.897705511525, 20774.48063798402, 20784.27255046066, 20910.895445522827, 2469.5184439034397, 2525.7347978462362, 2536.3278731136265, 2556.987215063931, 2566.8973241070335, 118338.0, 121202.3939880295, 124222.0, 126188.99999999908, 128514.99999999907, 19608.803911960982, 19636.70544941827, 21124.260650877146, 21270.787292127192, 21299.148034078775, 39948.800255999115, 40018.0, 40161.598384015786, 40329.39505907414, 40602.0, 10754.247202695737, 11008.789033206342, 11254.15593830466, 11319.264247823865, 11363.488643011084, 9139.72580822563, 9185.081491850895, 9216.769580760534, 9325.487098209664, 9338.112879276458, 10692.839607405895, 11084.113270938306, 11199.888001119885, 11214.327140371604, 11307.547698091985, 3756.6431189037, 3805.1248212911187, 4055.3511438169753, 4226.830926762957, 4492.618127459203, 950.7432993091965, 957.6935380678256, 968.8982656820932, 969.4571040217501, 974.2303580171726, 18100.547486312684, 18510.98189599585, 18566.350177743716, 18650.906745466185, 18656.906715466335, 1016.3038318751532, 1019.3832731197667, 1033.8190816607064, 1038.4184856480244, 1038.5015192707392, 10366.533505992249, 10426.27016108865, 10578.259521833552, 10592.364458132537, 10668.946655266674, 460450.0, 464767.0, 482183.0, 485675.0, 488597.0, 112353.43823280832, 114529.42735286437, 115133.42433287947, 115395.42302288435, 117216.0, 1149.8735139134687, 1165.8950694437542, 1172.876847930955, 1177.7232350397649, 1178.4107946026986, 16359.918200408922, 16566.420175293806, 16827.495175144766, 16829.326826926786, 17068.231929563448, 54243.0, 55324.44675553354, 55770.16344754751, 56423.0, 57950.13074803966, 69550.30449695438, 69566.0, 69720.30279697341, 69985.65007174932, 71584.64207679137, 18624.348147814762, 18856.905715471334, 18996.145173467503, 19115.808841911403, 19141.712874306617, 21916.342509724735, 22025.779742202372, 22074.779252207274, 22123.225687100876, 22136.667949981085, 17280.913595431943, 17596.560085997953, 17611.295548177928, 17614.03122828257, 17648.55878603045, 15473.5357939262, 15808.683826323639, 15825.446109386115, 16197.59506012359, 16373.017618942902, 17625.82374176293, 17644.911775441553, 17815.46553603394, 17971.550711232325, 18147.18337674834, 18581.070946452895, 18596.814031859507, 18772.342967996054, 18802.811971880652, 19007.23971041198, 17407.47777566675, 17448.0, 17579.912100439415, 17648.911755441142, 17727.11364431799], "value": 12483.80334465553, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.4283458113011, 1375.965600859979, 1381.585524342697, 1382.3295701584732, 1399.4262352435503, 14923.403063877446, 15467.5359739208, 15599.688006239869, 15605.765913511306, 15606.921965390186, 15081.0, 15119.319630616621, 15222.619434514116, 15256.084634921885, 15274.84725152748, 2651.376926422284, 2752.6008728734323, 2753.063958254193, 2753.9586906196423, 2770.6813716422666, 2669.8398096114297, 2697.9595306070423, 2727.890884364623, 2732.248631626299, 2751.2159034675124, 2508.76166764158, 2599.272203782944, 2609.2041927212194, 2611.8171727979047, 2704.8918043278245, 2693.636359091527, 2695.7169497202904, 2715.497632937893, 2723.9591406128825, 2730.385663225778, 2549.6048112542585, 2593.4424098818845, 2643.41844794145, 2649.0198626508122, 2652.1910817200746, 14500.492482763053, 14591.70816583673, 14653.70692586153, 14693.26533673312, 14715.264236788225, 7897.763067107996, 8140.063892652362, 8177.5502347370875, 8231.95884020576, 8237.917620823775, 5202.687838729688, 5409.783608655649, 5411.594130440233, 5468.26178465906, 5510.421405752419, 1855.4804654696572, 1867.2344338821017, 1887.226237242724, 1906.6377388296319, 1910.5987742574075, 25071.749282507124, 25323.0, 25394.0, 25433.87283063591, 25444.236672899657, 6499.0, 6661.0, 6722.361375669304, 6742.0, 6850.417714494324, 16755.0, 16767.161641917854, 16768.161591920354, 16797.58006049834, 16817.243224054946, 7665.578393188317, 7786.299233069051, 7803.219678032151, 7815.140334563193, 7847.254510821463, 7153.964230178815, 7202.855942881218, 7238.638068096574, 7273.0908636420445, 7305.0, 4939.6542242042715, 5101.744912754421, 5114.744262786846, 5119.1553393690365, 5148.819791307286, 1511.4558758846806, 1528.3504510582957, 1548.2800497768367, 1552.990556138519, 1554.207354249341, 855.0807881527383, 874.0472884555737, 877.5392918717724, 889.5329951775241, 892.7009451833709, 7226.674799634029, 7248.782536523912, 7303.525270857377, 7958.0, 8238.917610823935, 708.914930208368, 709.4111887133666, 719.9496035277481, 726.1902978179291, 729.5330988167577, 4341.918596519262, 4361.498427680794, 4391.692581519263, 5107.642465027412, 5383.0, 19890.90054549747, 20371.0, 20531.8973405135, 20541.178352866016, 20704.792952070286, 19591.412257632295, 19996.111839448913, 20583.794162058486, 20732.274370396965, 20877.89561052185, 10645.574177032831, 10717.46412679363, 10737.892621073846, 10816.405097719544, 10979.560817567208, 8040.195980402147, 8140.87788683182, 8149.551774652451, 8184.263416292324, 8261.339092872435, 16402.507924762278, 16879.66240675155, 16913.91543042277, 17111.401100961408, 17300.13499325054, 17550.73673894918, 18143.727844082085, 18320.45038648843, 18442.907785460986, 18870.3395381161, 10505.737356566147, 10632.574697012033, 10640.361578305326, 10660.413677247825, 10667.573297068031, 13095.869041309465, 13471.12437691547, 13483.797743033667, 13488.190708557126, 13683.657908552366, 10848.945755271174, 10980.1215902726, 11080.722981925517, 11181.440927953732, 11278.605248816251, 11048.613298534512, 11065.0, 11078.169137314895, 11078.501467433824, 11189.104871610089, 9097.818043638958, 9245.02927192635, 9292.95353523228, 9334.579943902676, 9408.43549387039, 6792.72829086831, 6924.1997080760375, 6948.583085014915, 6968.407685346802, 7013.193482749345, 6994.720211191496, 7016.158061032709, 7069.787906362817, 7082.893756593759, 7103.147622285359], "value": 6447.1539235855425, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.26429056860223, 519.047547749879, 524.1325606121865, 527.8680329917521, 529.2035486592678, 6266.18021890149, 6325.114483972242, 6374.585651932621, 6392.132759680385, 6402.583832050925, 6083.78706745264, 6176.598521096137, 6196.938030619693, 6204.689765511717, 6294.118823364733, 5201.193814958688, 5227.869303267411, 5233.031889100519, 5238.47615238475, 5242.606804489659, 5176.611754118438, 5208.244804503344, 5231.346081739783, 5236.559946014839, 5260.816761044162, 4796.736179510125, 4971.651984361096, 5007.098722229997, 5008.724520151391, 5024.673396229252, 4984.501549845023, 5001.774920128603, 5031.77357018935, 5056.873578160538, 5059.1905295152965, 4488.124815660947, 4495.662825288116, 4508.481524624677, 4509.413776209105, 4543.568361005699, 5888.293404791452, 6107.328193898667, 6188.721507532172, 6194.318624951252, 6227.657478838662, 5715.771369145271, 5748.396418376052, 5763.538916886639, 5763.971180144114, 5803.404063882466, 6533.640649764261, 6559.278479367265, 6564.442022428099, 6569.244536878225, 6598.93401065988, 4859.611231101503, 4873.6841052915515, 4907.828226012072, 4912.238603016538, 4931.21100623902, 6625.304343043959, 6780.660966951731, 6894.0, 6905.0, 6920.723171073151, 4955.231939049453, 4971.801127954914, 4988.426330971912, 5010.49895010496, 5020.397552293675, 5029.220470827027, 5036.143855544567, 5063.0, 5090.261912022736, 5120.743962801845, 5664.8867022659315, 5675.744591493392, 5704.172894930211, 5707.600467967285, 5713.371529131792, 6606.669666516655, 6607.702653380609, 6621.271660117383, 6654.6672666366485, 6663.666816659148, 1766.5936834528131, 1768.4694591622463, 1775.7513948047283, 1778.2442461953876, 1785.2412724591995, 1162.1690491298762, 1219.823125646794, 1247.5882958623633, 1249.7562975219744, 1255.1465003797505, 5627.690477023803, 5648.435156484401, 5655.858603534863, 5661.547076233891, 5666.546676265889, 6733.350329169287, 6735.663216839139, 6749.898751518731, 6756.831079223059, 6882.449404047664, 5668.8866222675315, 5673.659580425187, 5700.429957004267, 5704.71476426177, 5785.537157027427, 3495.2834668892815, 3545.8758943436856, 3552.6802587766706, 3554.773603106924, 3591.3356029134693, 6431.839204019937, 6445.645489498029, 6449.419552240321, 6455.7417703292285, 6559.638530129149, 6413.871722565523, 6832.350926661959, 6867.553609015398, 6903.0, 6955.826104347432, 6361.61830290184, 6428.55000149985, 6460.709268082947, 6461.0, 6549.526356569733, 6392.968035159794, 6524.2823289439075, 6546.738130474728, 6643.335666433318, 6680.164979377578, 6556.901646475402, 6603.273639899511, 6633.237177724431, 6652.068710380648, 6689.933100668931, 6417.812704649655, 6549.443297319781, 6556.246031706415, 6578.967105164444, 6594.802155935329, 4956.851294461172, 4988.650794444354, 4989.176785830297, 5057.443681194992, 5082.745862706924, 6605.985174521817, 6607.57050791697, 6668.766593169215, 6671.966640166962, 6767.492438067066, 6246.718897649525, 6550.803475895731, 6591.538592298493, 6594.505412094016, 6604.768833091011, 6502.187226596676, 6504.577202481823, 6567.9014814778775, 6569.310222426577, 6578.276389597045, 6255.78104766331, 6282.371762823681, 6329.367063293634, 6389.648569328731, 6399.328070552525, 6488.610683359014, 6525.282218956006, 6551.639659818756, 6561.770338038145, 6635.469162466895, 6280.152179455715, 6294.6852657366035, 6328.936710632835, 6412.39082287182, 6506.3493650634555], "value": 5068.715928200937, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [894.5706061090672, 905.9048799876012, 918.4443411735899, 923.5382308845577, 936.3211671538136, 17293.913530432346, 17974.37089701859, 18036.639267214647, 18084.186211620494, 18136.81863181368, 17111.22999465027, 17140.40008599696, 17265.654686906255, 17564.64870702585, 18408.35570755024, 915.1671978499584, 929.2983797233079, 930.3952430919888, 934.8924873639517, 937.9484128372936, 939.9389039712431, 943.6319835264252, 945.6170251048336, 946.0397696338188, 958.1759686669493, 979.7354714227155, 1009.6062535611118, 1011.246621267157, 1011.4184344002191, 1011.6004178349548, 992.1616234281984, 999.9700008999741, 1000.6247657128577, 1003.6888564544978, 1004.5780772075746, 714.3891972363658, 729.3399473476459, 737.8044818123202, 741.3772431157853, 749.1160430691782, 19450.513737156543, 19476.80523194764, 19551.511212219666, 19632.901835490873, 19674.40976770699, 21611.351659450243, 21653.566928661498, 21829.454263643376, 21898.0, 22043.66934495984, 17040.65918681632, 17383.73924391135, 17504.21231044606, 17691.0, 17929.0, 3793.2223894101644, 3802.049487628093, 3809.047738065484, 3819.751716138442, 3834.328992426342, 135461.0, 136093.3195334017, 138880.0, 139132.0, 141532.0, 16436.342546298016, 16488.6702265954, 16767.748483772753, 16905.661886762195, 16940.23768930401, 29049.0, 29542.852285738434, 29652.40695186084, 30851.0, 30932.69067309298, 8431.241188293083, 8499.065102838806, 8517.105703901125, 8540.871886921701, 8544.658213671384, 4174.937375939363, 4211.7051806373875, 4213.241616508996, 4240.469941257343, 4250.957490425118, 5323.707196104251, 5397.892042159135, 5445.401005889349, 5470.124780035176, 5475.945240547623, 944.9858252126223, 956.9569369378395, 974.8342781727123, 986.1962500562018, 991.7074463033423, 668.7325069971953, 692.9618870962045, 695.6626036372355, 696.3210869402292, 713.2617740638415, 10922.18083643714, 11582.826257606142, 11594.62295737341, 12384.504619815287, 13054.54309099177, 672.2302963107214, 688.6536820515879, 695.2977492732376, 705.5942832871119, 706.1631966120061, 5603.047481928082, 5616.5787565932715, 5642.858928526737, 5672.177534257509, 5702.657840529581, 115682.0, 115732.0, 116768.41615792036, 117967.0, 118334.0, 110824.44587777171, 111065.0, 113130.0, 114172.42913785377, 114452.0, 93353.0, 96651.0, 96794.0, 97866.51066744763, 99107.50446247867, 10544.736381590215, 10563.63027294041, 10590.523426445983, 10593.576256949636, 10605.151587873106, 35955.64044359523, 38886.222275554894, 42362.30550777935, 42992.35511467268, 44051.0, 58876.70561647164, 61042.38957610367, 78102.21897780949, 78766.60616697109, 80481.0, 19123.235070597577, 19298.035098244753, 19624.9018754911, 20127.597448050663, 20401.69397459069, 19675.0, 20483.180672772924, 20502.282420115225, 20613.690794637794, 20779.8961005194, 17731.11344432799, 17862.732059019385, 19572.706409403585, 19798.307059252857, 19896.0, 20118.094685738884, 20339.288124915558, 20494.69257961102, 20687.0, 20822.58354832925, 18909.338173163873, 18964.715529266796, 19055.52361190981, 19107.426777196706, 19286.8071319285, 12508.812367814307, 12579.0, 12679.112462127563, 12823.93588032054, 12898.419571119135, 13085.476580936656, 13811.51659691906, 14253.928730356281, 14509.274536273355, 14529.418823246951], "value": 9187.949496600515, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1452.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 106.0, 114.0, 112.0, 107.0, 106.0, 114.0, 115.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 123.0, 118.0, 119.0, 118.0, 151.0, 119.0, 117.0, 118.0], "value": 121.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 174.0, 166.0, 163.0, 162.0, 165.0, 168.0, 173.0, 162.0, 163.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 76.0, 79.0, 76.0, 74.0, 74.0, 77.0, 79.0, 80.0], "value": 77.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 86.0, 84.0, 79.0, 80.0, 80.0, 83.0, 88.0, 85.0, 87.0], "value": 83.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 119.0, 114.0, 113.0, 115.0, 127.0, 115.0, 119.0, 116.0, 115.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 151.0, 149.0, 148.0, 149.0, 152.0, 149.0, 153.0, 151.0, 150.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 101.0, 95.0, 102.0, 103.0, 95.0, 93.0, 102.0, 99.0], "value": 97.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 54.0, 61.0, 56.0, 54.0, 55.0, 56.0, 54.0, 55.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 38.0, 48.0, 44.0, 39.0, 43.0, 38.0, 38.0, 38.0, 46.0], "value": 41.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 81.0, 75.0, 75.0, 81.0, 74.0, 82.0, 77.0, 77.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 112.0, 110.0, 119.0, 117.0, 119.0, 121.0, 114.0, 110.0], "value": 115.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 169.0, 169.0, 169.0, 167.0, 172.0, 168.0, 167.0, 168.0, 177.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 65.0, 63.0, 64.0, 66.0, 78.0, 66.0, 66.0, 66.0], "value": 66.8, "unit": "score"}]}]} 17:28:59 INFO - Return code: 0 17:28:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:28:59 INFO - # TBPL SUCCESS # 17:28:59 INFO - Running post-action listener: _package_coverage_data 17:28:59 INFO - Running post-action listener: _resource_record_post_action 17:28:59 INFO - [mozharness: 2017-09-19 00:28:59.940125Z] Finished run-tests step (success) 17:28:59 INFO - Running post-run listener: _resource_record_post_run 17:29:00 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 341397504; Read time: 16; Write time: 185760 17:29:00 INFO - TinderboxPrint: CPU usage
13.3% 17:29:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:29:00 INFO - TinderboxPrint: I/O write bytes / time
341,397,504 / 185,760 17:29:00 INFO - TinderboxPrint: CPU idle
8,250.1 (86.7%) 17:29:00 INFO - TinderboxPrint: CPU user
1,202.1 (12.6%) 17:29:00 INFO - TinderboxPrint: Swap in / out
0 / 0 17:29:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10010624; Read time: 0; Write time: 656 17:29:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:29:00 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 331386880; Read time: 0; Write time: 185104 17:29:00 INFO - Running post-run listener: _upload_blobber_files 17:29:00 INFO - Blob upload gear active. 17:29:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:29:00 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 17:29:00 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'] 17:29:00 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 17:29:00 INFO - (blobuploader) - INFO - Open directory for files ... 17:29:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:29:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:29:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:01 INFO - (blobuploader) - INFO - Done attempting. 17:29:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:29:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:29:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:09 INFO - (blobuploader) - INFO - Done attempting. 17:29:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:29:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:29:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:10 INFO - (blobuploader) - INFO - Done attempting. 17:29:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:29:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:29:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:11 INFO - (blobuploader) - INFO - Done attempting. 17:29:11 INFO - (blobuploader) - INFO - Iteration through files over. 17:29:11 INFO - Return code: 0 17:29:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:29:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:29:11 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a80162a5c1107fce84315bf2f87c689e541f3150809ea7c8338c51fc393db1aa2cba26de1a2f45852619aab6ca1747d4f8cb5458ab013f1464181bca185d58b9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24c8aa7c3c3f670268ba5cc922fd8c1fa87c7a91ba90faaea2421aaf3ec55cfaec0a39400ee6045f5246abd40db4c4fb42a8493a24d7384a2ca3a020dff633a6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cde28d61d5489906723b96bc43234019f6c28293308f3167b0333ea99e662de5ce85a1d418907ba0ed87f53e48a42ee74a6f0cf981fdac37a2619b31b05f8a06", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/396ac70adc23fd4cf733eca1a8659ab2ae58f6ecb5cc0af1d93e844643bf58a6a78924878ae890659d3bfea856b9d1afc14b9aca57227f2503bc3133de5e344a"} 17:29:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:29:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:29:11 INFO - Contents: 17:29:11 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a80162a5c1107fce84315bf2f87c689e541f3150809ea7c8338c51fc393db1aa2cba26de1a2f45852619aab6ca1747d4f8cb5458ab013f1464181bca185d58b9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24c8aa7c3c3f670268ba5cc922fd8c1fa87c7a91ba90faaea2421aaf3ec55cfaec0a39400ee6045f5246abd40db4c4fb42a8493a24d7384a2ca3a020dff633a6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cde28d61d5489906723b96bc43234019f6c28293308f3167b0333ea99e662de5ce85a1d418907ba0ed87f53e48a42ee74a6f0cf981fdac37a2619b31b05f8a06", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/396ac70adc23fd4cf733eca1a8659ab2ae58f6ecb5cc0af1d93e844643bf58a6a78924878ae890659d3bfea856b9d1afc14b9aca57227f2503bc3133de5e344a"} 17:29:11 INFO - Running post-run listener: copy_logs_to_upload_dir 17:29:11 INFO - Copying logs to upload dir... 17:29:11 INFO - mkdir: /builds/slave/test/build/upload/logs 17:29:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.000769 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-09-18 17:29:11.177707) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 17:29:11.181523) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258 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/a80162a5c1107fce84315bf2f87c689e541f3150809ea7c8338c51fc393db1aa2cba26de1a2f45852619aab6ca1747d4f8cb5458ab013f1464181bca185d58b9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24c8aa7c3c3f670268ba5cc922fd8c1fa87c7a91ba90faaea2421aaf3ec55cfaec0a39400ee6045f5246abd40db4c4fb42a8493a24d7384a2ca3a020dff633a6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cde28d61d5489906723b96bc43234019f6c28293308f3167b0333ea99e662de5ce85a1d418907ba0ed87f53e48a42ee74a6f0cf981fdac37a2619b31b05f8a06", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/396ac70adc23fd4cf733eca1a8659ab2ae58f6ecb5cc0af1d93e844643bf58a6a78924878ae890659d3bfea856b9d1afc14b9aca57227f2503bc3133de5e344a"} build_url:https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/a63eNWFcTpOKhAf9s5Ef0A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a80162a5c1107fce84315bf2f87c689e541f3150809ea7c8338c51fc393db1aa2cba26de1a2f45852619aab6ca1747d4f8cb5458ab013f1464181bca185d58b9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24c8aa7c3c3f670268ba5cc922fd8c1fa87c7a91ba90faaea2421aaf3ec55cfaec0a39400ee6045f5246abd40db4c4fb42a8493a24d7384a2ca3a020dff633a6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cde28d61d5489906723b96bc43234019f6c28293308f3167b0333ea99e662de5ce85a1d418907ba0ed87f53e48a42ee74a6f0cf981fdac37a2619b31b05f8a06", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/396ac70adc23fd4cf733eca1a8659ab2ae58f6ecb5cc0af1d93e844643bf58a6a78924878ae890659d3bfea856b9d1afc14b9aca57227f2503bc3133de5e344a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 17:29:11.210224) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 17:29:11.210573) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1505761278.547571-1473702258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 17:29:11.296250) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 17:29:11.296593) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 17:29:11.296949) ========= ========= Total master_lag: 0.30 =========