builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1506115331.76 results: success (0) revision: 0a202bb2e249bfd06e3b705feb84561264c10516 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 14:22:11.756853) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 14:22:11.757288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 14:22:11.757886) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 14:22:11.955381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 14:22:11.955645) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-22 14:22:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-09-22 14:22:12 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163651 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 14:22:12.152995) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 14:22:12.153400) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018486 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 14:22:12.207344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-22 14:22:12.211854) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0a202bb2e249bfd06e3b705feb84561264c10516 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0a202bb2e249bfd06e3b705feb84561264c10516 --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=56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-22 14:22:12,174 truncating revision to first 12 chars 2017-09-22 14:22:12,175 Setting DEBUG logging. 2017-09-22 14:22:12,175 attempt 1/10 2017-09-22 14:22:12,175 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0a202bb2e249?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-22 14:22:13,039 unpacking tar archive at: mozilla-beta-0a202bb2e249/testing/mozharness/ program finished with exit code 0 elapsedTime=1.179346 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-22 14:22:13.407814) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 14:22:13.408127) ========= script_repo_revision: 0a202bb2e249bfd06e3b705feb84561264c10516 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 14:22:13.413582) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 14:22:13.414070) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 14:22:13.430402) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2017-09-22 14:22:13.430888) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:22:13 INFO - MultiFileLogger online at 20170922 14:22:13 in /builds/slave/test 14:22:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 14:22:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:22:13 INFO - {'append_to_log': False, 14:22:13 INFO - 'base_work_dir': '/builds/slave/test', 14:22:13 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 14:22:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:22:13 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 14:22:13 INFO - 'buildbot_json_path': 'buildprops.json', 14:22:13 INFO - 'code_coverage': False, 14:22:13 INFO - 'config_files': ('talos/linux_config.py',), 14:22:13 INFO - 'default_actions': ('clobber', 14:22:13 INFO - 'read-buildbot-config', 14:22:13 INFO - 'download-and-extract', 14:22:13 INFO - 'populate-webroot', 14:22:13 INFO - 'create-virtualenv', 14:22:13 INFO - 'install', 14:22:13 INFO - 'setup-mitmproxy', 14:22:13 INFO - 'run-tests'), 14:22:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:22:13 INFO - 'disable_ccov_upload': False, 14:22:13 INFO - 'disable_stylo': False, 14:22:13 INFO - 'download_minidump_stackwalk': True, 14:22:13 INFO - 'download_symbols': 'ondemand', 14:22:13 INFO - 'enable_stylo': False, 14:22:13 INFO - 'enable_webrender': False, 14:22:13 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 14:22:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:22:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:22:13 INFO - 'gecko_profile': False, 14:22:13 INFO - 'gecko_profile_interval': 0, 14:22:13 INFO - 'installer_path': 'installer.exe', 14:22:13 INFO - 'log_level': 'info', 14:22:13 INFO - 'log_name': 'talos', 14:22:13 INFO - 'log_to_console': True, 14:22:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:22:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:22:13 INFO - 'opt_config_files': (), 14:22:13 INFO - 'pip_index': False, 14:22:13 INFO - 'suite': 'dromaeojs-e10s', 14:22:13 INFO - 'system_bits': '32', 14:22:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:22:13 INFO - 'title': 'talos-linux64-ix-037', 14:22:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:22:13 INFO - 'use_talos_json': True, 14:22:13 INFO - 'verify': 'False', 14:22:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:22:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:22:13 INFO - 'work_dir': 'build'} 14:22:13 INFO - [mozharness: 2017-09-22 21:22:13.535707Z] Running clobber step. 14:22:13 INFO - Running pre-action listener: _resource_record_pre_action 14:22:13 INFO - Running main action method: clobber 14:22:13 INFO - rmtree: /builds/slave/test/build 14:22:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:22:15 INFO - Running post-action listener: _resource_record_post_action 14:22:15 INFO - [mozharness: 2017-09-22 21:22:15.043739Z] Finished clobber step (success) 14:22:15 INFO - [mozharness: 2017-09-22 21:22:15.043836Z] Running read-buildbot-config step. 14:22:15 INFO - Running pre-action listener: _resource_record_pre_action 14:22:15 INFO - Running main action method: read_buildbot_config 14:22:15 INFO - Using buildbot properties: 14:22:15 INFO - { 14:22:15 INFO - "project": "", 14:22:15 INFO - "product": "firefox", 14:22:15 INFO - "who": "ryanvm@gmail.com", 14:22:15 INFO - "installer_path": "public/build/target.tar.bz2", 14:22:15 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 14:22:15 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 14:22:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 14:22:15 INFO - "stage_platform": "linux64", 14:22:15 INFO - "basedir": "/builds/slave/test", 14:22:15 INFO - "buildnumber": 109, 14:22:15 INFO - "platform": "ubuntu64_hw", 14:22:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:22:15 INFO - "slavebuilddir": "test", 14:22:15 INFO - "taskId": "YN8De7fkSgudAFzj3KptTw", 14:22:15 INFO - "branch": "mozilla-beta", 14:22:15 INFO - "script_repo_revision": "production", 14:22:15 INFO - "revision": "0a202bb2e249bfd06e3b705feb84561264c10516", 14:22:15 INFO - "slavename": "talos-linux64-ix-037", 14:22:15 INFO - "repo_path": "releases/mozilla-beta" 14:22:15 INFO - } 14:22:15 INFO - Finding installer, test and symbols from parent task. 14:22:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YN8De7fkSgudAFzj3KptTw'}, attempt #1 14:22:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YN8De7fkSgudAFzj3KptTw'}, attempt #1 14:22:16 INFO - Task dependencies: HVyj_f7wQ8mtYJAdYYI9bA 14:22:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA'}, attempt #1 14:22:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.tar.bz2 14:22:16 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.test_packages.json 14:22:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.crashreporter-symbols.zip 14:22:16 INFO - Running post-action listener: _resource_record_post_action 14:22:16 INFO - [mozharness: 2017-09-22 21:22:16.717940Z] Finished read-buildbot-config step (success) 14:22:16 INFO - [mozharness: 2017-09-22 21:22:16.718247Z] Running download-and-extract step. 14:22:16 INFO - Running pre-action listener: _resource_record_pre_action 14:22:16 INFO - Running main action method: download_and_extract 14:22:16 INFO - mkdir: /builds/slave/test/build/tests 14:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:16 INFO - trying https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.test_packages.json 14:22:16 INFO - Downloading https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:22:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:22:17 INFO - Downloaded 989 bytes. 14:22:17 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:22:17 INFO - Using the following test package requirements: 14:22:17 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:22:17 INFO - u'common': [u'target.common.tests.zip'], 14:22:17 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:22:17 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:22:17 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:22:17 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:22:17 INFO - u'mozbase': [u'target.common.tests.zip'], 14:22:17 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:22:17 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:22:17 INFO - u'web-platform': [u'target.common.tests.zip', 14:22:17 INFO - u'target.web-platform.tests.tar.gz'], 14:22:17 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:22:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 14:22:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.common.tests.zip 14:22:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:22:17 INFO - Fetch https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.common.tests.zip into memory 14:22:18 INFO - Content-Length response header: 55184554 14:22:18 INFO - Bytes received: 55184554 14:22:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.talos.tests.zip 14:22:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:22:29 INFO - Fetch https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.talos.tests.zip into memory 14:22:29 INFO - Content-Length response header: 14509184 14:22:29 INFO - Bytes received: 14509184 14:22:30 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')]} 14:22:30 INFO - trying https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.tar.bz2 14:22:30 INFO - Downloading https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:22:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:22:31 INFO - Downloaded 53462381 bytes. 14:22:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.tar.bz2 14:22:31 INFO - mkdir: /builds/slave/test/properties 14:22:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:22:31 INFO - Writing to file /builds/slave/test/properties/build_url 14:22:31 INFO - Contents: 14:22:31 INFO - build_url:https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.tar.bz2 14:22:31 INFO - Running post-action listener: _resource_record_post_action 14:22:31 INFO - Running post-action listener: find_tests_for_verification 14:22:31 INFO - Running post-action listener: set_extra_try_arguments 14:22:31 INFO - [mozharness: 2017-09-22 21:22:31.186426Z] Finished download-and-extract step (success) 14:22:31 INFO - [mozharness: 2017-09-22 21:22:31.186524Z] Running populate-webroot step. 14:22:31 INFO - Running pre-action listener: _resource_record_pre_action 14:22:31 INFO - Running main action method: populate_webroot 14:22:31 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:22:31 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:22:31 INFO - 'tests': ['tresize', 14:22:31 INFO - 'tcanvasmark']}, 14:22:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:22:31 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:22:31 INFO - 'tests': ['dromaeo_css', 14:22:31 INFO - 'kraken']}, 14:22:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:22:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:22:31 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:22:31 INFO - 'talos_options': ['--disable-stylo'], 14:22:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:22:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:22:31 INFO - 'tests': ['damp', 'tps']}, 14:22:31 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:22:31 INFO - 'talos_options': ['--disable-stylo'], 14:22:31 INFO - 'tests': ['damp', 'tps']}, 14:22:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:22:31 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:22:31 INFO - 'tests': ['dromaeo_dom']}, 14:22:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:22:31 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:22:31 INFO - 'tests': ['basic_compositor_video', 14:22:31 INFO - 'glvideo']}, 14:22:31 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:22:31 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:22:31 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:22:31 INFO - 'talos_options': ['--disable-stylo'], 14:22:31 INFO - 'tests': ['ts_paint_webext', 14:22:31 INFO - 'tp5o_webext']}, 14:22:31 INFO - 'other-e10s': {'tests': ['a11yr', 14:22:31 INFO - 'ts_paint', 14:22:31 INFO - 'tpaint', 14:22:31 INFO - 'sessionrestore', 14:22:31 INFO - 'sessionrestore_many_windows', 14:22:31 INFO - 'sessionrestore_no_auto_restore', 14:22:31 INFO - 'tabpaint']}, 14:22:31 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:22:31 INFO - 'tests': ['a11yr', 14:22:31 INFO - 'ts_paint', 14:22:31 INFO - 'tpaint', 14:22:31 INFO - 'sessionrestore', 14:22:31 INFO - 'sessionrestore_many_windows', 14:22:31 INFO - 'sessionrestore_no_auto_restore', 14:22:31 INFO - 'tabpaint']}, 14:22:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:22:31 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 14:22:31 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:22:31 INFO - 'tests': ['perf_reftest_singletons']}, 14:22:31 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:22:31 INFO - 'tests': ['bloom_basic']}, 14:22:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:22:31 INFO - 'tsvgr_opacity', 14:22:31 INFO - 'tart', 14:22:31 INFO - 'tscrollx', 14:22:31 INFO - 'tsvg_static']}, 14:22:31 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:22:31 INFO - 'tests': ['tsvgx', 14:22:31 INFO - 'tsvgr_opacity', 14:22:31 INFO - 'tart', 14:22:31 INFO - 'tscrollx', 14:22:31 INFO - 'tsvg_static']}, 14:22:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:22:31 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:22:31 INFO - 'talos_options': ['--disable-stylo'], 14:22:31 INFO - 'tests': ['tp5o']}, 14:22:31 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:22:31 INFO - 'talos_options': ['--mitmproxy', 14:22:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:22:31 INFO - '--firstNonBlankPaint'], 14:22:31 INFO - 'tests': ['tp6_google', 14:22:31 INFO - 'tp6_youtube', 14:22:31 INFO - 'tp6_amazon', 14:22:31 INFO - 'tp6_facebook']}, 14:22:31 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:22:31 INFO - 'talos_options': ['--disable-stylo', 14:22:31 INFO - '--mitmproxy', 14:22:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:22:31 INFO - '--firstNonBlankPaint'], 14:22:31 INFO - 'tests': ['tp6_google', 14:22:31 INFO - 'tp6_youtube', 14:22:31 INFO - 'tp6_amazon', 14:22:31 INFO - 'tp6_facebook']}, 14:22:31 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:22:31 INFO - 'talos_options': ['--stylo-threads=1', 14:22:31 INFO - '--mitmproxy', 14:22:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:22:31 INFO - '--firstNonBlankPaint'], 14:22:31 INFO - 'tests': ['tp6_google', 14:22:31 INFO - 'tp6_youtube', 14:22:31 INFO - 'tp6_amazon', 14:22:31 INFO - 'tp6_facebook']}, 14:22:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:22:31 INFO - 'talos_options': ['--xperf_path', 14:22:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:22:31 INFO - 'tests': ['tp5n']}, 14:22:31 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:22:31 INFO - 'talos_options': ['--disable-stylo', 14:22:31 INFO - '--xperf_path', 14:22:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:22:31 INFO - 'tests': ['tp5n']}}} 14:22:31 INFO - Running post-action listener: _resource_record_post_action 14:22:31 INFO - [mozharness: 2017-09-22 21:22:31.201377Z] Finished populate-webroot step (success) 14:22:31 INFO - [mozharness: 2017-09-22 21:22:31.201467Z] Running create-virtualenv step. 14:22:31 INFO - Running pre-action listener: _resource_record_pre_action 14:22:31 INFO - Running main action method: create_virtualenv 14:22:31 INFO - Creating virtualenv /builds/slave/test/build/venv 14:22:31 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:22:31 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 14:22:31 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:22:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:22:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:22:32 INFO - Installing distribute.............................................................................................................................................................................................done. 14:22:32 INFO - Installing pip...............done. 14:22:32 INFO - Return code: 0 14:22:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:22:32 INFO - Reading from file tmpfile_stdout 14:22:32 INFO - Output received: 14:22:32 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 14:22:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:22:32 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')]} 14:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:32 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')]} 14:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:32 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 0x29581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7090>, '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 0x2cc7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', '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 14:22:32 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 14:22:32 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 14:22:32 INFO - Using env: {'DISPLAY': ':0', 14:22:32 INFO - 'HOME': '/home/cltbld', 14:22:32 INFO - 'LANG': 'en_US.UTF-8', 14:22:32 INFO - 'LANGUAGE': 'en_US:en', 14:22:32 INFO - 'LOGNAME': 'cltbld', 14:22:32 INFO - 'MAIL': '/var/mail/cltbld', 14:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:32 INFO - 'MOZ_NO_REMOTE': '1', 14:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:32 INFO - 'NO_EM_RESTART': '1', 14:22:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:32 INFO - 'PWD': '/builds/slave/test', 14:22:32 INFO - 'SHELL': '/bin/bash', 14:22:32 INFO - 'SHLVL': '1', 14:22:32 INFO - 'TERM': 'linux', 14:22:32 INFO - 'TMOUT': '86400', 14:22:32 INFO - 'USER': 'cltbld', 14:22:32 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', 14:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:32 INFO - '_': '/tools/buildbot/bin/python'} 14:22:33 INFO - Ignoring indexes: http://pypi.python.org/simple/ 14:22:33 INFO - Downloading/unpacking pip>=1.5 14:22:33 INFO - Running setup.py egg_info for package pip 14:22:33 INFO - warning: no files found matching 'pip/cacert.pem' 14:22:33 INFO - warning: no files found matching '*.html' under directory 'docs' 14:22:33 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:22:33 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:22:33 INFO - Installing collected packages: pip 14:22:33 INFO - Found existing installation: pip 1.1 14:22:33 INFO - Uninstalling pip: 14:22:33 INFO - Successfully uninstalled pip 14:22:33 INFO - Running setup.py install for pip 14:22:33 INFO - warning: no files found matching 'pip/cacert.pem' 14:22:33 INFO - warning: no files found matching '*.html' under directory 'docs' 14:22:33 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:22:33 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:22:33 INFO - Installing pip script to /builds/slave/test/build/venv/bin 14:22:33 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 14:22:33 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 14:22:33 INFO - Successfully installed pip 14:22:33 INFO - Cleaning up... 14:22:33 INFO - Return code: 0 14:22:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:22:33 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')]} 14:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:33 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')]} 14:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:33 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 0x29581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7090>, '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 0x2cc7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', '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 14:22:33 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 14:22:33 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 14:22:33 INFO - Using env: {'DISPLAY': ':0', 14:22:33 INFO - 'HOME': '/home/cltbld', 14:22:33 INFO - 'LANG': 'en_US.UTF-8', 14:22:33 INFO - 'LANGUAGE': 'en_US:en', 14:22:33 INFO - 'LOGNAME': 'cltbld', 14:22:33 INFO - 'MAIL': '/var/mail/cltbld', 14:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:33 INFO - 'MOZ_NO_REMOTE': '1', 14:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:33 INFO - 'NO_EM_RESTART': '1', 14:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:33 INFO - 'PWD': '/builds/slave/test', 14:22:33 INFO - 'SHELL': '/bin/bash', 14:22:33 INFO - 'SHLVL': '1', 14:22:33 INFO - 'TERM': 'linux', 14:22:33 INFO - 'TMOUT': '86400', 14:22:33 INFO - 'USER': 'cltbld', 14:22:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', 14:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:33 INFO - '_': '/tools/buildbot/bin/python'} 14:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:33 INFO - Downloading/unpacking psutil>=3.1.1 14:22:33 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 14:22:33 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 14:22:33 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 14:22:33 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 14:22:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:22:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:35 INFO - Installing collected packages: psutil 14:22:35 INFO - Running setup.py install for psutil 14:22:35 INFO - building 'psutil._psutil_linux' extension 14:22:35 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 14:22:35 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 14:22:35 INFO - building 'psutil._psutil_posix' extension 14:22:35 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 14:22:35 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 14:22:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:35 INFO - Successfully installed psutil 14:22:35 INFO - Cleaning up... 14:22:35 INFO - Return code: 0 14:22:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:22:35 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')]} 14:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:35 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')]} 14:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:35 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 0x29581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7090>, '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 0x2cc7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', '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 14:22:35 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 14:22:35 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 14:22:35 INFO - Using env: {'DISPLAY': ':0', 14:22:35 INFO - 'HOME': '/home/cltbld', 14:22:35 INFO - 'LANG': 'en_US.UTF-8', 14:22:35 INFO - 'LANGUAGE': 'en_US:en', 14:22:35 INFO - 'LOGNAME': 'cltbld', 14:22:35 INFO - 'MAIL': '/var/mail/cltbld', 14:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:35 INFO - 'MOZ_NO_REMOTE': '1', 14:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:35 INFO - 'NO_EM_RESTART': '1', 14:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:35 INFO - 'PWD': '/builds/slave/test', 14:22:35 INFO - 'SHELL': '/bin/bash', 14:22:35 INFO - 'SHLVL': '1', 14:22:35 INFO - 'TERM': 'linux', 14:22:35 INFO - 'TMOUT': '86400', 14:22:35 INFO - 'USER': 'cltbld', 14:22:35 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', 14:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:35 INFO - '_': '/tools/buildbot/bin/python'} 14:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:22:35 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 14:22:35 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 14:22:35 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 14:22:35 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 14:22:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:22:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:22:37 INFO - Installing collected packages: mozsystemmonitor 14:22:37 INFO - Running setup.py install for mozsystemmonitor 14:22:37 INFO - Successfully installed mozsystemmonitor 14:22:37 INFO - Cleaning up... 14:22:38 INFO - Return code: 0 14:22:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:38 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 0x29581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7090>, '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 0x2cc7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', '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 14:22:38 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 14:22:38 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 14:22:38 INFO - Using env: {'DISPLAY': ':0', 14:22:38 INFO - 'HOME': '/home/cltbld', 14:22:38 INFO - 'LANG': 'en_US.UTF-8', 14:22:38 INFO - 'LANGUAGE': 'en_US:en', 14:22:38 INFO - 'LOGNAME': 'cltbld', 14:22:38 INFO - 'MAIL': '/var/mail/cltbld', 14:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:38 INFO - 'MOZ_NO_REMOTE': '1', 14:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:38 INFO - 'NO_EM_RESTART': '1', 14:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:38 INFO - 'PWD': '/builds/slave/test', 14:22:38 INFO - 'SHELL': '/bin/bash', 14:22:38 INFO - 'SHLVL': '1', 14:22:38 INFO - 'TERM': 'linux', 14:22:38 INFO - 'TMOUT': '86400', 14:22:38 INFO - 'USER': 'cltbld', 14:22:38 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', 14:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:38 INFO - '_': '/tools/buildbot/bin/python'} 14:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:38 INFO - Downloading/unpacking jsonschema==2.5.1 14:22:38 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 14:22:38 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 14:22:38 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 14:22:38 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 14:22:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:22:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:22:40 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 14:22:40 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 14:22:40 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 14:22:40 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 14:22:40 INFO - Downloading functools32-3.2.3-2.tar.gz 14:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:22:40 INFO - warning: no files found matching '*.txt' 14:22:40 INFO - no previously-included directories found matching 'build' 14:22:40 INFO - no previously-included directories found matching 'dist' 14:22:40 INFO - no previously-included directories found matching '.git*' 14:22:40 INFO - Installing collected packages: jsonschema, functools32 14:22:40 INFO - Running setup.py install for functools32 14:22:40 INFO - warning: no files found matching '*.txt' 14:22:40 INFO - no previously-included directories found matching 'build' 14:22:40 INFO - no previously-included directories found matching 'dist' 14:22:40 INFO - no previously-included directories found matching '.git*' 14:22:40 INFO - Successfully installed jsonschema functools32 14:22:40 INFO - Cleaning up... 14:22:40 INFO - Return code: 0 14:22:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:22: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')]} 14:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22: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')]} 14:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:40 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 0x29581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7090>, '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 0x2cc7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', '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 14:22:40 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 14:22:40 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 14:22:40 INFO - Using env: {'DISPLAY': ':0', 14:22:40 INFO - 'HOME': '/home/cltbld', 14:22:40 INFO - 'LANG': 'en_US.UTF-8', 14:22:40 INFO - 'LANGUAGE': 'en_US:en', 14:22:40 INFO - 'LOGNAME': 'cltbld', 14:22:40 INFO - 'MAIL': '/var/mail/cltbld', 14:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:40 INFO - 'MOZ_NO_REMOTE': '1', 14:22:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:40 INFO - 'NO_EM_RESTART': '1', 14:22:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:40 INFO - 'PWD': '/builds/slave/test', 14:22:40 INFO - 'SHELL': '/bin/bash', 14:22:40 INFO - 'SHLVL': '1', 14:22:40 INFO - 'TERM': 'linux', 14:22:40 INFO - 'TMOUT': '86400', 14:22:40 INFO - 'USER': 'cltbld', 14:22:40 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', 14:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:40 INFO - '_': '/tools/buildbot/bin/python'} 14:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:22:40 INFO - Cleaning up... 14:22:40 INFO - Return code: 0 14:22:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:22: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')]} 14:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22: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')]} 14:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:40 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 0x29581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7090>, '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 0x2cc7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', '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 14:22:40 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 14:22:40 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 14:22:40 INFO - Using env: {'DISPLAY': ':0', 14:22:40 INFO - 'HOME': '/home/cltbld', 14:22:40 INFO - 'LANG': 'en_US.UTF-8', 14:22:40 INFO - 'LANGUAGE': 'en_US:en', 14:22:40 INFO - 'LOGNAME': 'cltbld', 14:22:40 INFO - 'MAIL': '/var/mail/cltbld', 14:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:40 INFO - 'MOZ_NO_REMOTE': '1', 14:22:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:40 INFO - 'NO_EM_RESTART': '1', 14:22:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:40 INFO - 'PWD': '/builds/slave/test', 14:22:40 INFO - 'SHELL': '/bin/bash', 14:22:40 INFO - 'SHLVL': '1', 14:22:40 INFO - 'TERM': 'linux', 14:22:40 INFO - 'TMOUT': '86400', 14:22:40 INFO - 'USER': 'cltbld', 14:22:40 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', 14:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:40 INFO - '_': '/tools/buildbot/bin/python'} 14:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:41 INFO - Downloading/unpacking blobuploader==1.2.4 14:22:41 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 14:22:41 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 14:22:41 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 14:22:41 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 14:22:42 INFO - Downloading blobuploader-1.2.4.tar.gz 14:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:22:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:22:42 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 14:22:42 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 14:22:42 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 14:22:42 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 14:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:22:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:22:42 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 14:22:42 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 14:22:42 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 14:22:42 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 14:22:42 INFO - Downloading docopt-0.6.1.tar.gz 14:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:22:42 INFO - Installing collected packages: blobuploader, requests, docopt 14:22:42 INFO - Running setup.py install for blobuploader 14:22:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:22:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:22:42 INFO - Running setup.py install for requests 14:22:43 INFO - Running setup.py install for docopt 14:22:43 INFO - Successfully installed blobuploader requests docopt 14:22:43 INFO - Cleaning up... 14:22:43 INFO - Return code: 0 14:22:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:43 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 0x29581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7090>, '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 0x2cc7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', '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 14:22:43 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 14:22:43 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 14:22:43 INFO - Using env: {'DISPLAY': ':0', 14:22:43 INFO - 'HOME': '/home/cltbld', 14:22:43 INFO - 'LANG': 'en_US.UTF-8', 14:22:43 INFO - 'LANGUAGE': 'en_US:en', 14:22:43 INFO - 'LOGNAME': 'cltbld', 14:22:43 INFO - 'MAIL': '/var/mail/cltbld', 14:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:43 INFO - 'MOZ_NO_REMOTE': '1', 14:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:43 INFO - 'NO_EM_RESTART': '1', 14:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:43 INFO - 'PWD': '/builds/slave/test', 14:22:43 INFO - 'SHELL': '/bin/bash', 14:22:43 INFO - 'SHLVL': '1', 14:22:43 INFO - 'TERM': 'linux', 14:22:43 INFO - 'TMOUT': '86400', 14:22:43 INFO - 'USER': 'cltbld', 14:22:43 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', 14:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:43 INFO - '_': '/tools/buildbot/bin/python'} 14:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:43 INFO - Running setup.py (path:/tmp/pip-gs_vWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:43 INFO - Running setup.py (path:/tmp/pip-A795OB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:43 INFO - Running setup.py (path:/tmp/pip-nMOUDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:43 INFO - Running setup.py (path:/tmp/pip-Izaomh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:43 INFO - Running setup.py (path:/tmp/pip-WsSckb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:43 INFO - Running setup.py (path:/tmp/pip-vr8YjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:44 INFO - Running setup.py (path:/tmp/pip-UC_X5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:44 INFO - Running setup.py (path:/tmp/pip-vfOcuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:44 INFO - Running setup.py (path:/tmp/pip-gvk7mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:44 INFO - Running setup.py (path:/tmp/pip-OMBiQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:44 INFO - Running setup.py (path:/tmp/pip-EiGpSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:44 INFO - Running setup.py (path:/tmp/pip-sTgjb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:44 INFO - Running setup.py (path:/tmp/pip-9fm39f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:44 INFO - Running setup.py (path:/tmp/pip-Uo_FAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:44 INFO - Running setup.py (path:/tmp/pip-O48gFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:44 INFO - Running setup.py (path:/tmp/pip-YNoo6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:44 INFO - Running setup.py (path:/tmp/pip-KIN22o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:22:44 INFO - Running setup.py install for manifestparser 14:22:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:22:44 INFO - Running setup.py install for mozcrash 14:22:45 INFO - Running setup.py install for mozdebug 14:22:45 INFO - Running setup.py install for mozdevice 14:22:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:22:45 INFO - Running setup.py install for mozfile 14:22:45 INFO - Running setup.py install for mozhttpd 14:22:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:22:45 INFO - Running setup.py install for mozinfo 14:22:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:22:45 INFO - Running setup.py install for mozInstall 14:22:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:22:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:22:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:22:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:22:45 INFO - Running setup.py install for mozleak 14:22:45 INFO - Running setup.py install for mozlog 14:22:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:22:45 INFO - Running setup.py install for moznetwork 14:22:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:22:45 INFO - Running setup.py install for mozprocess 14:22:46 INFO - Running setup.py install for mozprofile 14:22:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:22:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:22:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:22:46 INFO - Running setup.py install for mozrunner 14:22:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:22:46 INFO - Running setup.py install for mozscreenshot 14:22:46 INFO - Running setup.py install for moztest 14:22:46 INFO - Running setup.py install for mozversion 14:22:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:22:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:22:46 INFO - Cleaning up... 14:22:46 INFO - Return code: 0 14:22:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:46 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 0x29581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7090>, '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 0x2cc7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', '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 14:22:46 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 14:22:46 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 14:22:46 INFO - Using env: {'DISPLAY': ':0', 14:22:46 INFO - 'HOME': '/home/cltbld', 14:22:46 INFO - 'LANG': 'en_US.UTF-8', 14:22:46 INFO - 'LANGUAGE': 'en_US:en', 14:22:46 INFO - 'LOGNAME': 'cltbld', 14:22:46 INFO - 'MAIL': '/var/mail/cltbld', 14:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:46 INFO - 'MOZ_NO_REMOTE': '1', 14:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:46 INFO - 'NO_EM_RESTART': '1', 14:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:46 INFO - 'PWD': '/builds/slave/test', 14:22:46 INFO - 'SHELL': '/bin/bash', 14:22:46 INFO - 'SHLVL': '1', 14:22:46 INFO - 'TERM': 'linux', 14:22:46 INFO - 'TMOUT': '86400', 14:22:46 INFO - 'USER': 'cltbld', 14:22:46 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', 14:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:46 INFO - '_': '/tools/buildbot/bin/python'} 14:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:46 INFO - Running setup.py (path:/tmp/pip-Qn_Srr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:46 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)) 14:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:46 INFO - Running setup.py (path:/tmp/pip-7b21BG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:46 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)) 14:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:46 INFO - Running setup.py (path:/tmp/pip-5mzOjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:47 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)) 14:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:47 INFO - Running setup.py (path:/tmp/pip-jhaF8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:47 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)) 14:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:47 INFO - Running setup.py (path:/tmp/pip-w_Sggz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:47 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)) 14:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:47 INFO - Running setup.py (path:/tmp/pip-VZKOIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:47 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)) 14:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:47 INFO - Running setup.py (path:/tmp/pip-OFaSK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:47 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)) 14:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:47 INFO - Running setup.py (path:/tmp/pip-VhkX4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:47 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)) 14:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:47 INFO - Running setup.py (path:/tmp/pip-wowpEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:47 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)) 14:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:47 INFO - Running setup.py (path:/tmp/pip-sUck7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:47 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)) 14:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:47 INFO - Running setup.py (path:/tmp/pip-8yScsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:47 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)) 14:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:47 INFO - Running setup.py (path:/tmp/pip-KAH9yR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:47 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)) 14:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:47 INFO - Running setup.py (path:/tmp/pip-LD_wt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:47 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)) 14:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:47 INFO - Running setup.py (path:/tmp/pip-fZx2xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:47 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)) 14:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:47 INFO - Running setup.py (path:/tmp/pip-mx4smB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:47 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)) 14:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:47 INFO - Running setup.py (path:/tmp/pip-CvN1uF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:48 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)) 14:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:48 INFO - Running setup.py (path:/tmp/pip-fKsH3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:48 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)) 14:22:48 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)) 14:22:48 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)) 14:22:48 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)) 14:22:48 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)) 14:22:48 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)) 14:22:48 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)) 14:22:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:22:48 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 14:22:48 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 14:22:48 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 14:22:48 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 14:22:49 INFO - Downloading blessings-1.6.tar.gz 14:22:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:22:49 INFO - Installing collected packages: blessings 14:22:49 INFO - Running setup.py install for blessings 14:22:49 INFO - Successfully installed blessings 14:22:49 INFO - Cleaning up... 14:22:49 INFO - Return code: 0 14:22:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:22:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:49 INFO - Reading from file tmpfile_stdout 14:22:49 INFO - Current package versions: 14:22:49 INFO - argparse == 1.2.1 14:22:49 INFO - blessings == 1.6 14:22:49 INFO - blobuploader == 1.2.4 14:22:49 INFO - docopt == 0.6.1 14:22:49 INFO - functools32 == 3.2.3-2 14:22:49 INFO - jsonschema == 2.5.1 14:22:49 INFO - manifestparser == 1.1 14:22:49 INFO - mozInstall == 1.13 14:22:49 INFO - mozcrash == 1.0 14:22:49 INFO - mozdebug == 0.1 14:22:49 INFO - mozdevice == 0.51 14:22:49 INFO - mozfile == 1.2 14:22:49 INFO - mozhttpd == 0.7 14:22:49 INFO - mozinfo == 0.10 14:22:49 INFO - mozleak == 0.1 14:22:49 INFO - mozlog == 3.5 14:22:49 INFO - moznetwork == 0.27 14:22:49 INFO - mozprocess == 0.25 14:22:49 INFO - mozprofile == 0.28 14:22:49 INFO - mozrunner == 6.13 14:22:49 INFO - mozscreenshot == 0.1 14:22:49 INFO - mozsystemmonitor == 0.3 14:22:49 INFO - moztest == 0.8 14:22:49 INFO - mozversion == 1.4 14:22:49 INFO - psutil == 3.1.1 14:22:49 INFO - requests == 1.2.3 14:22:49 INFO - wsgiref == 0.1.2 14:22:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22: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')]} 14:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22: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')]} 14:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:49 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 0x29581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7090>, '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 0x2cc7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', '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 14:22:49 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 14:22:49 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 14:22:49 INFO - Using env: {'DISPLAY': ':0', 14:22:49 INFO - 'HOME': '/home/cltbld', 14:22:49 INFO - 'LANG': 'en_US.UTF-8', 14:22:49 INFO - 'LANGUAGE': 'en_US:en', 14:22:49 INFO - 'LOGNAME': 'cltbld', 14:22:49 INFO - 'MAIL': '/var/mail/cltbld', 14:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:49 INFO - 'MOZ_NO_REMOTE': '1', 14:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:49 INFO - 'NO_EM_RESTART': '1', 14:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:49 INFO - 'PWD': '/builds/slave/test', 14:22:49 INFO - 'SHELL': '/bin/bash', 14:22:49 INFO - 'SHLVL': '1', 14:22:49 INFO - 'TERM': 'linux', 14:22:49 INFO - 'TMOUT': '86400', 14:22:49 INFO - 'USER': 'cltbld', 14:22:49 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', 14:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:49 INFO - '_': '/tools/buildbot/bin/python'} 14:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:49 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)) 14:22:49 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)) 14:22:49 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)) 14:22:49 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)) 14:22:49 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)) 14:22:49 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)) 14:22:49 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)) 14:22:49 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)) 14:22:49 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)) 14:22:49 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:22: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 14:22: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 14:22: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 14:22: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 14:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:22:51 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)) 14:22:51 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)) 14:22:51 INFO - Installing collected packages: simplejson 14:22:51 INFO - Running setup.py install for simplejson 14:22:51 INFO - building 'simplejson._speedups' extension 14:22:51 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 14:22:51 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 14:22:52 INFO - Successfully installed simplejson 14:22:52 INFO - Cleaning up... 14:22:52 INFO - Return code: 0 14:22:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:22:52 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')]} 14:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:52 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')]} 14:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:52 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 0x29581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc7090>, '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 0x2cc7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', '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 14:22:52 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 14:22:52 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 14:22:52 INFO - Using env: {'DISPLAY': ':0', 14:22:52 INFO - 'HOME': '/home/cltbld', 14:22:52 INFO - 'LANG': 'en_US.UTF-8', 14:22:52 INFO - 'LANGUAGE': 'en_US:en', 14:22:52 INFO - 'LOGNAME': 'cltbld', 14:22:52 INFO - 'MAIL': '/var/mail/cltbld', 14:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:52 INFO - 'MOZ_NO_REMOTE': '1', 14:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:52 INFO - 'NO_EM_RESTART': '1', 14:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:52 INFO - 'PWD': '/builds/slave/test', 14:22:52 INFO - 'SHELL': '/bin/bash', 14:22:52 INFO - 'SHLVL': '1', 14:22:52 INFO - 'TERM': 'linux', 14:22:52 INFO - 'TMOUT': '86400', 14:22:52 INFO - 'USER': 'cltbld', 14:22:52 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', 14:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:52 INFO - '_': '/tools/buildbot/bin/python'} 14:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:22:52 INFO - Cleaning up... 14:22:52 INFO - Return code: 0 14:22:52 INFO - Running post-action listener: _resource_record_post_action 14:22:52 INFO - Running post-action listener: _start_resource_monitoring 14:22:52 INFO - Starting resource monitoring. 14:22:52 INFO - [mozharness: 2017-09-22 21:22:52.322374Z] Finished create-virtualenv step (success) 14:22:52 INFO - [mozharness: 2017-09-22 21:22:52.322894Z] Running install step. 14:22:52 INFO - Running pre-action listener: _resource_record_pre_action 14:22:52 INFO - Running main action method: install 14:22:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:52 INFO - Reading from file tmpfile_stdout 14:22:52 INFO - Detecting whether we're running mozinstall >=1.0... 14:22:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:22:52 INFO - Reading from file tmpfile_stdout 14:22:52 INFO - Output received: 14:22:52 INFO - Usage: mozinstall [options] installer 14:22:52 INFO - Options: 14:22:52 INFO - -h, --help show this help message and exit 14:22:52 INFO - -d DEST, --destination=DEST 14:22:52 INFO - Directory to install application into. [default: 14:22:52 INFO - "/builds/slave/test"] 14:22:52 INFO - --app=APP Application being installed. [default: firefox] 14:22:52 INFO - mkdir: /builds/slave/test/build/application 14:22:52 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'] 14:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:23:07 INFO - Reading from file tmpfile_stdout 14:23:07 INFO - Output received: 14:23:07 INFO - /builds/slave/test/build/application/firefox/firefox 14:23:07 INFO - Running post-action listener: _resource_record_post_action 14:23:07 INFO - [mozharness: 2017-09-22 21:23:07.306269Z] Finished install step (success) 14:23:07 INFO - [mozharness: 2017-09-22 21:23:07.306520Z] Running setup-mitmproxy step. 14:23:07 INFO - Running pre-action listener: _resource_record_pre_action 14:23:07 INFO - Running main action method: setup_mitmproxy 14:23:07 INFO - Skipping: mitmproxy is not required 14:23:07 INFO - Running post-action listener: _resource_record_post_action 14:23:07 INFO - [mozharness: 2017-09-22 21:23:07.307643Z] Finished setup-mitmproxy step (success) 14:23:07 INFO - [mozharness: 2017-09-22 21:23:07.307862Z] Running run-tests step. 14:23:07 INFO - Running pre-action listener: _resource_record_pre_action 14:23:07 INFO - Running pre-action listener: _set_gcov_prefix 14:23:07 INFO - Running main action method: run_tests 14:23:07 WARNING - Try message not found. 14:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:23:07 INFO - Python 2.7.3 14:23:07 INFO - Return code: 0 14:23:07 INFO - grabbing minidump binary from tooltool 14:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:07 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 0x2cc7090>, '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 0x2cc7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:23:07 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 14:23:07 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 14:23:07 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 14:23:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:23:07 INFO - Return code: 0 14:23:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:23:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:23:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:23:07 INFO - ENV: RUST_BACKTRACE is now full 14:23:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:23:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 14:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 14:23:07 INFO - Using env: {'DISPLAY': ':0', 14:23:07 INFO - 'HOME': '/home/cltbld', 14:23:07 INFO - 'LANG': 'en_US.UTF-8', 14:23:07 INFO - 'LANGUAGE': 'en_US:en', 14:23:07 INFO - 'LOGNAME': 'cltbld', 14:23:07 INFO - 'MAIL': '/var/mail/cltbld', 14:23:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:23:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:07 INFO - 'MOZ_NO_REMOTE': '1', 14:23:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:07 INFO - 'NO_EM_RESTART': '1', 14:23:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:07 INFO - 'PWD': '/builds/slave/test', 14:23:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:23:07 INFO - 'RUST_BACKTRACE': 'full', 14:23:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:23:07 INFO - 'SHELL': '/bin/bash', 14:23:07 INFO - 'SHLVL': '1', 14:23:07 INFO - 'TERM': 'linux', 14:23:07 INFO - 'TMOUT': '86400', 14:23:07 INFO - 'USER': 'cltbld', 14:23:07 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', 14:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:07 INFO - '_': '/tools/buildbot/bin/python'} 14:23:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 14:23:07 INFO - mozversion application_buildid: 20170922200127 14:23:07 INFO - mozversion application_changeset: 0a202bb2e249bfd06e3b705feb84561264c10516 14:23:07 INFO - mozversion application_display_name: Firefox 14:23:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:23:07 INFO - mozversion application_name: Firefox 14:23:07 INFO - mozversion application_remotingname: firefox 14:23:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:23:07 INFO - mozversion application_vendor: Mozilla 14:23:07 INFO - mozversion application_version: 57.0 14:23:07 INFO - mozversion platform_buildid: 20170922200127 14:23:07 INFO - mozversion platform_changeset: 0a202bb2e249bfd06e3b705feb84561264c10516 14:23:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:23:07 INFO - mozversion platform_version: 57.0 14:23:07 INFO - using testdate: 1506115387 14:23:07 INFO - actual date: 1506115387 14:23:07 INFO - starting webserver on 'localhost:57169' 14:23:07 INFO - SUITE-START | Running 2 tests 14:23:07 INFO - TEST-START | dromaeo_css 14:23:07 INFO - Initialising browser for dromaeo_css test... 14:23:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57169/getInfo.html -profile /tmp/tmpojxB2a/profile 14:23:07 INFO - TEST-INFO | started process 29888 (/builds/slave/test/build/application/firefox/firefox http://localhost:57169/getInfo.html) 14:23:13 INFO - TEST-INFO | 29888: exit 0 14:23:13 INFO - Browser initialized. 14:23:13 INFO - Running cycle 1/1 for dromaeo_css test... 14:23:13 INFO - Using env: {'DISPLAY': ':0', 14:23:13 INFO - 'HOME': '/home/cltbld', 14:23:13 INFO - 'JSGC_DISABLE_POISONING': '1', 14:23:13 INFO - 'LANG': 'en_US.UTF-8', 14:23:13 INFO - 'LANGUAGE': 'en_US:en', 14:23:13 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:23:13 INFO - 'LOGNAME': 'cltbld', 14:23:13 INFO - 'MAIL': '/var/mail/cltbld', 14:23:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:23:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:23:13 INFO - 'MOZ_CRASHREPORTER': '1', 14:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:13 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:23:13 INFO - 'MOZ_NO_REMOTE': '1', 14:23:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:13 INFO - 'NO_EM_RESTART': '1', 14:23:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:13 INFO - 'PWD': '/builds/slave/test', 14:23:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:23:13 INFO - 'RUST_BACKTRACE': 'full', 14:23:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:23:13 INFO - 'SHELL': '/bin/bash', 14:23:13 INFO - 'SHLVL': '1', 14:23:13 INFO - 'TERM': 'linux', 14:23:13 INFO - 'TMOUT': '86400', 14:23:13 INFO - 'USER': 'cltbld', 14:23:13 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', 14:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:13 INFO - '_': '/tools/buildbot/bin/python'} 14:23:13 INFO - TEST-INFO | started process 30081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpojxB2a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:23:24 INFO - PID 30081 | RSS: Main: 143613952 14:23:24 INFO - PID 30081 | 14:26:21 INFO - PID 30081 | Cycle 1(1): loaded http://localhost:57169/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57169/tests/dromaeo/cssquery-ext.html) 14:26:22 INFO - PID 30081 | RSS: Main: 147415040 14:26:22 INFO - PID 30081 | 14:29:24 INFO - PID 30081 | Cycle 1(1): loaded http://localhost:57169/tests/dromaeo/cssquery-ext.html (next: http://localhost:57169/tests/dromaeo/cssquery-jquery.html) 14:29:24 INFO - PID 30081 | RSS: Main: 145772544 14:29:24 INFO - PID 30081 | 14:32:26 INFO - PID 30081 | Cycle 1(1): loaded http://localhost:57169/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57169/tests/dromaeo/cssquery-mootools.html) 14:32:27 INFO - PID 30081 | RSS: Main: 147034112 14:32:27 INFO - PID 30081 | 14:35:28 INFO - PID 30081 | Cycle 1(1): loaded http://localhost:57169/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57169/tests/dromaeo/cssquery-prototype.html) 14:35:29 INFO - PID 30081 | RSS: Main: 146501632 14:35:29 INFO - PID 30081 | 14:38:31 INFO - PID 30081 | Cycle 1(1): loaded http://localhost:57169/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57169/tests/dromaeo/cssquery-yui.html) 14:38:32 INFO - PID 30081 | RSS: Main: 148377600 14:38:32 INFO - PID 30081 | 14:41:33 INFO - PID 30081 | Cycle 1(1): loaded http://localhost:57169/tests/dromaeo/cssquery-yui.html (next: http://localhost:57169/tests/dromaeo/cssquery-dojo.html) 14:41:34 INFO - PID 30081 | RSS: Main: 151556096 14:41:34 INFO - PID 30081 | 14:41:34 INFO - PID 30081 | __start_tp_report 14:41:34 INFO - PID 30081 | _x_x_mozilla_page_load 14:41:34 INFO - PID 30081 | _x_x_mozilla_page_load_details 14:41:34 INFO - PID 30081 | |i|pagename|runs| 14:41:34 INFO - PID 30081 | |0;dojo.html;4010.819513121909;4043.353063509839;4048.9190216195693;4049.8987525311863;4064.8170832312544;6505.544611877171;6527.706253218611;6532.673366331688;6622.503312251589;6640.468762499;6588.736450541985;6594.241662208848;6647.734090636381;6657.866842663144;6682.6992785324655;5892.057270836667;5905;5910.763569457238;5963.2247807784925;5972.343042265347;5832.066869300913;5851.268591426072;5915.704214789265;5956.076808094752;6010.188624535697;5891.970540147315;5917.497012753921;5919.052951527757;5988.461038506533;6012.338642749294;5828.766849326022;5989.700514974255;5999.550033747487;6005.579609427342;6012.098185272201;5798.391168927286;5852.590318677694;5888.322842873039;5918.112283157518;5985.162077309136;6415.262244841856;6503.804885853385;6516.055172000081;6517.771877984248;6542.4111829935055;7098.787036388865;7180.31786980236;7193.424526037905;7196.316349946746;7197.100362454693;7160.928390716131;7167.319104685047;7187.389071928892;7198.928010719878;7278.053852999076;6568.441682456997;6605.834854128685;6634.867302654016;6635.734570617218;6689.5986240825705;7194.712211511481;7205.243449437734;7303.561786292733;7358.77923662291;7378.704851805867;6956.826079347956;6969.6166710830375;7037.120359955005;7040;7054.894176587355;7066.364027237573;7070.1515818101125;7152.356287934007;7155.499115061895;7172.390346820579;6987.89518157228;6991.650417479207;7027.086478757728;7046.823829404306;7085.787426377217;7012.754553590702;7041.683124259421;7042.401395881408;7052.224255331909;7057.435405167575;5273.3935597406025;5347.705876176769;5351.464853514617;5356.0894647909945;5357.973210134002;4816.325714399987;4841.515848415201;4850.781714822841;4876.609871210295;4897.730624815669;6582.868342633121;6617.33826617344;6632.1709786276715;6634.038064480624;6651.33486651331;7108.253633368526;7111.715531378687;7176.569405835667;7189.173245076883;7199.496035277481;6553.639549824806;6573.211214654272;6602.7689030883685;6672.599644021374;6682;6070.696465176724;6107.6640784757265;6120.17377654011;6128.387161283925;6149.354317796567;7356.889646655304;7364.484486086029;7452.478326517092;7452.701891924262;7457.47797654159;6970.546914450544;7085.999999999897;7088;7175.748848790267;7178.102737157856;7329.9267007329245;7352;7371.815704607213;7374.741884034033;7438.6652600632015;6979.825504362431;6999.545029573062;7066.57600543969;7076.893846592408;7087.751928682472;7109.928900710926;7111.075560177143;7116.323949224816;7201.387882030086;7205.855882882208;6750.5274630775375;6861.897071544031;6864.073350097673;6871.175458944758;6934.687939042856;6826.146731658543;6827.761028363983;6835.658217089026;6855.965720171367;6906.585604863724;6770.52606317553;6846.4522838173825;6861.931380686329;6875.278095799869;6879.346462086094;6874.725010999504;6889.173299204128;6895.103636527219;6929.099217101744;6985.5808651481075;6600.042993765973;6626.900596491153;6686.866262674622;6689.832754181184;6698.363655452724 14:41:34 INFO - PID 30081 | |1;ext.html;978.8923218445972;989.6338354808722;1003.3377970539443;1005.2661557063349;1008.3042700536629;45496.54503454969;45817;46081.30878036832;46119.077618447656;46230.30654540181;43878.34182487265;43950.560494395046;44287.77856110715;44303.55696443035;44388;8074.71738489153;8217.835643287131;8221.136780638006;8227.588620568977;8234.135415781346;7950.920490795104;7971.561564113971;8021.438499305051;8023.919760802376;8036.236557527055;8854.335924805666;9002.964659064193;9003.369764116514;9005.369624126313;9053.185213330798;8944.910550894505;8973.685920992733;9002.369834111614;9007.324450666194;9011.143941325563;8804.207621314048;8820.117988201193;8852.203301702877;8861.867071993925;8878.778030549223;41318;41579.58420415787;41614.79192604048;41736.16527669429;41755.58244417578;3855.768653880776;3883.456316115746;3890.105275786557;3894.9610503894883;3901.473301104343;33156;33273.500897486556;33365.332693346;33390.332193356;33408;5607.355154157283;5624.718764061821;5625.1843482695185;5686.516646085088;5704.344000439961;223565;224289;225268;225739;226580.8670956651;47800.521994780305;48948.75525622349;54653.45346546563;55056;55261.72369138129;57596.71201643965;57826.42173578295;57943.71028144832;58048.709756450946;58113.70943145342;19015.33446329372;19015.33446329372;19023.52441188981;19148.329808456638;19149.138288777038;15584;15757.68484630301;15774.211289435712;15785.763213551805;15796.289166987513;15695.529134125994;15758.290876910567;15815.920920395325;15823.920880395524;15828.76256856148;6170.7223174957235;6255.624662520263;6269.498440124779;6277.2153480814895;6295.464885484785;1125.178619607691;1129.6836885672026;1135.8864113588575;1146.4210573660248;1151.1308961733837;25966.610500842504;25991.480170396488;26297.21108366752;26548.867255663983;26608.20175394741;1244.3902487780922;1252.1673087396962;1256.5790460195938;1264.5574049082747;1271.510468469646;13730.862691373159;13924.37340319688;14025.948053895998;14153.009289349853;14252.358643860844;296374;323802;324643;327868;328422.35788820905;65555.67222163858;65863;66202;66417;66566;1546.9922650386677;1560.8985415947927;1561.7813506109153;1583.0422594330494;1587.928543215558;30747.53878691777;30987.535186972666;31078;31247.531287031168;31361.843190784813;44256.11487770162;44475.555244448435;44540;44835.55164448314;44900.326495103254;260005;264808;265054;265714;265827;37853.43219851649;38191;38291;38401.23197535978;38756.80621596874;48235.5176448231;49025;49309.753451232515;49697.75151124221;49711.25433118434;34793;35099;35304.64695353014;35484.82257588695;35685.28629427449;32754.83622581872;32858.835705821315;32888.67111328856;33032.83483582567;33734.49398258979;41463.37804932989;41863;41987.580124198365;42098.36852447277;42149.36775948302;34041.659583403845;34140.829295853364;34221.657783422845;34227.657723422446;34336;25602.551158117403;25737.485250294514;25805;26086;26167.869160654074 14:41:34 INFO - PID 30081 | |2;jquery.html;643.5403535064133;643.5931669576528;644.7231135696991;647.2715092164759;657.8815813153633;23998.16006439775;24622.138225162143;24646.753532464714;24656.630150547757;24666.876665616648;26828.329291767717;27194.5920811188;27209;27210.863945680292;27212.04757833476;6384.968075159618;6692.263850976401;6727.495437842157;6744.629045402501;6748.190217173946;6704.765333213339;6742.494312926526;6798.116244888182;6800.047993280945;6801.557898736566;6726.899096513556;6729.461643068567;6768.966155169217;7027.648617569127;7033.156021277454;6976.651167441608;7022.859542809167;7023.157221133446;7029.578225306473;7043.788686339418;6577.769778057793;6585.374389433044;6596.637184954826;6600.141981542417;6622.801315960529;29934.101976940725;31119.06642800697;31188.376232475224;31588.210294742585;31592.684073159206;2421.721502027272;2427.538767634144;2432.0879670123704;2432.70807503099;2461.655368248447;21573.137074517;21715.674264886038;21770.564588708137;21800;21972.560548788933;2602.2973797074874;2642.5903984882375;2670.6661667291587;2699.4601079783924;2700.9324766880986;145278;151950.24024879804;161880;166304.16847915805;167091.1645441777;16639.6672066558;17014.404495842587;17045.40341088056;17115.74326385105;17265.39571115005;27400.177994660193;27593.44813103727;27621.171364859085;27676.584851227246;27737.167884963485;11384.203105782515;11596.942015290038;11716.472758725879;11789.528418863149;11816.940915295369;10364.222683298784;10560.788784224273;10626.893731062744;10708.518116684612;10762.461876906124;10088.74778130538;10221.131203847608;10337.950304660144;10589.9470502647;10620.362778233331;2886.163012726286;2904.3755592547705;2963.4962056450454;3039.2705750619693;3065.310305181361;1058.2327812335996;1069.0445352196903;1091.9181061420425;1093.9989909233122;1097.1332647208776;21425.250116246167;21779.67330490044;21783.455413614785;21855.235066772588;21903.780962190493;1149.143887803575;1155.6879642496478;1157.4675649201292;1172.4899668643995;1184.6505280942142;11630.53477860893;11849.644510664693;11956.52173913051;12053.758924821455;12136.514539418324;624534;631981;644581;647577;653414;129815;132676;133901.3304933469;135503;135533.3223333877;1191.195942738648;1234.388977456147;1295.5206573567652;1308.4439113376968;1346.2730125731996;22108.557828843655;22321.330360089225;22585.193184545526;22587.548249035255;22604.208852690077;63824.36175638184;64346.35653643404;65653.34346656472;66590.33409665841;66974.3302566968;83016.58491707503;83096.58451707703;83317.58341208255;83492.58253708936;83602.58198708968;16125.516234512983;16261.105639189958;16399;16430;16549.751753723944;24260;24697.87651061733;24799.380015499035;24870.12954546582;25177.622335665346;19540.21839126419;19738.30915917936;19746.111424985622;20116;20125.698114528;17883;17903.910480448034;17976.460706178834;18321.633567328314;18587.628247434706;19919;20516.897415512827;20745.481362966046;20781.58436831285;20895.910408958982;16186.190690465664;16186.595335116715;16197.271122799739;16221;16454.917725411295;19930.501737456678;19969.400917972485;20369.083391247725;20414.69377959302;20471.181152753725 14:41:34 INFO - PID 30081 | |3;mootools.html;1414.2221778022088;1518.9392424303026;1522.649790548174;1535.431890200626;1535.7773122897174;17384.73922891156;18009.549761255974;18135.546611334692;18144.002079885602;18172.727409088875;17729.29082836685;17863.64272714545;17976;18023.819761802377;18032.278708851663;3150.212446888278;3177.4121787469276;3219.3561287742427;3219.4687876500348;3220.5652236948063;3078.599782028344;3133.88746994817;3150.2596889730894;3167.3190264093214;3168.572242747234;3069.6316442026878;3176.3488484860663;3180.697833705806;3182.268078341971;3183.697548732867;3139.1838122088193;3153.085605174508;3169.8732050717945;3175.650678425383;3176.190071531768;3076.7846250762454;3115.5949726535405;3119.157827386593;3124.9218769530944;3174.904752857418;17573.64852702939;17831.465056048208;17847;17850.91074544632;17864.55338616532;8899.15458031486;9210.49342286174;9233.122853328923;9234.261259099256;9241.168294853429;5603.355614104389;5795.565332600072;5904.1734157218025;5946.583739138262;5960.314563825173;2119.5972765174565;2152.956940861174;2195.3304242206123;2221.7000704904794;2233.553289342138;33002.339953201044;33370;33398.33203335944;33399.83300083484;33420.665793342;7483.550986940692;7544.47188696786;7559.811004724816;7784.844303113906;7825.217478252129;20532.794672053387;20565.794342056688;20580;20580.691289630668;20665.793342066387;8839.513826739463;9083.137101975302;9083.364164508554;9087.727368178965;9090.636374544943;8021.959890200512;8192.54940978252;8284.295834854105;8284.668613255402;8324.292435143081;5972.074328479092;5983.3545774912245;6129.448349648464;6153.784617538365;6172.321044685081;1609.4125644139804;1666.2002238925384;1676.5054308978881;1720.7590937268792;1760.8063113057553;1032.8450732390052;1043.8068957242933;1048.8479170520231;1052.5421441672897;1065.5790962569743;10345.482725863676;10409.5836166554;10432.582696692047;10436.37381757097;10513;1103.448275862069;1117.541807858774;1117.9161562882653;1122.1303489795473;1128.4019469681082;5612.045952188138;5652.123920792284;6367.363263673596;6574.342565743387;6715.6977935993;26748;26834;27328.316792080357;27727.584086238723;27739.583906241423;25304.873475632503;27359.179224623294;27431.725682743316;27632.58551121735;27725.58411623827;11879.168458208016;12664.430100645493;12736.872631273569;12926.935365323114;12990.675233119058;10062.798744025225;10180.338278011906;10281.12610428122;10296.330738501973;10392.116670083127;21626.891865540572;22847;23142.537149257256;23283;23461.882690586437;23497.647535286644;23637.881810590836;23850;23916.52166956686;24726.752732472443;12799.744005120032;12855.871441285468;12871.613851584467;13013.804792928304;13031.413586388824;16292;16318.102504362374;16468.42360517376;16475.917620411823;16486.25811838494;13379.933100334436;13437.193768373929;13527.729445411234;13634.590962271148;13645.727085458433;12644.936775316064;12650.05124615676;12799.168054076456;13199.604011879659;13274.93362533181;10494.950504949444;10773.192010599394;10777.51501182433;10841.837372439262;11001.559937602726;8398.790030249293;8518.23335899772;8556.529390883561;8634.179752923714;8652;8561.905666128643;8567.61445734931;8569.400141990001;8612.698555550525;8750.824983500166 14:41:34 INFO - PID 30081 | |4;prototype.html;545.2203349210628;590.7755053079829;593.4895989449074;604.0848115105613;607.6566739792017;6602.834929126769;6615.14775862758;6648.867022659544;6683.331666833326;6690.3644153805435;6430.45341146002;6495.213816200548;6504.512161587876;6519.44584710299;6521.6739163041775;5321.920171197435;5346.866328341784;5365.222042803791;5370.543503802162;5377.542908852753;4994.750262486879;5089.872753181163;5139.331886854722;5261.868453288679;5343.118385466393;5093.821716239932;5098.490150984909;5123.103456895047;5129.153689641204;5150.716710580917;5060.342155519796;5068.3917929848285;5082.288479612838;5110.2590124431745;5137.948620513785;4666.3900954171095;4687.835925742583;4689.577937985598;4755.191617425046;4756.096341695102;6401.871962560769;6436.678166091677;6445.903311450332;6450.129232553592;6469.32072132424;5958.910616340759;6011.12838638395;6058.787942421994;6101.115338275969;6102.26772787264;6763.492738044617;6783.559068660521;6797.388235058868;6803.557768745065;6851.588904665736;5049.64652474327;5177.119889618773;5230.3985041719925;5234.136367499358;5266.368035835724;7030.29697030298;7084.858302833966;7107.964460177718;7144.928550714479;7153.749618763319;5381.515663590296;5408.620207108859;5441.918371224435;5443.156310771837;5470.671759694431;5442.727863606804;5451.754671039813;5483.643563168382;5512.283403157644;5519.834404967857;6041.879162416815;6075.513958883279;6076.331603523698;6093.360197179321;6124.836281106575;6866.661001104837;6877.933920242371;6949.166100067923;6950.582965022115;6965.547239429421;1838.7333836593618;1868.8693340529055;1870.2892900697648;1877.6807942649782;1898.9620207595772;1295.436485128972;1308.5093090091216;1330.2417621955585;1335.7595632785997;1357.178906761415;6290.6789574189015;6299.244090709144;6368.936310636927;6398.520110991694;6436.7425302988295;6824.873895807136;6834.760783372558;6840.623765692835;6976.441884649216;6986.196587392414;6319.58922670025;6329.968350158219;6374.426301632875;6417.427730206129;6472.190976127984;3616.4213725803747;3634.9091272717865;3650.361186792301;3677.1726361568435;3698.5746639136305;7246.695594792988;7263.491555591164;7284.162321333115;7284.526505777108;7327.780166595011;7059.89410158848;7135.928640713526;7175.964120179366;7176.96411517939;7204.243554426815;7089.326513981164;7143.9285607143265;7200.111939552583;7225.277472252733;7262.963685181646;6822.420094292041;6908.5509441886115;6921.6193109379465;6922.723091076301;6926.757563485254;6870.862582748217;6901.309869013058;6914.999999999799;6930.48021398387;6979.2671769465505;7033.964830175816;7119.822004449723;7135.250798666273;7239.239879812754;7254;5336.786528538815;5343.839684809462;5369.335505993155;5391.75737091824;5422.430644782241;6637.435817955527;6812.25065242813;6847.965760171366;7016.824579385556;7032.964835175791;6675.899861501985;6694.430973367318;6712.871583975917;6831;6839.69221385029;6728.932710673026;6760.256371799;6766.458683305225;6792.796216113525;6900.6204658744255;6680.9978503222965;6683.8663226734225;6687.528743676384;6714.731410743516;6810.863782724218;6755.695993680198;6801.171168470441;6826.371846838903;6884.483663725341;6921.757738479129;6301.1411633567295;6502.414782669393;6589.736410543716;6653.367930046637;6684.264730879502 14:41:34 INFO - PID 30081 | |5;yui.html;987.5013118375219;990.9009099090097;1003.9949800250998;1013.9391636501811;1036.4403222259984;21207.787922120773;21734.56530869382;21761.3471595852;21764.347069587897;21785.128594856225;17333.22000509977;17450.3019879205;19670.70493942592;20599.897000514975;20912.16351345948;1062.3466568060626;1102.7132945434164;1102.7794441111769;1102.85662863828;1103.1615971861404;1073.2272763610188;1111.7998760223156;1119.278065647661;1122.5229277557005;1125.673554669149;1179.2747460311932;1180.9881901180963;1183.9822402663967;1184.3486082654506;1184.4255536065002;1164.9650510484698;1165.300819508301;1167.7722844045416;1174.166341897254;1174.2308787744041;860.389123722158;861.8836457078277;864.7405778266495;869.5304535550795;870.499462808881;21092.89453552738;21201.8939905301;21403.785962140337;21674.891625541928;22751.886240568856;20973.5805283895;21466.463338416663;21471.24850630236;21519.78480215209;21540.461488462755;19268.710969335472;19400.902995485074;20014.399568012985;20107.698384524243;20161;4128.4632997710105;4145.647619952308;4196.265653510654;4201.621854033121;4206.074663574009;164872;170867;172523.1373843123;172983;173000;17432.738508922375;17790.199441024924;17884.642307154045;17887.463376098738;17955.910220449074;35222;36008.63991360105;36102.638973610454;36113;36135.638643613755;9002.234810041089;9047.095290470901;9125.543722813833;9155;9278.304127190488;4747.715137091785;4821.9035619287415;4823.252395878644;4823.493533179036;4825.758712064383;5889.204957330791;6000.729967151488;6048;6165.352637972948;6167.321594624587;1138.3568283919558;1149.7125718570358;1164.3596022187762;1169.7251145980688;1172.5309876049648;755.0825746717765;767.8272388712606;771.1286246541372;774.4191856107919;796.2117503671324;12985.480580776662;13470.663233419244;13604.251766152956;14131.434742610387;14227.146371217554;752;758.6548120605222;761.4859969520552;766.8772996320673;769.8806684963839;6356.459700925473;6374.904376434357;6436.871262574722;6444.258910225384;6456.870862582722;152240;155635;155961.2201938983;157529;158947;136985;139466;140667;142109.28945355208;146991.2650436741;117982.41008795073;120763;121018;122166;123203;11984.76030479403;12109.636710898687;12152.939235303767;12194.634160975185;12215.167724841345;55505;56966.43033569777;57146.714266428404;57369.71315143398;57965;72261.6386918062;72449.27550724425;73043.63478182787;73671;76489.23510765044;17736.91131544334;17797.644047119244;17871.463856084338;17961;17980.730289045412;17641.558961026076;18302.26790928348;18341.082945852922;18483.445496635122;18508.259669613064;17096.14519274056;17215.741763873302;17233.56916077108;17429.215685294446;17450.650986979934;18792.812071879107;18826.341078062203;18858.905705471934;18927.905360473662;19003.90498047501;17713.557161071076;17816.91091544534;17940.641187176443;18084.81915180884;18107.275708971494;12155.756884862076;12215.450304736485;12228.082893782825;12252.75494490123;12258.203216791237;11630.360330181922;11650.6504804856;11709.473073711873;11779.941100294443;11880.524779008743 14:41:34 INFO - PID 30081 | __end_tp_report 14:41:34 INFO - PID 30081 | __start_cc_report 14:41:34 INFO - PID 30081 | _x_x_mozilla_cycle_collect,248 14:41:34 INFO - PID 30081 | __end_cc_report 14:41:34 INFO - PID 30081 | __startTimestamp1506116494177__endTimestamp 14:41:34 INFO - PID 30081 | 14:41:34 INFO - PID 30081 | ------- Summary: start ------- 14:41:34 INFO - PID 30081 | Number of tests: 6 14:41:34 INFO - PID 30081 | 14:41:34 INFO - PID 30081 | [#0] dojo.html Cycles:165 Average:6569.49 Median:6826.15 stddev:747.12 (10.9%) stddev-sans-first:721.95 14:41:34 INFO - PID 30081 | Values: 4010.8 4043.4 4048.9 4049.9 4064.8 6505.5 6527.7 6532.7 6622.5 6640.5 6588.7 6594.2 6647.7 6657.9 6682.7 5892.1 5905.0 5910.8 5963.2 5972.3 5832.1 5851.3 5915.7 5956.1 6010.2 5892.0 5917.5 5919.1 5988.5 6012.3 5828.8 5989.7 5999.6 6005.6 6012.1 5798.4 5852.6 5888.3 5918.1 5985.2 6415.3 6503.8 6516.1 6517.8 6542.4 7098.8 7180.3 7193.4 7196.3 7197.1 7160.9 7167.3 7187.4 7198.9 7278.1 6568.4 6605.8 6634.9 6635.7 6689.6 7194.7 7205.2 7303.6 7358.8 7378.7 6956.8 6969.6 7037.1 7040.0 7054.9 7066.4 7070.2 7152.4 7155.5 7172.4 6987.9 6991.7 7027.1 7046.8 7085.8 7012.8 7041.7 7042.4 7052.2 7057.4 5273.4 5347.7 5351.5 5356.1 5358.0 4816.3 4841.5 4850.8 4876.6 4897.7 6582.9 6617.3 6632.2 6634.0 6651.3 7108.3 7111.7 7176.6 7189.2 7199.5 6553.6 6573.2 6602.8 6672.6 6682.0 6070.7 6107.7 6120.2 6128.4 6149.4 7356.9 7364.5 7452.5 7452.7 7457.5 6970.5 7086.0 7088.0 7175.7 7178.1 7329.9 7352.0 7371.8 7374.7 7438.7 6979.8 6999.5 7066.6 7076.9 7087.8 7109.9 7111.1 7116.3 7201.4 7205.9 6750.5 6861.9 6864.1 6871.2 6934.7 6826.1 6827.8 6835.7 6856.0 6906.6 6770.5 6846.5 6861.9 6875.3 6879.3 6874.7 6889.2 6895.1 6929.1 6985.6 6600.0 6626.9 6686.9 6689.8 6698.4 14:41:34 INFO - PID 30081 | 14:41:34 INFO - PID 30081 | [#1] ext.html Cycles:180 Average:45531.68 Median:38346.12 stddev:71091.89 (185.4%) stddev-sans-first:71212.62 14:41:34 INFO - PID 30081 | Values: 978.9 989.6 1003.3 1005.3 1008.3 45496.5 45817.0 46081.3 46119.1 46230.3 43878.3 43950.6 44287.8 44303.6 44388.0 8074.7 8217.8 8221.1 8227.6 8234.1 7950.9 7971.6 8021.4 8023.9 8036.2 8854.3 9003.0 9003.4 9005.4 9053.2 8944.9 8973.7 9002.4 9007.3 9011.1 8804.2 8820.1 8852.2 8861.9 8878.8 41318.0 41579.6 41614.8 41736.2 41755.6 3855.8 3883.5 3890.1 3895.0 3901.5 33156.0 33273.5 33365.3 33390.3 33408.0 5607.4 5624.7 5625.2 5686.5 5704.3 223565.0 224289.0 225268.0 225739.0 226580.9 47800.5 48948.8 54653.5 55056.0 55261.7 57596.7 57826.4 57943.7 58048.7 58113.7 19015.3 19015.3 19023.5 19148.3 19149.1 15584.0 15757.7 15774.2 15785.8 15796.3 15695.5 15758.3 15815.9 15823.9 15828.8 6170.7 6255.6 6269.5 6277.2 6295.5 1125.2 1129.7 1135.9 1146.4 1151.1 25966.6 25991.5 26297.2 26548.9 26608.2 1244.4 1252.2 1256.6 1264.6 1271.5 13730.9 13924.4 14025.9 14153.0 14252.4 296374.0 323802.0 324643.0 327868.0 328422.4 65555.7 65863.0 66202.0 66417.0 66566.0 1547.0 1560.9 1561.8 1583.0 1587.9 30747.5 30987.5 31078.0 31247.5 31361.8 44256.1 44475.6 44540.0 44835.6 44900.3 260005.0 264808.0 265054.0 265714.0 265827.0 37853.4 38191.0 38291.0 38401.2 38756.8 48235.5 49025.0 49309.8 49697.8 49711.3 34793.0 35099.0 35304.6 35484.8 35685.3 32754.8 32858.8 32888.7 33032.8 33734.5 41463.4 41863.0 41987.6 42098.4 42149.4 34041.7 34140.8 34221.7 34227.7 34336.0 25602.6 25737.5 25805.0 26086.0 26167.9 14:41:34 INFO - PID 30081 | 14:41:34 INFO - PID 30081 | [#2] jquery.html Cycles:180 Average:41704.34 Median:22214.94 stddev:107034.93 (481.8%) stddev-sans-first:107290.79 14:41:34 INFO - PID 30081 | Values: 643.5 643.6 644.7 647.3 657.9 23998.2 24622.1 24646.8 24656.6 24666.9 26828.3 27194.6 27209.0 27210.9 27212.0 6385.0 6692.3 6727.5 6744.6 6748.2 6704.8 6742.5 6798.1 6800.0 6801.6 6726.9 6729.5 6769.0 7027.6 7033.2 6976.7 7022.9 7023.2 7029.6 7043.8 6577.8 6585.4 6596.6 6600.1 6622.8 29934.1 31119.1 31188.4 31588.2 31592.7 2421.7 2427.5 2432.1 2432.7 2461.7 21573.1 21715.7 21770.6 21800.0 21972.6 2602.3 2642.6 2670.7 2699.5 2700.9 145278.0 151950.2 161880.0 166304.2 167091.2 16639.7 17014.4 17045.4 17115.7 17265.4 27400.2 27593.4 27621.2 27676.6 27737.2 11384.2 11596.9 11716.5 11789.5 11816.9 10364.2 10560.8 10626.9 10708.5 10762.5 10088.7 10221.1 10338.0 10589.9 10620.4 2886.2 2904.4 2963.5 3039.3 3065.3 1058.2 1069.0 1091.9 1094.0 1097.1 21425.3 21779.7 21783.5 21855.2 21903.8 1149.1 1155.7 1157.5 1172.5 1184.7 11630.5 11849.6 11956.5 12053.8 12136.5 624534.0 631981.0 644581.0 647577.0 653414.0 129815.0 132676.0 133901.3 135503.0 135533.3 1191.2 1234.4 1295.5 1308.4 1346.3 22108.6 22321.3 22585.2 22587.5 22604.2 63824.4 64346.4 65653.3 66590.3 66974.3 83016.6 83096.6 83317.6 83492.6 83602.6 16125.5 16261.1 16399.0 16430.0 16549.8 24260.0 24697.9 24799.4 24870.1 25177.6 19540.2 19738.3 19746.1 20116.0 20125.7 17883.0 17903.9 17976.5 18321.6 18587.6 19919.0 20516.9 20745.5 20781.6 20895.9 16186.2 16186.6 16197.3 16221.0 16454.9 19930.5 19969.4 20369.1 20414.7 20471.2 14:41:34 INFO - PID 30081 | 14:41:34 INFO - PID 30081 | [#3] mootools.html Cycles:180 Average:11146.19 Median:23567.76 stddev:8328.96 (35.3%) stddev-sans-first:8320.23 14:41:34 INFO - PID 30081 | Values: 1414.2 1518.9 1522.6 1535.4 1535.8 17384.7 18009.5 18135.5 18144.0 18172.7 17729.3 17863.6 17976.0 18023.8 18032.3 3150.2 3177.4 3219.4 3219.5 3220.6 3078.6 3133.9 3150.3 3167.3 3168.6 3069.6 3176.3 3180.7 3182.3 3183.7 3139.2 3153.1 3169.9 3175.7 3176.2 3076.8 3115.6 3119.2 3124.9 3174.9 17573.6 17831.5 17847.0 17850.9 17864.6 8899.2 9210.5 9233.1 9234.3 9241.2 5603.4 5795.6 5904.2 5946.6 5960.3 2119.6 2153.0 2195.3 2221.7 2233.6 33002.3 33370.0 33398.3 33399.8 33420.7 7483.6 7544.5 7559.8 7784.8 7825.2 20532.8 20565.8 20580.0 20580.7 20665.8 8839.5 9083.1 9083.4 9087.7 9090.6 8022.0 8192.5 8284.3 8284.7 8324.3 5972.1 5983.4 6129.4 6153.8 6172.3 1609.4 1666.2 1676.5 1720.8 1760.8 1032.8 1043.8 1048.8 1052.5 1065.6 10345.5 10409.6 10432.6 10436.4 10513.0 1103.4 1117.5 1117.9 1122.1 1128.4 5612.0 5652.1 6367.4 6574.3 6715.7 26748.0 26834.0 27328.3 27727.6 27739.6 25304.9 27359.2 27431.7 27632.6 27725.6 11879.2 12664.4 12736.9 12926.9 12990.7 10062.8 10180.3 10281.1 10296.3 10392.1 21626.9 22847.0 23142.5 23283.0 23461.9 23497.6 23637.9 23850.0 23916.5 24726.8 12799.7 12855.9 12871.6 13013.8 13031.4 16292.0 16318.1 16468.4 16475.9 16486.3 13379.9 13437.2 13527.7 13634.6 13645.7 12644.9 12650.1 12799.2 13199.6 13274.9 10495.0 10773.2 10777.5 10841.8 11001.6 8398.8 8518.2 8556.5 8634.2 8652.0 8561.9 8567.6 8569.4 8612.7 8750.8 14:41:34 INFO - PID 30081 | 14:41:34 INFO - PID 30081 | [#4] prototype.html Cycles:180 Average:5823.18 Median:6470.76 stddev:1621.80 (25.1%) stddev-sans-first:1577.23 14:41:34 INFO - PID 30081 | Values: 545.2 590.8 593.5 604.1 607.7 6602.8 6615.1 6648.9 6683.3 6690.4 6430.5 6495.2 6504.5 6519.4 6521.7 5321.9 5346.9 5365.2 5370.5 5377.5 4994.8 5089.9 5139.3 5261.9 5343.1 5093.8 5098.5 5123.1 5129.2 5150.7 5060.3 5068.4 5082.3 5110.3 5137.9 4666.4 4687.8 4689.6 4755.2 4756.1 6401.9 6436.7 6445.9 6450.1 6469.3 5958.9 6011.1 6058.8 6101.1 6102.3 6763.5 6783.6 6797.4 6803.6 6851.6 5049.6 5177.1 5230.4 5234.1 5266.4 7030.3 7084.9 7108.0 7144.9 7153.7 5381.5 5408.6 5441.9 5443.2 5470.7 5442.7 5451.8 5483.6 5512.3 5519.8 6041.9 6075.5 6076.3 6093.4 6124.8 6866.7 6877.9 6949.2 6950.6 6965.5 1838.7 1868.9 1870.3 1877.7 1899.0 1295.4 1308.5 1330.2 1335.8 1357.2 6290.7 6299.2 6368.9 6398.5 6436.7 6824.9 6834.8 6840.6 6976.4 6986.2 6319.6 6330.0 6374.4 6417.4 6472.2 3616.4 3634.9 3650.4 3677.2 3698.6 7246.7 7263.5 7284.2 7284.5 7327.8 7059.9 7135.9 7176.0 7177.0 7204.2 7089.3 7143.9 7200.1 7225.3 7263.0 6822.4 6908.6 6921.6 6922.7 6926.8 6870.9 6901.3 6915.0 6930.5 6979.3 7034.0 7119.8 7135.3 7239.2 7254.0 5336.8 5343.8 5369.3 5391.8 5422.4 6637.4 6812.3 6848.0 7016.8 7033.0 6675.9 6694.4 6712.9 6831.0 6839.7 6728.9 6760.3 6766.5 6792.8 6900.6 6681.0 6683.9 6687.5 6714.7 6810.9 6755.7 6801.2 6826.4 6884.5 6921.8 6301.1 6502.4 6589.7 6653.4 6684.3 14:41:34 INFO - PID 30081 | 14:41:34 INFO - PID 30081 | [#5] yui.html Cycles:180 Average:29355.67 Median:18204.77 stddev:44858.26 (246.4%) stddev-sans-first:44933.53 14:41:34 INFO - PID 30081 | Values: 987.5 990.9 1004.0 1013.9 1036.4 21207.8 21734.6 21761.3 21764.3 21785.1 17333.2 17450.3 19670.7 20599.9 20912.2 1062.3 1102.7 1102.8 1102.9 1103.2 1073.2 1111.8 1119.3 1122.5 1125.7 1179.3 1181.0 1184.0 1184.3 1184.4 1165.0 1165.3 1167.8 1174.2 1174.2 860.4 861.9 864.7 869.5 870.5 21092.9 21201.9 21403.8 21674.9 22751.9 20973.6 21466.5 21471.2 21519.8 21540.5 19268.7 19400.9 20014.4 20107.7 20161.0 4128.5 4145.6 4196.3 4201.6 4206.1 164872.0 170867.0 172523.1 172983.0 173000.0 17432.7 17790.2 17884.6 17887.5 17955.9 35222.0 36008.6 36102.6 36113.0 36135.6 9002.2 9047.1 9125.5 9155.0 9278.3 4747.7 4821.9 4823.3 4823.5 4825.8 5889.2 6000.7 6048.0 6165.4 6167.3 1138.4 1149.7 1164.4 1169.7 1172.5 755.1 767.8 771.1 774.4 796.2 12985.5 13470.7 13604.3 14131.4 14227.1 752.0 758.7 761.5 766.9 769.9 6356.5 6374.9 6436.9 6444.3 6456.9 152240.0 155635.0 155961.2 157529.0 158947.0 136985.0 139466.0 140667.0 142109.3 146991.3 117982.4 120763.0 121018.0 122166.0 123203.0 11984.8 12109.6 12152.9 12194.6 12215.2 55505.0 56966.4 57146.7 57369.7 57965.0 72261.6 72449.3 73043.6 73671.0 76489.2 17736.9 17797.6 17871.5 17961.0 17980.7 17641.6 18302.3 18341.1 18483.4 18508.3 17096.1 17215.7 17233.6 17429.2 17450.7 18792.8 18826.3 18858.9 18927.9 19003.9 17713.6 17816.9 17940.6 18084.8 18107.3 12155.8 12215.5 12228.1 12252.8 12258.2 11630.4 11650.7 11709.5 11779.9 11880.5 14:41:34 INFO - PID 30081 | -------- Summary: end -------- 14:41:34 INFO - PID 30081 | 14:41:34 INFO - TEST-INFO | 30081: exit 0 14:41:34 INFO - TEST-OK | dromaeo_css | took 1107231ms 14:41:34 INFO - TEST-START | kraken 14:41:34 INFO - Initialising browser for kraken test... 14:41:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57169/getInfo.html -profile /tmp/tmp1bRKtu/profile 14:41:34 INFO - TEST-INFO | started process 30438 (/builds/slave/test/build/application/firefox/firefox http://localhost:57169/getInfo.html) 14:41:39 INFO - TEST-INFO | 30438: exit 0 14:41:39 INFO - Browser initialized. 14:41:39 INFO - Running cycle 1/1 for kraken test... 14:41:39 INFO - Using env: {'DISPLAY': ':0', 14:41:39 INFO - 'HOME': '/home/cltbld', 14:41:39 INFO - 'JSGC_DISABLE_POISONING': '1', 14:41:39 INFO - 'LANG': 'en_US.UTF-8', 14:41:39 INFO - 'LANGUAGE': 'en_US:en', 14:41:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:41:39 INFO - 'LOGNAME': 'cltbld', 14:41:39 INFO - 'MAIL': '/var/mail/cltbld', 14:41:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:41:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:41:39 INFO - 'MOZ_CRASHREPORTER': '1', 14:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:41:39 INFO - 'MOZ_NO_REMOTE': '1', 14:41:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:39 INFO - 'NO_EM_RESTART': '1', 14:41:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:39 INFO - 'PWD': '/builds/slave/test', 14:41:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:41:39 INFO - 'RUST_BACKTRACE': 'full', 14:41:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:41:39 INFO - 'SHELL': '/bin/bash', 14:41:39 INFO - 'SHLVL': '1', 14:41:39 INFO - 'TERM': 'linux', 14:41:39 INFO - 'TMOUT': '86400', 14:41:39 INFO - 'USER': 'cltbld', 14:41:39 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291', 14:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:39 INFO - '_': '/tools/buildbot/bin/python'} 14:41:39 INFO - TEST-INFO | started process 30625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1bRKtu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:41:50 INFO - PID 30625 | RSS: Main: 146767872 14:41:50 INFO - PID 30625 | 14:41:53 INFO - PID 30625 | Cycle 1(1): loaded http://localhost:57169/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57169/tests/kraken/driver.html?testName=audio-beat-detection) 14:41:54 INFO - PID 30625 | RSS: Main: 152764416 14:41:54 INFO - PID 30625 | 14:41:56 INFO - PID 30625 | Cycle 1(1): loaded http://localhost:57169/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57169/tests/kraken/driver.html?testName=audio-dft) 14:41:57 INFO - PID 30625 | RSS: Main: 153260032 14:41:57 INFO - PID 30625 | 14:42:00 INFO - PID 30625 | Cycle 1(1): loaded http://localhost:57169/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57169/tests/kraken/driver.html?testName=audio-fft) 14:42:00 INFO - PID 30625 | RSS: Main: 154857472 14:42:00 INFO - PID 30625 | 14:42:02 INFO - PID 30625 | Cycle 1(1): loaded http://localhost:57169/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57169/tests/kraken/driver.html?testName=audio-oscillator) 14:42:03 INFO - PID 30625 | RSS: Main: 154816512 14:42:03 INFO - PID 30625 | 14:42:05 INFO - PID 30625 | Cycle 1(1): loaded http://localhost:57169/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57169/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:42:06 INFO - PID 30625 | RSS: Main: 154640384 14:42:06 INFO - PID 30625 | 14:42:09 INFO - PID 30625 | Cycle 1(1): loaded http://localhost:57169/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57169/tests/kraken/driver.html?testName=imaging-darkroom) 14:42:09 INFO - PID 30625 | RSS: Main: 154177536 14:42:09 INFO - PID 30625 | 14:42:13 INFO - PID 30625 | Cycle 1(1): loaded http://localhost:57169/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57169/tests/kraken/driver.html?testName=imaging-desaturate) 14:42:13 INFO - PID 30625 | RSS: Main: 156749824 14:42:13 INFO - PID 30625 | 14:42:16 INFO - PID 30625 | Cycle 1(1): loaded http://localhost:57169/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57169/tests/kraken/driver.html?testName=json-parse-financial) 14:42:17 INFO - PID 30625 | RSS: Main: 157401088 14:42:17 INFO - PID 30625 | 14:42:18 INFO - PID 30625 | Cycle 1(1): loaded http://localhost:57169/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57169/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:42:19 INFO - PID 30625 | RSS: Main: 157290496 14:42:19 INFO - PID 30625 | 14:42:20 INFO - PID 30625 | Cycle 1(1): loaded http://localhost:57169/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57169/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:42:21 INFO - PID 30625 | RSS: Main: 157356032 14:42:21 INFO - PID 30625 | 14:42:23 INFO - PID 30625 | Cycle 1(1): loaded http://localhost:57169/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57169/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:42:24 INFO - PID 30625 | RSS: Main: 154406912 14:42:24 INFO - PID 30625 | 14:42:26 INFO - PID 30625 | Cycle 1(1): loaded http://localhost:57169/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57169/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:42:27 INFO - PID 30625 | RSS: Main: 154378240 14:42:27 INFO - PID 30625 | 14:42:29 INFO - PID 30625 | Cycle 1(1): loaded http://localhost:57169/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57169/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:42:30 INFO - PID 30625 | RSS: Main: 155074560 14:42:30 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | Cycle 1(1): loaded http://localhost:57169/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57169/tests/kraken/driver.html?testName=ai-astar) 14:42:32 INFO - PID 30625 | RSS: Main: 156590080 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | __start_tp_report 14:42:32 INFO - PID 30625 | _x_x_mozilla_page_load 14:42:32 INFO - PID 30625 | _x_x_mozilla_page_load_details 14:42:32 INFO - PID 30625 | |i|pagename|runs| 14:42:32 INFO - PID 30625 | |0;ai-astar;106;105;104;105;106;107;108;106;108;106 14:42:32 INFO - PID 30625 | |1;audio-beat-detection;111;112;111;111;112;111;134;112;116;113 14:42:32 INFO - PID 30625 | |2;audio-dft;166;164;163;162;163;162;163;164;161;164 14:42:32 INFO - PID 30625 | |3;audio-fft;73;73;72;72;71;72;72;72;73;73 14:42:32 INFO - PID 30625 | |4;audio-oscillator;79;78;77;76;78;78;78;77;77;79 14:42:32 INFO - PID 30625 | |5;imaging-gaussian-blur;109;113;113;113;114;114;116;114;117;114 14:42:32 INFO - PID 30625 | |6;imaging-darkroom;150;148;150;149;149;148;150;150;150;149 14:42:32 INFO - PID 30625 | |7;imaging-desaturate;93;94;95;93;94;94;94;94;96;94 14:42:32 INFO - PID 30625 | |8;json-parse-financial;46;45;44;44;44;46;45;45;44;44 14:42:32 INFO - PID 30625 | |9;json-stringify-tinderbox;37;37;41;37;38;37;38;37;37;37 14:42:32 INFO - PID 30625 | |10;stanford-crypto-aes;70;69;69;68;70;69;78;70;76;70 14:42:32 INFO - PID 30625 | |11;stanford-crypto-ccm;101;106;100;101;108;105;104;109;101;105 14:42:32 INFO - PID 30625 | |12;stanford-crypto-pbkdf2;153;152;151;158;147;149;153;147;149;151 14:42:32 INFO - PID 30625 | |13;stanford-crypto-sha256-iterative;59;59;58;61;59;62;58;58;57;63 14:42:32 INFO - PID 30625 | __end_tp_report 14:42:32 INFO - PID 30625 | __start_cc_report 14:42:32 INFO - PID 30625 | _x_x_mozilla_cycle_collect,709 14:42:32 INFO - PID 30625 | __end_cc_report 14:42:32 INFO - PID 30625 | __startTimestamp1506116552272__endTimestamp 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | ------- Summary: start ------- 14:42:32 INFO - PID 30625 | Number of tests: 14 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | [#0] ai-astar Cycles:10 Average:106.10 Median:106.00 stddev:1.29 (1.2%) stddev-sans-first:1.36 14:42:32 INFO - PID 30625 | Values: 106.0 105.0 104.0 105.0 106.0 107.0 108.0 106.0 108.0 106.0 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | [#1] audio-beat-detection Cycles:10 Average:114.30 Median:112.00 stddev:7.09 (6.3%) stddev-sans-first:7.42 14:42:32 INFO - PID 30625 | Values: 111.0 112.0 111.0 111.0 112.0 111.0 134.0 112.0 116.0 113.0 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.40 (0.9%) stddev-sans-first:1.05 14:42:32 INFO - PID 30625 | Values: 166.0 164.0 163.0 162.0 163.0 162.0 163.0 164.0 161.0 164.0 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | [#3] audio-fft Cycles:10 Average:72.30 Median:72.50 stddev:0.67 (0.9%) stddev-sans-first:0.67 14:42:32 INFO - PID 30625 | Values: 73.0 73.0 72.0 72.0 71.0 72.0 72.0 72.0 73.0 73.0 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:78.00 stddev:0.95 (1.2%) stddev-sans-first:0.88 14:42:32 INFO - PID 30625 | Values: 79.0 78.0 77.0 76.0 78.0 78.0 78.0 77.0 77.0 79.0 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:2.11 (1.9%) stddev-sans-first:1.39 14:42:32 INFO - PID 30625 | Values: 109.0 113.0 113.0 113.0 114.0 114.0 116.0 114.0 117.0 114.0 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:150.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 14:42:32 INFO - PID 30625 | Values: 150.0 148.0 150.0 149.0 149.0 148.0 150.0 150.0 150.0 149.0 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.88 (0.9%) stddev-sans-first:0.83 14:42:32 INFO - PID 30625 | Values: 93.0 94.0 95.0 93.0 94.0 94.0 94.0 94.0 96.0 94.0 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | [#8] json-parse-financial Cycles:10 Average:44.70 Median:45.00 stddev:0.82 (1.8%) stddev-sans-first:0.73 14:42:32 INFO - PID 30625 | Values: 46.0 45.0 44.0 44.0 44.0 46.0 45.0 45.0 44.0 44.0 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | [#9] json-stringify-tinderbox Cycles:10 Average:37.60 Median:37.00 stddev:1.26 (3.4%) stddev-sans-first:1.32 14:42:32 INFO - PID 30625 | Values: 37.0 37.0 41.0 37.0 38.0 37.0 38.0 37.0 37.0 37.0 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | [#10] stanford-crypto-aes Cycles:10 Average:70.90 Median:70.00 stddev:3.31 (4.7%) stddev-sans-first:3.50 14:42:32 INFO - PID 30625 | Values: 70.0 69.0 69.0 68.0 70.0 69.0 78.0 70.0 76.0 70.0 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | [#11] stanford-crypto-ccm Cycles:10 Average:104.00 Median:105.00 stddev:3.16 (3.0%) stddev-sans-first:3.16 14:42:32 INFO - PID 30625 | Values: 101.0 106.0 100.0 101.0 108.0 105.0 104.0 109.0 101.0 105.0 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.00 Median:151.50 stddev:3.30 (2.2%) stddev-sans-first:3.42 14:42:32 INFO - PID 30625 | Values: 153.0 152.0 151.0 158.0 147.0 149.0 153.0 147.0 149.0 151.0 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.40 Median:59.00 stddev:1.96 (3.3%) stddev-sans-first:2.07 14:42:32 INFO - PID 30625 | Values: 59.0 59.0 58.0 61.0 59.0 62.0 58.0 58.0 57.0 63.0 14:42:32 INFO - PID 30625 | -------- Summary: end -------- 14:42:32 INFO - PID 30625 | 14:42:32 INFO - PID 30625 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:42:32 INFO - TEST-INFO | 30625: exit 0 14:42:32 INFO - TEST-OK | kraken | took 58011ms 14:42:32 INFO - SUITE-END | took 1165s 14:42:32 INFO - Completed test suite (00:19:25) 14:42:32 INFO - javascript benchmark 14:42:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9471.770415061172, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4010.819513121909, 4043.353063509839, 4048.9190216195693, 4049.8987525311863, 4064.8170832312544, 6505.544611877171, 6527.706253218611, 6532.673366331688, 6622.503312251589, 6640.468762499, 6588.736450541985, 6594.241662208848, 6647.734090636381, 6657.866842663144, 6682.6992785324655, 5892.057270836667, 5905.0, 5910.763569457238, 5963.2247807784925, 5972.343042265347, 5832.066869300913, 5851.268591426072, 5915.704214789265, 5956.076808094752, 6010.188624535697, 5891.970540147315, 5917.497012753921, 5919.052951527757, 5988.461038506533, 6012.338642749294, 5828.766849326022, 5989.700514974255, 5999.550033747487, 6005.579609427342, 6012.098185272201, 5798.391168927286, 5852.590318677694, 5888.322842873039, 5918.112283157518, 5985.162077309136, 6415.262244841856, 6503.804885853385, 6516.055172000081, 6517.771877984248, 6542.4111829935055, 7098.787036388865, 7180.31786980236, 7193.424526037905, 7196.316349946746, 7197.100362454693, 7160.928390716131, 7167.319104685047, 7187.389071928892, 7198.928010719878, 7278.053852999076, 6568.441682456997, 6605.834854128685, 6634.867302654016, 6635.734570617218, 6689.5986240825705, 7194.712211511481, 7205.243449437734, 7303.561786292733, 7358.77923662291, 7378.704851805867, 6956.826079347956, 6969.6166710830375, 7037.120359955005, 7040.0, 7054.894176587355, 7066.364027237573, 7070.1515818101125, 7152.356287934007, 7155.499115061895, 7172.390346820579, 6987.89518157228, 6991.650417479207, 7027.086478757728, 7046.823829404306, 7085.787426377217, 7012.754553590702, 7041.683124259421, 7042.401395881408, 7052.224255331909, 7057.435405167575, 5273.3935597406025, 5347.705876176769, 5351.464853514617, 5356.0894647909945, 5357.973210134002, 4816.325714399987, 4841.515848415201, 4850.781714822841, 4876.609871210295, 4897.730624815669, 6582.868342633121, 6617.33826617344, 6632.1709786276715, 6634.038064480624, 6651.33486651331, 7108.253633368526, 7111.715531378687, 7176.569405835667, 7189.173245076883, 7199.496035277481, 6553.639549824806, 6573.211214654272, 6602.7689030883685, 6672.599644021374, 6682.0, 6070.696465176724, 6107.6640784757265, 6120.17377654011, 6128.387161283925, 6149.354317796567, 7356.889646655304, 7364.484486086029, 7452.478326517092, 7452.701891924262, 7457.47797654159, 6970.546914450544, 7085.999999999897, 7088.0, 7175.748848790267, 7178.102737157856, 7329.9267007329245, 7352.0, 7371.815704607213, 7374.741884034033, 7438.6652600632015, 6979.825504362431, 6999.545029573062, 7066.57600543969, 7076.893846592408, 7087.751928682472, 7109.928900710926, 7111.075560177143, 7116.323949224816, 7201.387882030086, 7205.855882882208, 6750.5274630775375, 6861.897071544031, 6864.073350097673, 6871.175458944758, 6934.687939042856, 6826.146731658543, 6827.761028363983, 6835.658217089026, 6855.965720171367, 6906.585604863724, 6770.52606317553, 6846.4522838173825, 6861.931380686329, 6875.278095799869, 6879.346462086094, 6874.725010999504, 6889.173299204128, 6895.103636527219, 6929.099217101744, 6985.5808651481075, 6600.042993765973, 6626.900596491153, 6686.866262674622, 6689.832754181184, 6698.363655452724], "value": 6520.617625572498, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [978.8923218445972, 989.6338354808722, 1003.3377970539443, 1005.2661557063349, 1008.3042700536629, 45496.54503454969, 45817.0, 46081.30878036832, 46119.077618447656, 46230.30654540181, 43878.34182487265, 43950.560494395046, 44287.77856110715, 44303.55696443035, 44388.0, 8074.71738489153, 8217.835643287131, 8221.136780638006, 8227.588620568977, 8234.135415781346, 7950.920490795104, 7971.561564113971, 8021.438499305051, 8023.919760802376, 8036.236557527055, 8854.335924805666, 9002.964659064193, 9003.369764116514, 9005.369624126313, 9053.185213330798, 8944.910550894505, 8973.685920992733, 9002.369834111614, 9007.324450666194, 9011.143941325563, 8804.207621314048, 8820.117988201193, 8852.203301702877, 8861.867071993925, 8878.778030549223, 41318.0, 41579.58420415787, 41614.79192604048, 41736.16527669429, 41755.58244417578, 3855.768653880776, 3883.456316115746, 3890.105275786557, 3894.9610503894883, 3901.473301104343, 33156.0, 33273.500897486556, 33365.332693346, 33390.332193356, 33408.0, 5607.355154157283, 5624.718764061821, 5625.1843482695185, 5686.516646085088, 5704.344000439961, 223565.0, 224289.0, 225268.0, 225739.0, 226580.8670956651, 47800.521994780305, 48948.75525622349, 54653.45346546563, 55056.0, 55261.72369138129, 57596.71201643965, 57826.42173578295, 57943.71028144832, 58048.709756450946, 58113.70943145342, 19015.33446329372, 19015.33446329372, 19023.52441188981, 19148.329808456638, 19149.138288777038, 15584.0, 15757.68484630301, 15774.211289435712, 15785.763213551805, 15796.289166987513, 15695.529134125994, 15758.290876910567, 15815.920920395325, 15823.920880395524, 15828.76256856148, 6170.7223174957235, 6255.624662520263, 6269.498440124779, 6277.2153480814895, 6295.464885484785, 1125.178619607691, 1129.6836885672026, 1135.8864113588575, 1146.4210573660248, 1151.1308961733837, 25966.610500842504, 25991.480170396488, 26297.21108366752, 26548.867255663983, 26608.20175394741, 1244.3902487780922, 1252.1673087396962, 1256.5790460195938, 1264.5574049082747, 1271.510468469646, 13730.862691373159, 13924.37340319688, 14025.948053895998, 14153.009289349853, 14252.358643860844, 296374.0, 323802.0, 324643.0, 327868.0, 328422.35788820905, 65555.67222163858, 65863.0, 66202.0, 66417.0, 66566.0, 1546.9922650386677, 1560.8985415947927, 1561.7813506109153, 1583.0422594330494, 1587.928543215558, 30747.53878691777, 30987.535186972666, 31078.0, 31247.531287031168, 31361.843190784813, 44256.11487770162, 44475.555244448435, 44540.0, 44835.55164448314, 44900.326495103254, 260005.0, 264808.0, 265054.0, 265714.0, 265827.0, 37853.43219851649, 38191.0, 38291.0, 38401.23197535978, 38756.80621596874, 48235.5176448231, 49025.0, 49309.753451232515, 49697.75151124221, 49711.25433118434, 34793.0, 35099.0, 35304.64695353014, 35484.82257588695, 35685.28629427449, 32754.83622581872, 32858.835705821315, 32888.67111328856, 33032.83483582567, 33734.49398258979, 41463.37804932989, 41863.0, 41987.580124198365, 42098.36852447277, 42149.36775948302, 34041.659583403845, 34140.829295853364, 34221.657783422845, 34227.657723422446, 34336.0, 25602.551158117403, 25737.485250294514, 25805.0, 26086.0, 26167.869160654074], "value": 19554.578834140335, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.5403535064133, 643.5931669576528, 644.7231135696991, 647.2715092164759, 657.8815813153633, 23998.16006439775, 24622.138225162143, 24646.753532464714, 24656.630150547757, 24666.876665616648, 26828.329291767717, 27194.5920811188, 27209.0, 27210.863945680292, 27212.04757833476, 6384.968075159618, 6692.263850976401, 6727.495437842157, 6744.629045402501, 6748.190217173946, 6704.765333213339, 6742.494312926526, 6798.116244888182, 6800.047993280945, 6801.557898736566, 6726.899096513556, 6729.461643068567, 6768.966155169217, 7027.648617569127, 7033.156021277454, 6976.651167441608, 7022.859542809167, 7023.157221133446, 7029.578225306473, 7043.788686339418, 6577.769778057793, 6585.374389433044, 6596.637184954826, 6600.141981542417, 6622.801315960529, 29934.101976940725, 31119.06642800697, 31188.376232475224, 31588.210294742585, 31592.684073159206, 2421.721502027272, 2427.538767634144, 2432.0879670123704, 2432.70807503099, 2461.655368248447, 21573.137074517, 21715.674264886038, 21770.564588708137, 21800.0, 21972.560548788933, 2602.2973797074874, 2642.5903984882375, 2670.6661667291587, 2699.4601079783924, 2700.9324766880986, 145278.0, 151950.24024879804, 161880.0, 166304.16847915805, 167091.1645441777, 16639.6672066558, 17014.404495842587, 17045.40341088056, 17115.74326385105, 17265.39571115005, 27400.177994660193, 27593.44813103727, 27621.171364859085, 27676.584851227246, 27737.167884963485, 11384.203105782515, 11596.942015290038, 11716.472758725879, 11789.528418863149, 11816.940915295369, 10364.222683298784, 10560.788784224273, 10626.893731062744, 10708.518116684612, 10762.461876906124, 10088.74778130538, 10221.131203847608, 10337.950304660144, 10589.9470502647, 10620.362778233331, 2886.163012726286, 2904.3755592547705, 2963.4962056450454, 3039.2705750619693, 3065.310305181361, 1058.2327812335996, 1069.0445352196903, 1091.9181061420425, 1093.9989909233122, 1097.1332647208776, 21425.250116246167, 21779.67330490044, 21783.455413614785, 21855.235066772588, 21903.780962190493, 1149.143887803575, 1155.6879642496478, 1157.4675649201292, 1172.4899668643995, 1184.6505280942142, 11630.53477860893, 11849.644510664693, 11956.52173913051, 12053.758924821455, 12136.514539418324, 624534.0, 631981.0, 644581.0, 647577.0, 653414.0, 129815.0, 132676.0, 133901.3304933469, 135503.0, 135533.3223333877, 1191.195942738648, 1234.388977456147, 1295.5206573567652, 1308.4439113376968, 1346.2730125731996, 22108.557828843655, 22321.330360089225, 22585.193184545526, 22587.548249035255, 22604.208852690077, 63824.36175638184, 64346.35653643404, 65653.34346656472, 66590.33409665841, 66974.3302566968, 83016.58491707503, 83096.58451707703, 83317.58341208255, 83492.58253708936, 83602.58198708968, 16125.516234512983, 16261.105639189958, 16399.0, 16430.0, 16549.751753723944, 24260.0, 24697.87651061733, 24799.380015499035, 24870.12954546582, 25177.622335665346, 19540.21839126419, 19738.30915917936, 19746.111424985622, 20116.0, 20125.698114528, 17883.0, 17903.910480448034, 17976.460706178834, 18321.633567328314, 18587.628247434706, 19919.0, 20516.897415512827, 20745.481362966046, 20781.58436831285, 20895.910408958982, 16186.190690465664, 16186.595335116715, 16197.271122799739, 16221.0, 16454.917725411295, 19930.501737456678, 19969.400917972485, 20369.083391247725, 20414.69377959302, 20471.181152753725], "value": 13352.448232076902, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.2221778022088, 1518.9392424303026, 1522.649790548174, 1535.431890200626, 1535.7773122897174, 17384.73922891156, 18009.549761255974, 18135.546611334692, 18144.002079885602, 18172.727409088875, 17729.29082836685, 17863.64272714545, 17976.0, 18023.819761802377, 18032.278708851663, 3150.212446888278, 3177.4121787469276, 3219.3561287742427, 3219.4687876500348, 3220.5652236948063, 3078.599782028344, 3133.88746994817, 3150.2596889730894, 3167.3190264093214, 3168.572242747234, 3069.6316442026878, 3176.3488484860663, 3180.697833705806, 3182.268078341971, 3183.697548732867, 3139.1838122088193, 3153.085605174508, 3169.8732050717945, 3175.650678425383, 3176.190071531768, 3076.7846250762454, 3115.5949726535405, 3119.157827386593, 3124.9218769530944, 3174.904752857418, 17573.64852702939, 17831.465056048208, 17847.0, 17850.91074544632, 17864.55338616532, 8899.15458031486, 9210.49342286174, 9233.122853328923, 9234.261259099256, 9241.168294853429, 5603.355614104389, 5795.565332600072, 5904.1734157218025, 5946.583739138262, 5960.314563825173, 2119.5972765174565, 2152.956940861174, 2195.3304242206123, 2221.7000704904794, 2233.553289342138, 33002.339953201044, 33370.0, 33398.33203335944, 33399.83300083484, 33420.665793342, 7483.550986940692, 7544.47188696786, 7559.811004724816, 7784.844303113906, 7825.217478252129, 20532.794672053387, 20565.794342056688, 20580.0, 20580.691289630668, 20665.793342066387, 8839.513826739463, 9083.137101975302, 9083.364164508554, 9087.727368178965, 9090.636374544943, 8021.959890200512, 8192.54940978252, 8284.295834854105, 8284.668613255402, 8324.292435143081, 5972.074328479092, 5983.3545774912245, 6129.448349648464, 6153.784617538365, 6172.321044685081, 1609.4125644139804, 1666.2002238925384, 1676.5054308978881, 1720.7590937268792, 1760.8063113057553, 1032.8450732390052, 1043.8068957242933, 1048.8479170520231, 1052.5421441672897, 1065.5790962569743, 10345.482725863676, 10409.5836166554, 10432.582696692047, 10436.37381757097, 10513.0, 1103.448275862069, 1117.541807858774, 1117.9161562882653, 1122.1303489795473, 1128.4019469681082, 5612.045952188138, 5652.123920792284, 6367.363263673596, 6574.342565743387, 6715.6977935993, 26748.0, 26834.0, 27328.316792080357, 27727.584086238723, 27739.583906241423, 25304.873475632503, 27359.179224623294, 27431.725682743316, 27632.58551121735, 27725.58411623827, 11879.168458208016, 12664.430100645493, 12736.872631273569, 12926.935365323114, 12990.675233119058, 10062.798744025225, 10180.338278011906, 10281.12610428122, 10296.330738501973, 10392.116670083127, 21626.891865540572, 22847.0, 23142.537149257256, 23283.0, 23461.882690586437, 23497.647535286644, 23637.881810590836, 23850.0, 23916.52166956686, 24726.752732472443, 12799.744005120032, 12855.871441285468, 12871.613851584467, 13013.804792928304, 13031.413586388824, 16292.0, 16318.102504362374, 16468.42360517376, 16475.917620411823, 16486.25811838494, 13379.933100334436, 13437.193768373929, 13527.729445411234, 13634.590962271148, 13645.727085458433, 12644.936775316064, 12650.05124615676, 12799.168054076456, 13199.604011879659, 13274.93362533181, 10494.950504949444, 10773.192010599394, 10777.51501182433, 10841.837372439262, 11001.559937602726, 8398.790030249293, 8518.23335899772, 8556.529390883561, 8634.179752923714, 8652.0, 8561.905666128643, 8567.61445734931, 8569.400141990001, 8612.698555550525, 8750.824983500166], "value": 7826.14330980681, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.2203349210628, 590.7755053079829, 593.4895989449074, 604.0848115105613, 607.6566739792017, 6602.834929126769, 6615.14775862758, 6648.867022659544, 6683.331666833326, 6690.3644153805435, 6430.45341146002, 6495.213816200548, 6504.512161587876, 6519.44584710299, 6521.6739163041775, 5321.920171197435, 5346.866328341784, 5365.222042803791, 5370.543503802162, 5377.542908852753, 4994.750262486879, 5089.872753181163, 5139.331886854722, 5261.868453288679, 5343.118385466393, 5093.821716239932, 5098.490150984909, 5123.103456895047, 5129.153689641204, 5150.716710580917, 5060.342155519796, 5068.3917929848285, 5082.288479612838, 5110.2590124431745, 5137.948620513785, 4666.3900954171095, 4687.835925742583, 4689.577937985598, 4755.191617425046, 4756.096341695102, 6401.871962560769, 6436.678166091677, 6445.903311450332, 6450.129232553592, 6469.32072132424, 5958.910616340759, 6011.12838638395, 6058.787942421994, 6101.115338275969, 6102.26772787264, 6763.492738044617, 6783.559068660521, 6797.388235058868, 6803.557768745065, 6851.588904665736, 5049.64652474327, 5177.119889618773, 5230.3985041719925, 5234.136367499358, 5266.368035835724, 7030.29697030298, 7084.858302833966, 7107.964460177718, 7144.928550714479, 7153.749618763319, 5381.515663590296, 5408.620207108859, 5441.918371224435, 5443.156310771837, 5470.671759694431, 5442.727863606804, 5451.754671039813, 5483.643563168382, 5512.283403157644, 5519.834404967857, 6041.879162416815, 6075.513958883279, 6076.331603523698, 6093.360197179321, 6124.836281106575, 6866.661001104837, 6877.933920242371, 6949.166100067923, 6950.582965022115, 6965.547239429421, 1838.7333836593618, 1868.8693340529055, 1870.2892900697648, 1877.6807942649782, 1898.9620207595772, 1295.436485128972, 1308.5093090091216, 1330.2417621955585, 1335.7595632785997, 1357.178906761415, 6290.6789574189015, 6299.244090709144, 6368.936310636927, 6398.520110991694, 6436.7425302988295, 6824.873895807136, 6834.760783372558, 6840.623765692835, 6976.441884649216, 6986.196587392414, 6319.58922670025, 6329.968350158219, 6374.426301632875, 6417.427730206129, 6472.190976127984, 3616.4213725803747, 3634.9091272717865, 3650.361186792301, 3677.1726361568435, 3698.5746639136305, 7246.695594792988, 7263.491555591164, 7284.162321333115, 7284.526505777108, 7327.780166595011, 7059.89410158848, 7135.928640713526, 7175.964120179366, 7176.96411517939, 7204.243554426815, 7089.326513981164, 7143.9285607143265, 7200.111939552583, 7225.277472252733, 7262.963685181646, 6822.420094292041, 6908.5509441886115, 6921.6193109379465, 6922.723091076301, 6926.757563485254, 6870.862582748217, 6901.309869013058, 6914.999999999799, 6930.48021398387, 6979.2671769465505, 7033.964830175816, 7119.822004449723, 7135.250798666273, 7239.239879812754, 7254.0, 5336.786528538815, 5343.839684809462, 5369.335505993155, 5391.75737091824, 5422.430644782241, 6637.435817955527, 6812.25065242813, 6847.965760171366, 7016.824579385556, 7032.964835175791, 6675.899861501985, 6694.430973367318, 6712.871583975917, 6831.0, 6839.69221385029, 6728.932710673026, 6760.256371799, 6766.458683305225, 6792.796216113525, 6900.6204658744255, 6680.9978503222965, 6683.8663226734225, 6687.528743676384, 6714.731410743516, 6810.863782724218, 6755.695993680198, 6801.171168470441, 6826.371846838903, 6884.483663725341, 6921.757738479129, 6301.1411633567295, 6502.414782669393, 6589.736410543716, 6653.367930046637, 6684.264730879502], "value": 5357.1045868639885, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [987.5013118375219, 990.9009099090097, 1003.9949800250998, 1013.9391636501811, 1036.4403222259984, 21207.787922120773, 21734.56530869382, 21761.3471595852, 21764.347069587897, 21785.128594856225, 17333.22000509977, 17450.3019879205, 19670.70493942592, 20599.897000514975, 20912.16351345948, 1062.3466568060626, 1102.7132945434164, 1102.7794441111769, 1102.85662863828, 1103.1615971861404, 1073.2272763610188, 1111.7998760223156, 1119.278065647661, 1122.5229277557005, 1125.673554669149, 1179.2747460311932, 1180.9881901180963, 1183.9822402663967, 1184.3486082654506, 1184.4255536065002, 1164.9650510484698, 1165.300819508301, 1167.7722844045416, 1174.166341897254, 1174.2308787744041, 860.389123722158, 861.8836457078277, 864.7405778266495, 869.5304535550795, 870.499462808881, 21092.89453552738, 21201.8939905301, 21403.785962140337, 21674.891625541928, 22751.886240568856, 20973.5805283895, 21466.463338416663, 21471.24850630236, 21519.78480215209, 21540.461488462755, 19268.710969335472, 19400.902995485074, 20014.399568012985, 20107.698384524243, 20161.0, 4128.4632997710105, 4145.647619952308, 4196.265653510654, 4201.621854033121, 4206.074663574009, 164872.0, 170867.0, 172523.1373843123, 172983.0, 173000.0, 17432.738508922375, 17790.199441024924, 17884.642307154045, 17887.463376098738, 17955.910220449074, 35222.0, 36008.63991360105, 36102.638973610454, 36113.0, 36135.638643613755, 9002.234810041089, 9047.095290470901, 9125.543722813833, 9155.0, 9278.304127190488, 4747.715137091785, 4821.9035619287415, 4823.252395878644, 4823.493533179036, 4825.758712064383, 5889.204957330791, 6000.729967151488, 6048.0, 6165.352637972948, 6167.321594624587, 1138.3568283919558, 1149.7125718570358, 1164.3596022187762, 1169.7251145980688, 1172.5309876049648, 755.0825746717765, 767.8272388712606, 771.1286246541372, 774.4191856107919, 796.2117503671324, 12985.480580776662, 13470.663233419244, 13604.251766152956, 14131.434742610387, 14227.146371217554, 752.0, 758.6548120605222, 761.4859969520552, 766.8772996320673, 769.8806684963839, 6356.459700925473, 6374.904376434357, 6436.871262574722, 6444.258910225384, 6456.870862582722, 152240.0, 155635.0, 155961.2201938983, 157529.0, 158947.0, 136985.0, 139466.0, 140667.0, 142109.28945355208, 146991.2650436741, 117982.41008795073, 120763.0, 121018.0, 122166.0, 123203.0, 11984.76030479403, 12109.636710898687, 12152.939235303767, 12194.634160975185, 12215.167724841345, 55505.0, 56966.43033569777, 57146.714266428404, 57369.71315143398, 57965.0, 72261.6386918062, 72449.27550724425, 73043.63478182787, 73671.0, 76489.23510765044, 17736.91131544334, 17797.644047119244, 17871.463856084338, 17961.0, 17980.730289045412, 17641.558961026076, 18302.26790928348, 18341.082945852922, 18483.445496635122, 18508.259669613064, 17096.14519274056, 17215.741763873302, 17233.56916077108, 17429.215685294446, 17450.650986979934, 18792.812071879107, 18826.341078062203, 18858.905705471934, 18927.905360473662, 19003.90498047501, 17713.557161071076, 17816.91091544534, 17940.641187176443, 18084.81915180884, 18107.275708971494, 12155.756884862076, 12215.450304736485, 12228.082893782825, 12252.75494490123, 12258.203216791237, 11630.360330181922, 11650.6504804856, 11709.473073711873, 11779.941100294443, 11880.524779008743], "value": 10115.450577819485, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1358.3000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 104.0, 105.0, 106.0, 107.0, 108.0, 106.0, 108.0, 106.0], "value": 106.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 111.0, 112.0, 111.0, 134.0, 112.0, 116.0, 113.0], "value": 114.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 163.0, 162.0, 163.0, 162.0, 163.0, 164.0, 161.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 72.0, 71.0, 72.0, 72.0, 72.0, 73.0, 73.0], "value": 72.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 77.0, 76.0, 78.0, 78.0, 78.0, 77.0, 77.0, 79.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 113.0, 113.0, 114.0, 114.0, 116.0, 114.0, 117.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 150.0, 149.0, 149.0, 148.0, 150.0, 150.0, 150.0, 149.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 93.0, 94.0, 94.0, 94.0, 94.0, 96.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 45.0, 44.0, 44.0, 44.0, 46.0, 45.0, 45.0, 44.0, 44.0], "value": 44.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 41.0, 37.0, 38.0, 37.0, 38.0, 37.0, 37.0, 37.0], "value": 37.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 68.0, 70.0, 69.0, 78.0, 70.0, 76.0, 70.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 106.0, 100.0, 101.0, 108.0, 105.0, 104.0, 109.0, 101.0, 105.0], "value": 104.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 151.0, 158.0, 147.0, 149.0, 153.0, 147.0, 149.0, 151.0], "value": 151.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 61.0, 59.0, 62.0, 58.0, 58.0, 57.0, 63.0], "value": 59.4, "unit": "score"}]}]} 14:42:33 INFO - Return code: 0 14:42:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:42:33 INFO - # TBPL SUCCESS # 14:42:33 INFO - Running post-action listener: _package_coverage_data 14:42:33 INFO - Running post-action listener: _resource_record_post_action 14:42:33 INFO - [mozharness: 2017-09-22 21:42:33.072374Z] Finished run-tests step (success) 14:42:33 INFO - Running post-run listener: _resource_record_post_run 14:42:33 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 12288; Write bytes: 283672576; Read time: 312; Write time: 267488 14:42:33 INFO - TinderboxPrint: CPU usage
13.0% 14:42:33 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 312 14:42:33 INFO - TinderboxPrint: I/O write bytes / time
283,672,576 / 267,488 14:42:33 INFO - TinderboxPrint: CPU idle
8,182.0 (87.0%) 14:42:33 INFO - TinderboxPrint: CPU user
1,177.5 (12.5%) 14:42:33 INFO - TinderboxPrint: Swap in / out
0 / 0 14:42:33 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9170944; Read time: 0; Write time: 784 14:42:33 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:42:33 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 12288; Write bytes: 274501632; Read time: 312; Write time: 266704 14:42:33 INFO - Running post-run listener: _upload_blobber_files 14:42:33 INFO - Blob upload gear active. 14:42:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:42:33 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 14:42:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:42:34 INFO - (blobuploader) - INFO - Open directory for files ... 14:42:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:42:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:42:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:35 INFO - (blobuploader) - INFO - Done attempting. 14:42:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:42:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:42:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:39 INFO - (blobuploader) - INFO - Done attempting. 14:42:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:42:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:42:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:40 INFO - (blobuploader) - INFO - Done attempting. 14:42:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:42:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:42:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:41 INFO - (blobuploader) - INFO - Done attempting. 14:42:41 INFO - (blobuploader) - INFO - Iteration through files over. 14:42:41 INFO - Return code: 0 14:42:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:42:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:42:41 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ae0dbe76f897ff45e62bc32f0ba99da27df61451b9f22c4aa232878112ca51d154d7a59d76dd0ef7008aa9a3e4b8f53a000554ff9269a4bd06b3bd5d5f14810d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/49cad9f004e7461286b5d1371c40ad54ffb3c192d0627a43011fd5a646a15e1ae141442a7b24de98a784482d8e6a3901f29ed0789604112f4e41c2a81451ff0b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/23095f46d6e48c064120437b301c74b2474ea20ca530a1974062bb8c3728b23f61627babade32ed9defd60960d181dbef581b6eb1286ade5f796f5165fb10ea8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/85837b3330f389cfcecd9a72a9b626531ff5c6edb52fb86a54cdd702ef49900474c5220fc3068a842aa276c66807685be9f4ca4bd5f7835c2df65e9817d56101"} 14:42:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:42:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:42:41 INFO - Contents: 14:42:41 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ae0dbe76f897ff45e62bc32f0ba99da27df61451b9f22c4aa232878112ca51d154d7a59d76dd0ef7008aa9a3e4b8f53a000554ff9269a4bd06b3bd5d5f14810d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/49cad9f004e7461286b5d1371c40ad54ffb3c192d0627a43011fd5a646a15e1ae141442a7b24de98a784482d8e6a3901f29ed0789604112f4e41c2a81451ff0b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/23095f46d6e48c064120437b301c74b2474ea20ca530a1974062bb8c3728b23f61627babade32ed9defd60960d181dbef581b6eb1286ade5f796f5165fb10ea8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/85837b3330f389cfcecd9a72a9b626531ff5c6edb52fb86a54cdd702ef49900474c5220fc3068a842aa276c66807685be9f4ca4bd5f7835c2df65e9817d56101"} 14:42:41 INFO - Running post-run listener: copy_logs_to_upload_dir 14:42:41 INFO - Copying logs to upload dir... 14:42:41 INFO - mkdir: /builds/slave/test/build/upload/logs 14:42:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.790028 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2017-09-22 14:42:41.279092) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 14:42:41.285153) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ae0dbe76f897ff45e62bc32f0ba99da27df61451b9f22c4aa232878112ca51d154d7a59d76dd0ef7008aa9a3e4b8f53a000554ff9269a4bd06b3bd5d5f14810d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/49cad9f004e7461286b5d1371c40ad54ffb3c192d0627a43011fd5a646a15e1ae141442a7b24de98a784482d8e6a3901f29ed0789604112f4e41c2a81451ff0b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/23095f46d6e48c064120437b301c74b2474ea20ca530a1974062bb8c3728b23f61627babade32ed9defd60960d181dbef581b6eb1286ade5f796f5165fb10ea8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/85837b3330f389cfcecd9a72a9b626531ff5c6edb52fb86a54cdd702ef49900474c5220fc3068a842aa276c66807685be9f4ca4bd5f7835c2df65e9817d56101"} build_url:https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/HVyj_f7wQ8mtYJAdYYI9bA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ae0dbe76f897ff45e62bc32f0ba99da27df61451b9f22c4aa232878112ca51d154d7a59d76dd0ef7008aa9a3e4b8f53a000554ff9269a4bd06b3bd5d5f14810d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/49cad9f004e7461286b5d1371c40ad54ffb3c192d0627a43011fd5a646a15e1ae141442a7b24de98a784482d8e6a3901f29ed0789604112f4e41c2a81451ff0b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/23095f46d6e48c064120437b301c74b2474ea20ca530a1974062bb8c3728b23f61627babade32ed9defd60960d181dbef581b6eb1286ade5f796f5165fb10ea8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/85837b3330f389cfcecd9a72a9b626531ff5c6edb52fb86a54cdd702ef49900474c5220fc3068a842aa276c66807685be9f4ca4bd5f7835c2df65e9817d56101"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 14:42:41.321102) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 14:42:41.321543) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1506110179.17849-527069291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 14:42:41.406708) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 14:42:41.407160) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 14:42:41.407595) ========= ========= Total master_lag: 0.25 =========