builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-076 starttime: 1507200656.55 results: success (0) revision: aff9435e51e0f183a552237f6fd44f648a68e094 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-05 03:50:56.548714) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-05 03:50:56.549284) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-05 03:50:56.549623) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-05 03:50:56.567070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-05 03:50:56.567377) ========= 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=9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-05 03:50:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.3M=0s 2017-10-05 03:50:56 (69.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126219 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-05 03:50:56.711759) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-05 03:50:56.715181) ========= 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=9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019555 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-05 03:50:56.767909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-05 03:50:56.768266) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev aff9435e51e0f183a552237f6fd44f648a68e094 --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 aff9435e51e0f183a552237f6fd44f648a68e094 --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=9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-05 03:50:56,834 truncating revision to first 12 chars 2017-10-05 03:50:56,834 Setting DEBUG logging. 2017-10-05 03:50:56,834 attempt 1/10 2017-10-05 03:50:56,834 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/aff9435e51e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-05 03:50:58,009 unpacking tar archive at: mozilla-beta-aff9435e51e0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.455373 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-05 03:50:58.240823) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-05 03:50:58.244455) ========= script_repo_revision: aff9435e51e0f183a552237f6fd44f648a68e094 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-05 03:50:58.245060) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-05 03:50:58.245332) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-05 03:50:58.263696) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2017-10-05 03:50:58.264071) ========= /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=9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:50:58 INFO - MultiFileLogger online at 20171005 03:50:58 in /builds/slave/test 03:50:58 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 03:50:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:50:58 INFO - {'append_to_log': False, 03:50:58 INFO - 'base_work_dir': '/builds/slave/test', 03:50:58 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 03:50:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:50:58 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 03:50:58 INFO - 'buildbot_json_path': 'buildprops.json', 03:50:58 INFO - 'code_coverage': False, 03:50:58 INFO - 'config_files': ('talos/linux_config.py',), 03:50:58 INFO - 'default_actions': ('clobber', 03:50:58 INFO - 'read-buildbot-config', 03:50:58 INFO - 'download-and-extract', 03:50:58 INFO - 'populate-webroot', 03:50:58 INFO - 'create-virtualenv', 03:50:58 INFO - 'install', 03:50:58 INFO - 'setup-mitmproxy', 03:50:58 INFO - 'run-tests'), 03:50:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:50:58 INFO - 'disable_ccov_upload': False, 03:50:58 INFO - 'disable_stylo': False, 03:50:58 INFO - 'download_minidump_stackwalk': True, 03:50:58 INFO - 'download_symbols': 'ondemand', 03:50:58 INFO - 'enable_stylo': False, 03:50:58 INFO - 'enable_webrender': False, 03:50:58 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:50:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:50:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:50:58 INFO - 'gecko_profile': False, 03:50:58 INFO - 'gecko_profile_interval': 0, 03:50:58 INFO - 'installer_path': 'installer.exe', 03:50:58 INFO - 'log_level': 'info', 03:50:58 INFO - 'log_name': 'talos', 03:50:58 INFO - 'log_to_console': True, 03:50:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:50:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:50:58 INFO - 'opt_config_files': (), 03:50:58 INFO - 'pip_index': False, 03:50:58 INFO - 'suite': 'dromaeojs-e10s', 03:50:58 INFO - 'system_bits': '32', 03:50:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:50:58 INFO - 'title': 'talos-linux64-ix-076', 03:50:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:50:58 INFO - 'use_talos_json': True, 03:50:58 INFO - 'verify': 'False', 03:50:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:50:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:50:58 INFO - 'work_dir': 'build'} 03:50:58 INFO - [mozharness: 2017-10-05 10:50:58.469785Z] Running clobber step. 03:50:58 INFO - Running pre-action listener: _resource_record_pre_action 03:50:58 INFO - Running main action method: clobber 03:50:58 INFO - rmtree: /builds/slave/test/build 03:50:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:50:59 INFO - Running post-action listener: _resource_record_post_action 03:50:59 INFO - [mozharness: 2017-10-05 10:50:59.462252Z] Finished clobber step (success) 03:50:59 INFO - [mozharness: 2017-10-05 10:50:59.462349Z] Running read-buildbot-config step. 03:50:59 INFO - Running pre-action listener: _resource_record_pre_action 03:50:59 INFO - Running main action method: read_buildbot_config 03:50:59 INFO - Using buildbot properties: 03:50:59 INFO - { 03:50:59 INFO - "project": "", 03:50:59 INFO - "product": "firefox", 03:50:59 INFO - "who": "ffxbld@noreply.mozilla.org", 03:50:59 INFO - "installer_path": "public/build/target.tar.bz2", 03:50:59 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 03:50:59 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 03:50:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 03:50:59 INFO - "stage_platform": "linux64", 03:50:59 INFO - "basedir": "/builds/slave/test", 03:50:59 INFO - "buildnumber": 159, 03:50:59 INFO - "platform": "ubuntu64_hw", 03:50:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:50:59 INFO - "slavebuilddir": "test", 03:50:59 INFO - "taskId": "VIqrFpz7QoSUujhegtFG2g", 03:50:59 INFO - "branch": "mozilla-beta", 03:50:59 INFO - "script_repo_revision": "production", 03:50:59 INFO - "revision": "aff9435e51e0f183a552237f6fd44f648a68e094", 03:50:59 INFO - "slavename": "talos-linux64-ix-076", 03:50:59 INFO - "repo_path": "releases/mozilla-beta" 03:50:59 INFO - } 03:50:59 INFO - Finding installer, test and symbols from parent task. 03:50:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VIqrFpz7QoSUujhegtFG2g'}, attempt #1 03:50:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VIqrFpz7QoSUujhegtFG2g'}, attempt #1 03:51:00 INFO - Task dependencies: IS7zatsMTCq1Es8WUuizWw 03:51:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw'}, attempt #1 03:51:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.tar.bz2 03:51:00 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.test_packages.json 03:51:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.crashreporter-symbols.zip 03:51:00 INFO - Running post-action listener: _resource_record_post_action 03:51:00 INFO - [mozharness: 2017-10-05 10:51:00.811202Z] Finished read-buildbot-config step (success) 03:51:00 INFO - [mozharness: 2017-10-05 10:51:00.811422Z] Running download-and-extract step. 03:51:00 INFO - Running pre-action listener: _resource_record_pre_action 03:51:00 INFO - Running main action method: download_and_extract 03:51:00 INFO - mkdir: /builds/slave/test/build/tests 03:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:00 INFO - trying https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.test_packages.json 03:51:00 INFO - Downloading https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:51:01 INFO - Downloaded 989 bytes. 03:51:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:51:01 INFO - Using the following test package requirements: 03:51:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:51:01 INFO - u'common': [u'target.common.tests.zip'], 03:51:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:51:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:51:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:51:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:51:01 INFO - u'mozbase': [u'target.common.tests.zip'], 03:51:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:51:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:51:01 INFO - u'web-platform': [u'target.common.tests.zip', 03:51:01 INFO - u'target.web-platform.tests.tar.gz'], 03:51:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:51:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:51:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.common.tests.zip 03:51:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:51:01 INFO - Fetch https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.common.tests.zip into memory 03:51:02 INFO - Content-Length response header: 55179363 03:51:02 INFO - Bytes received: 55179363 03:51:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.talos.tests.zip 03:51:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:51:13 INFO - Fetch https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.talos.tests.zip into memory 03:51:13 INFO - Content-Length response header: 14509224 03:51:13 INFO - Bytes received: 14509224 03:51:14 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')]} 03:51:14 INFO - trying https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.tar.bz2 03:51:14 INFO - Downloading https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:51:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:51:15 INFO - Downloaded 55324877 bytes. 03:51:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.tar.bz2 03:51:15 INFO - mkdir: /builds/slave/test/properties 03:51:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:51:15 INFO - Writing to file /builds/slave/test/properties/build_url 03:51:15 INFO - Contents: 03:51:15 INFO - build_url:https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.tar.bz2 03:51:15 INFO - Running post-action listener: _resource_record_post_action 03:51:15 INFO - Running post-action listener: find_tests_for_verification 03:51:15 INFO - Running post-action listener: set_extra_try_arguments 03:51:15 INFO - [mozharness: 2017-10-05 10:51:15.768858Z] Finished download-and-extract step (success) 03:51:15 INFO - [mozharness: 2017-10-05 10:51:15.768957Z] Running populate-webroot step. 03:51:15 INFO - Running pre-action listener: _resource_record_pre_action 03:51:15 INFO - Running main action method: populate_webroot 03:51:15 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:51:15 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:51:15 INFO - 'tests': ['tresize', 03:51:15 INFO - 'tcanvasmark']}, 03:51:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:51:15 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:51:15 INFO - 'tests': ['dromaeo_css', 03:51:15 INFO - 'kraken']}, 03:51:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:51:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:15 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:51:15 INFO - 'talos_options': ['--disable-stylo'], 03:51:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:51:15 INFO - 'tests': ['damp', 'tps']}, 03:51:15 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:51:15 INFO - 'talos_options': ['--disable-stylo'], 03:51:15 INFO - 'tests': ['damp', 'tps']}, 03:51:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:51:15 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:51:15 INFO - 'tests': ['dromaeo_dom']}, 03:51:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:51:15 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:51:15 INFO - 'tests': ['basic_compositor_video', 03:51:15 INFO - 'glvideo']}, 03:51:15 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:51:15 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:51:15 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:51:15 INFO - 'talos_options': ['--disable-stylo'], 03:51:15 INFO - 'tests': ['ts_paint_webext', 03:51:15 INFO - 'tp5o_webext']}, 03:51:15 INFO - 'other-e10s': {'tests': ['a11yr', 03:51:15 INFO - 'ts_paint', 03:51:15 INFO - 'tpaint', 03:51:15 INFO - 'sessionrestore', 03:51:15 INFO - 'sessionrestore_many_windows', 03:51:15 INFO - 'sessionrestore_no_auto_restore', 03:51:15 INFO - 'tabpaint']}, 03:51:15 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:51:15 INFO - 'tests': ['a11yr', 03:51:15 INFO - 'ts_paint', 03:51:15 INFO - 'tpaint', 03:51:15 INFO - 'sessionrestore', 03:51:15 INFO - 'sessionrestore_many_windows', 03:51:15 INFO - 'sessionrestore_no_auto_restore', 03:51:15 INFO - 'tabpaint']}, 03:51:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:51:15 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:51:15 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:51:15 INFO - 'tests': ['perf_reftest_singletons']}, 03:51:15 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:51:15 INFO - 'tests': ['bloom_basic']}, 03:51:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:51:15 INFO - 'tsvgr_opacity', 03:51:15 INFO - 'tart', 03:51:15 INFO - 'tscrollx', 03:51:15 INFO - 'tsvg_static']}, 03:51:15 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:51:15 INFO - 'tests': ['tsvgx', 03:51:15 INFO - 'tsvgr_opacity', 03:51:15 INFO - 'tart', 03:51:15 INFO - 'tscrollx', 03:51:15 INFO - 'tsvg_static']}, 03:51:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:51:15 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:51:15 INFO - 'talos_options': ['--disable-stylo'], 03:51:15 INFO - 'tests': ['tp5o']}, 03:51:15 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:51:15 INFO - 'talos_options': ['--mitmproxy', 03:51:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:51:15 INFO - '--firstNonBlankPaint'], 03:51:15 INFO - 'tests': ['tp6_google', 03:51:15 INFO - 'tp6_youtube', 03:51:15 INFO - 'tp6_amazon', 03:51:15 INFO - 'tp6_facebook']}, 03:51:15 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:51:15 INFO - 'talos_options': ['--disable-stylo', 03:51:15 INFO - '--mitmproxy', 03:51:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:51:15 INFO - '--firstNonBlankPaint'], 03:51:15 INFO - 'tests': ['tp6_google', 03:51:15 INFO - 'tp6_youtube', 03:51:15 INFO - 'tp6_amazon', 03:51:15 INFO - 'tp6_facebook']}, 03:51:15 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:51:15 INFO - 'talos_options': ['--stylo-threads=1', 03:51:15 INFO - '--mitmproxy', 03:51:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:51:15 INFO - '--firstNonBlankPaint'], 03:51:15 INFO - 'tests': ['tp6_google', 03:51:15 INFO - 'tp6_youtube', 03:51:15 INFO - 'tp6_amazon', 03:51:15 INFO - 'tp6_facebook']}, 03:51:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:51:15 INFO - 'talos_options': ['--xperf_path', 03:51:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:15 INFO - 'tests': ['tp5n']}, 03:51:15 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:51:15 INFO - 'talos_options': ['--disable-stylo', 03:51:15 INFO - '--xperf_path', 03:51:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:15 INFO - 'tests': ['tp5n']}}} 03:51:15 INFO - Running post-action listener: _resource_record_post_action 03:51:15 INFO - [mozharness: 2017-10-05 10:51:15.784048Z] Finished populate-webroot step (success) 03:51:15 INFO - [mozharness: 2017-10-05 10:51:15.784139Z] Running create-virtualenv step. 03:51:15 INFO - Running pre-action listener: _resource_record_pre_action 03:51:15 INFO - Running main action method: create_virtualenv 03:51:15 INFO - Creating virtualenv /builds/slave/test/build/venv 03:51:15 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:51:15 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:51:15 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:51:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:51:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:51:16 INFO - Installing distribute.............................................................................................................................................................................................done. 03:51:16 INFO - Installing pip...............done. 03:51:16 INFO - Return code: 0 03:51:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:51:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:51:16 INFO - Reading from file tmpfile_stdout 03:51:16 INFO - Output received: 03:51:16 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:51:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:51: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')]} 03:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51: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')]} 03:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:16 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 0x28861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5090>, '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 0x2bf5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beff90>, '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': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', '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 03:51:16 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 03:51:16 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 03:51:16 INFO - Using env: {'DISPLAY': ':0', 03:51:16 INFO - 'HOME': '/home/cltbld', 03:51:16 INFO - 'LANG': 'en_US.UTF-8', 03:51:16 INFO - 'LANGUAGE': 'en_US:en', 03:51:16 INFO - 'LOGNAME': 'cltbld', 03:51:16 INFO - 'MAIL': '/var/mail/cltbld', 03:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:16 INFO - 'MOZ_NO_REMOTE': '1', 03:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:16 INFO - 'NO_EM_RESTART': '1', 03:51:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:16 INFO - 'PWD': '/builds/slave/test', 03:51:16 INFO - 'SHELL': '/bin/bash', 03:51:16 INFO - 'SHLVL': '1', 03:51:16 INFO - 'TERM': 'linux', 03:51:16 INFO - 'TMOUT': '86400', 03:51:16 INFO - 'USER': 'cltbld', 03:51:16 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', 03:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:16 INFO - '_': '/tools/buildbot/bin/python'} 03:51:17 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:51:17 INFO - Downloading/unpacking pip>=1.5 03:51:17 INFO - Running setup.py egg_info for package pip 03:51:17 INFO - warning: no files found matching 'pip/cacert.pem' 03:51:17 INFO - warning: no files found matching '*.html' under directory 'docs' 03:51:17 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:51:17 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:51:17 INFO - Installing collected packages: pip 03:51:17 INFO - Found existing installation: pip 1.1 03:51:17 INFO - Uninstalling pip: 03:51:17 INFO - Successfully uninstalled pip 03:51:17 INFO - Running setup.py install for pip 03:51:17 INFO - warning: no files found matching 'pip/cacert.pem' 03:51:17 INFO - warning: no files found matching '*.html' under directory 'docs' 03:51:17 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:51:17 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:51:17 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:51:17 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:51:17 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:51:17 INFO - Successfully installed pip 03:51:17 INFO - Cleaning up... 03:51:17 INFO - Return code: 0 03:51:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:51:17 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')]} 03:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:17 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')]} 03:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:17 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 0x28861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5090>, '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 0x2bf5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beff90>, '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': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', '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 03:51:17 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 03:51:17 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 03:51:17 INFO - Using env: {'DISPLAY': ':0', 03:51:17 INFO - 'HOME': '/home/cltbld', 03:51:17 INFO - 'LANG': 'en_US.UTF-8', 03:51:17 INFO - 'LANGUAGE': 'en_US:en', 03:51:17 INFO - 'LOGNAME': 'cltbld', 03:51:17 INFO - 'MAIL': '/var/mail/cltbld', 03:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:17 INFO - 'MOZ_NO_REMOTE': '1', 03:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:17 INFO - 'NO_EM_RESTART': '1', 03:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:17 INFO - 'PWD': '/builds/slave/test', 03:51:17 INFO - 'SHELL': '/bin/bash', 03:51:17 INFO - 'SHLVL': '1', 03:51:17 INFO - 'TERM': 'linux', 03:51:17 INFO - 'TMOUT': '86400', 03:51:17 INFO - 'USER': 'cltbld', 03:51:17 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', 03:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:17 INFO - '_': '/tools/buildbot/bin/python'} 03:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:18 INFO - Downloading/unpacking psutil>=3.1.1 03:51:18 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 03:51:18 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 03:51:18 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 03:51:18 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 03:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:51:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:19 INFO - Installing collected packages: psutil 03:51:19 INFO - Running setup.py install for psutil 03:51:19 INFO - building 'psutil._psutil_linux' extension 03:51:19 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 03:51:19 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 03:51:19 INFO - building 'psutil._psutil_posix' extension 03:51:19 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 03:51:19 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 03:51:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:20 INFO - Successfully installed psutil 03:51:20 INFO - Cleaning up... 03:51:20 INFO - Return code: 0 03:51:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:51:20 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')]} 03:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:20 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')]} 03:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:20 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 0x28861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5090>, '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 0x2bf5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beff90>, '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': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', '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 03:51:20 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 03:51:20 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 03:51:20 INFO - Using env: {'DISPLAY': ':0', 03:51:20 INFO - 'HOME': '/home/cltbld', 03:51:20 INFO - 'LANG': 'en_US.UTF-8', 03:51:20 INFO - 'LANGUAGE': 'en_US:en', 03:51:20 INFO - 'LOGNAME': 'cltbld', 03:51:20 INFO - 'MAIL': '/var/mail/cltbld', 03:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:20 INFO - 'MOZ_NO_REMOTE': '1', 03:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:20 INFO - 'NO_EM_RESTART': '1', 03:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:20 INFO - 'PWD': '/builds/slave/test', 03:51:20 INFO - 'SHELL': '/bin/bash', 03:51:20 INFO - 'SHLVL': '1', 03:51:20 INFO - 'TERM': 'linux', 03:51:20 INFO - 'TMOUT': '86400', 03:51:20 INFO - 'USER': 'cltbld', 03:51:20 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', 03:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:20 INFO - '_': '/tools/buildbot/bin/python'} 03:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:51:20 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 03:51:20 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 03:51:20 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 03:51:20 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 03:51:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:51:21 INFO - Installing collected packages: mozsystemmonitor 03:51:21 INFO - Running setup.py install for mozsystemmonitor 03:51:22 INFO - Successfully installed mozsystemmonitor 03:51:22 INFO - Cleaning up... 03:51:22 INFO - Return code: 0 03:51:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:51:22 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')]} 03:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:22 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')]} 03:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:22 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 0x28861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5090>, '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 0x2bf5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beff90>, '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': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', '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 03:51:22 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 03:51:22 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 03:51:22 INFO - Using env: {'DISPLAY': ':0', 03:51:22 INFO - 'HOME': '/home/cltbld', 03:51:22 INFO - 'LANG': 'en_US.UTF-8', 03:51:22 INFO - 'LANGUAGE': 'en_US:en', 03:51:22 INFO - 'LOGNAME': 'cltbld', 03:51:22 INFO - 'MAIL': '/var/mail/cltbld', 03:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:22 INFO - 'MOZ_NO_REMOTE': '1', 03:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:22 INFO - 'NO_EM_RESTART': '1', 03:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:22 INFO - 'PWD': '/builds/slave/test', 03:51:22 INFO - 'SHELL': '/bin/bash', 03:51:22 INFO - 'SHLVL': '1', 03:51:22 INFO - 'TERM': 'linux', 03:51:22 INFO - 'TMOUT': '86400', 03:51:22 INFO - 'USER': 'cltbld', 03:51:22 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', 03:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:22 INFO - '_': '/tools/buildbot/bin/python'} 03:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:22 INFO - Downloading/unpacking jsonschema==2.5.1 03:51:22 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 03:51:22 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 03:51:22 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 03:51:22 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 03:51:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:51:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:51:23 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 03:51:23 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 03:51:23 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 03:51:23 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 03:51:23 INFO - Downloading functools32-3.2.3-2.tar.gz 03:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:51:23 INFO - warning: no files found matching '*.txt' 03:51:23 INFO - no previously-included directories found matching 'build' 03:51:23 INFO - no previously-included directories found matching 'dist' 03:51:23 INFO - no previously-included directories found matching '.git*' 03:51:23 INFO - Installing collected packages: jsonschema, functools32 03:51:23 INFO - Running setup.py install for functools32 03:51:24 INFO - warning: no files found matching '*.txt' 03:51:24 INFO - no previously-included directories found matching 'build' 03:51:24 INFO - no previously-included directories found matching 'dist' 03:51:24 INFO - no previously-included directories found matching '.git*' 03:51:24 INFO - Successfully installed jsonschema functools32 03:51:24 INFO - Cleaning up... 03:51:24 INFO - Return code: 0 03:51:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:51:24 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')]} 03:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:24 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')]} 03:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:24 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 0x28861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5090>, '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 0x2bf5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beff90>, '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': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', '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 03:51:24 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 03:51:24 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 03:51:24 INFO - Using env: {'DISPLAY': ':0', 03:51:24 INFO - 'HOME': '/home/cltbld', 03:51:24 INFO - 'LANG': 'en_US.UTF-8', 03:51:24 INFO - 'LANGUAGE': 'en_US:en', 03:51:24 INFO - 'LOGNAME': 'cltbld', 03:51:24 INFO - 'MAIL': '/var/mail/cltbld', 03:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:24 INFO - 'MOZ_NO_REMOTE': '1', 03:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:24 INFO - 'NO_EM_RESTART': '1', 03:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:24 INFO - 'PWD': '/builds/slave/test', 03:51:24 INFO - 'SHELL': '/bin/bash', 03:51:24 INFO - 'SHLVL': '1', 03:51:24 INFO - 'TERM': 'linux', 03:51:24 INFO - 'TMOUT': '86400', 03:51:24 INFO - 'USER': 'cltbld', 03:51:24 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', 03:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:24 INFO - '_': '/tools/buildbot/bin/python'} 03:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:51:24 INFO - Cleaning up... 03:51:24 INFO - Return code: 0 03:51:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:51:24 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')]} 03:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:24 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')]} 03:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:24 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 0x28861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5090>, '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 0x2bf5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beff90>, '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': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', '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 03:51:24 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 03:51:24 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 03:51:24 INFO - Using env: {'DISPLAY': ':0', 03:51:24 INFO - 'HOME': '/home/cltbld', 03:51:24 INFO - 'LANG': 'en_US.UTF-8', 03:51:24 INFO - 'LANGUAGE': 'en_US:en', 03:51:24 INFO - 'LOGNAME': 'cltbld', 03:51:24 INFO - 'MAIL': '/var/mail/cltbld', 03:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:24 INFO - 'MOZ_NO_REMOTE': '1', 03:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:24 INFO - 'NO_EM_RESTART': '1', 03:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:24 INFO - 'PWD': '/builds/slave/test', 03:51:24 INFO - 'SHELL': '/bin/bash', 03:51:24 INFO - 'SHLVL': '1', 03:51:24 INFO - 'TERM': 'linux', 03:51:24 INFO - 'TMOUT': '86400', 03:51:24 INFO - 'USER': 'cltbld', 03:51:24 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', 03:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:24 INFO - '_': '/tools/buildbot/bin/python'} 03:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:24 INFO - Downloading/unpacking blobuploader==1.2.4 03:51:24 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 03:51:24 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 03:51:24 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 03:51:24 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 03:51:25 INFO - Downloading blobuploader-1.2.4.tar.gz 03:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:51:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:51:25 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 03:51:25 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 03:51:25 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 03:51:25 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 03:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:51:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:51:26 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 03:51:26 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 03:51:26 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 03:51:26 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 03:51:26 INFO - Downloading docopt-0.6.1.tar.gz 03:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:51:26 INFO - Installing collected packages: blobuploader, requests, docopt 03:51:26 INFO - Running setup.py install for blobuploader 03:51:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:51:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:51:26 INFO - Running setup.py install for requests 03:51:26 INFO - Running setup.py install for docopt 03:51:26 INFO - Successfully installed blobuploader requests docopt 03:51:26 INFO - Cleaning up... 03:51:26 INFO - Return code: 0 03:51:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:26 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')]} 03:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:26 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')]} 03:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:26 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 0x28861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5090>, '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 0x2bf5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beff90>, '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': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', '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 03:51:26 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 03:51:26 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 03:51:26 INFO - Using env: {'DISPLAY': ':0', 03:51:26 INFO - 'HOME': '/home/cltbld', 03:51:26 INFO - 'LANG': 'en_US.UTF-8', 03:51:26 INFO - 'LANGUAGE': 'en_US:en', 03:51:26 INFO - 'LOGNAME': 'cltbld', 03:51:26 INFO - 'MAIL': '/var/mail/cltbld', 03:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:26 INFO - 'MOZ_NO_REMOTE': '1', 03:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:26 INFO - 'NO_EM_RESTART': '1', 03:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:26 INFO - 'PWD': '/builds/slave/test', 03:51:26 INFO - 'SHELL': '/bin/bash', 03:51:26 INFO - 'SHLVL': '1', 03:51:26 INFO - 'TERM': 'linux', 03:51:26 INFO - 'TMOUT': '86400', 03:51:26 INFO - 'USER': 'cltbld', 03:51:26 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', 03:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:26 INFO - '_': '/tools/buildbot/bin/python'} 03:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:27 INFO - Running setup.py (path:/tmp/pip-v3fyxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:27 INFO - Running setup.py (path:/tmp/pip-ezPJ4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:27 INFO - Running setup.py (path:/tmp/pip-8vxYdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:27 INFO - Running setup.py (path:/tmp/pip-bwxcTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:27 INFO - Running setup.py (path:/tmp/pip-m_TtWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:27 INFO - Running setup.py (path:/tmp/pip-CjlpCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:27 INFO - Running setup.py (path:/tmp/pip-fR39oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:27 INFO - Running setup.py (path:/tmp/pip-w5Hzsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:27 INFO - Running setup.py (path:/tmp/pip-blBC_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:27 INFO - Running setup.py (path:/tmp/pip-UcaG0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:27 INFO - Running setup.py (path:/tmp/pip-7Jzcn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:27 INFO - Running setup.py (path:/tmp/pip-autrRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:27 INFO - Running setup.py (path:/tmp/pip-w3t_YI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:27 INFO - Running setup.py (path:/tmp/pip-J7zbqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:27 INFO - Running setup.py (path:/tmp/pip-lRD7Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:28 INFO - Running setup.py (path:/tmp/pip-nFGy4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:28 INFO - Running setup.py (path:/tmp/pip-AJvMHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:51:28 INFO - Running setup.py install for manifestparser 03:51:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Running setup.py install for mozcrash 03:51:28 INFO - Running setup.py install for mozdebug 03:51:28 INFO - Running setup.py install for mozdevice 03:51:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Running setup.py install for mozfile 03:51:28 INFO - Running setup.py install for mozhttpd 03:51:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Running setup.py install for mozinfo 03:51:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Running setup.py install for mozInstall 03:51:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:51:28 INFO - Running setup.py install for mozleak 03:51:29 INFO - Running setup.py install for mozlog 03:51:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:51:29 INFO - Running setup.py install for moznetwork 03:51:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:51:29 INFO - Running setup.py install for mozprocess 03:51:29 INFO - Running setup.py install for mozprofile 03:51:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:51:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:51:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:51:29 INFO - Running setup.py install for mozrunner 03:51:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:51:29 INFO - Running setup.py install for mozscreenshot 03:51:29 INFO - Running setup.py install for moztest 03:51:29 INFO - Running setup.py install for mozversion 03:51:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:51:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:51:29 INFO - Cleaning up... 03:51:29 INFO - Return code: 0 03:51:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:29 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 0x28861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5090>, '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 0x2bf5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beff90>, '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': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', '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 03:51:29 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 03:51:29 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 03:51:29 INFO - Using env: {'DISPLAY': ':0', 03:51:29 INFO - 'HOME': '/home/cltbld', 03:51:29 INFO - 'LANG': 'en_US.UTF-8', 03:51:29 INFO - 'LANGUAGE': 'en_US:en', 03:51:29 INFO - 'LOGNAME': 'cltbld', 03:51:29 INFO - 'MAIL': '/var/mail/cltbld', 03:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:29 INFO - 'MOZ_NO_REMOTE': '1', 03:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:29 INFO - 'NO_EM_RESTART': '1', 03:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:29 INFO - 'PWD': '/builds/slave/test', 03:51:29 INFO - 'SHELL': '/bin/bash', 03:51:29 INFO - 'SHLVL': '1', 03:51:29 INFO - 'TERM': 'linux', 03:51:29 INFO - 'TMOUT': '86400', 03:51:29 INFO - 'USER': 'cltbld', 03:51:29 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', 03:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:29 INFO - '_': '/tools/buildbot/bin/python'} 03:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:30 INFO - Running setup.py (path:/tmp/pip-hrWjCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:30 INFO - Running setup.py (path:/tmp/pip-HYAtYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:30 INFO - Running setup.py (path:/tmp/pip-Zlwemi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:30 INFO - Running setup.py (path:/tmp/pip-3312j4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:30 INFO - Running setup.py (path:/tmp/pip-EovtLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:30 INFO - Running setup.py (path:/tmp/pip-rCvhXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:30 INFO - Running setup.py (path:/tmp/pip-J29RW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:30 INFO - Running setup.py (path:/tmp/pip-SQcj5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:30 INFO - Running setup.py (path:/tmp/pip-7YwWM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:30 INFO - Running setup.py (path:/tmp/pip-yieVHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:30 INFO - Running setup.py (path:/tmp/pip-k7bl9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:30 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)) 03:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:30 INFO - Running setup.py (path:/tmp/pip-u5rJff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:31 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)) 03:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:31 INFO - Running setup.py (path:/tmp/pip-HkrPD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:31 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)) 03:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:31 INFO - Running setup.py (path:/tmp/pip-NNhxgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:31 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)) 03:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:31 INFO - Running setup.py (path:/tmp/pip-PAUYaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:31 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)) 03:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:31 INFO - Running setup.py (path:/tmp/pip-whBEyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:31 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)) 03:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:31 INFO - Running setup.py (path:/tmp/pip-n1vIm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:31 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)) 03:51:31 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)) 03:51:31 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)) 03:51:31 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)) 03:51:31 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)) 03:51:31 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)) 03:51:31 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)) 03:51:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:51:31 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 03:51:31 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 03:51:31 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 03:51:31 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 03:51:32 INFO - Downloading blessings-1.6.tar.gz 03:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:51:32 INFO - Installing collected packages: blessings 03:51:32 INFO - Running setup.py install for blessings 03:51:32 INFO - Successfully installed blessings 03:51:32 INFO - Cleaning up... 03:51:32 INFO - Return code: 0 03:51:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:51:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:32 INFO - Reading from file tmpfile_stdout 03:51:32 INFO - Current package versions: 03:51:32 INFO - argparse == 1.2.1 03:51:32 INFO - blessings == 1.6 03:51:32 INFO - blobuploader == 1.2.4 03:51:32 INFO - docopt == 0.6.1 03:51:32 INFO - functools32 == 3.2.3-2 03:51:32 INFO - jsonschema == 2.5.1 03:51:32 INFO - manifestparser == 1.1 03:51:32 INFO - mozInstall == 1.13 03:51:32 INFO - mozcrash == 1.0 03:51:32 INFO - mozdebug == 0.1 03:51:32 INFO - mozdevice == 0.51 03:51:32 INFO - mozfile == 1.2 03:51:32 INFO - mozhttpd == 0.7 03:51:32 INFO - mozinfo == 0.10 03:51:32 INFO - mozleak == 0.1 03:51:32 INFO - mozlog == 3.5 03:51:32 INFO - moznetwork == 0.27 03:51:32 INFO - mozprocess == 0.25 03:51:32 INFO - mozprofile == 0.28 03:51:32 INFO - mozrunner == 6.13 03:51:32 INFO - mozscreenshot == 0.1 03:51:32 INFO - mozsystemmonitor == 0.3 03:51:32 INFO - moztest == 0.8 03:51:32 INFO - mozversion == 1.4 03:51:32 INFO - psutil == 3.1.1 03:51:32 INFO - requests == 1.2.3 03:51:32 INFO - wsgiref == 0.1.2 03:51:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51: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')]} 03:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51: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')]} 03:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:32 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 0x28861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5090>, '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 0x2bf5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beff90>, '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': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', '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 03:51:32 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 03:51:32 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 03:51:32 INFO - Using env: {'DISPLAY': ':0', 03:51:32 INFO - 'HOME': '/home/cltbld', 03:51:32 INFO - 'LANG': 'en_US.UTF-8', 03:51:32 INFO - 'LANGUAGE': 'en_US:en', 03:51:32 INFO - 'LOGNAME': 'cltbld', 03:51:32 INFO - 'MAIL': '/var/mail/cltbld', 03:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:32 INFO - 'MOZ_NO_REMOTE': '1', 03:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:32 INFO - 'NO_EM_RESTART': '1', 03:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:32 INFO - 'PWD': '/builds/slave/test', 03:51:32 INFO - 'SHELL': '/bin/bash', 03:51:32 INFO - 'SHLVL': '1', 03:51:32 INFO - 'TERM': 'linux', 03:51:32 INFO - 'TMOUT': '86400', 03:51:32 INFO - 'USER': 'cltbld', 03:51:32 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', 03:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:32 INFO - '_': '/tools/buildbot/bin/python'} 03:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:33 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)) 03:51:33 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)) 03:51:33 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)) 03:51:33 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)) 03:51:33 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)) 03:51:33 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)) 03:51:33 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)) 03:51:33 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)) 03:51:33 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)) 03:51:33 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:51: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 03:51: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 03:51: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 03:51: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 03:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:51:34 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)) 03:51:34 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)) 03:51:34 INFO - Installing collected packages: simplejson 03:51:34 INFO - Running setup.py install for simplejson 03:51:34 INFO - building 'simplejson._speedups' extension 03:51:34 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 03:51:35 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 03:51:35 INFO - Successfully installed simplejson 03:51:35 INFO - Cleaning up... 03:51:35 INFO - Return code: 0 03:51:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:51: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')]} 03:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51: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')]} 03:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5090>, '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 0x2bf5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beff90>, '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': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', '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 03:51: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', 'jsonschema'] in /builds/slave/test/build 03:51: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 jsonschema 03:51:35 INFO - Using env: {'DISPLAY': ':0', 03:51:35 INFO - 'HOME': '/home/cltbld', 03:51:35 INFO - 'LANG': 'en_US.UTF-8', 03:51:35 INFO - 'LANGUAGE': 'en_US:en', 03:51:35 INFO - 'LOGNAME': 'cltbld', 03:51:35 INFO - 'MAIL': '/var/mail/cltbld', 03:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:35 INFO - 'MOZ_NO_REMOTE': '1', 03:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:35 INFO - 'NO_EM_RESTART': '1', 03:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:35 INFO - 'PWD': '/builds/slave/test', 03:51:35 INFO - 'SHELL': '/bin/bash', 03:51:35 INFO - 'SHLVL': '1', 03:51:35 INFO - 'TERM': 'linux', 03:51:35 INFO - 'TMOUT': '86400', 03:51:35 INFO - 'USER': 'cltbld', 03:51:35 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', 03:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:35 INFO - '_': '/tools/buildbot/bin/python'} 03:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:51:35 INFO - Cleaning up... 03:51:35 INFO - Return code: 0 03:51:35 INFO - Running post-action listener: _resource_record_post_action 03:51:35 INFO - Running post-action listener: _start_resource_monitoring 03:51:35 INFO - Starting resource monitoring. 03:51:35 INFO - [mozharness: 2017-10-05 10:51:35.647715Z] Finished create-virtualenv step (success) 03:51:35 INFO - [mozharness: 2017-10-05 10:51:35.648178Z] Running install step. 03:51:35 INFO - Running pre-action listener: _resource_record_pre_action 03:51:35 INFO - Running main action method: install 03:51:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:35 INFO - Reading from file tmpfile_stdout 03:51:35 INFO - Detecting whether we're running mozinstall >=1.0... 03:51:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:51:36 INFO - Reading from file tmpfile_stdout 03:51:36 INFO - Output received: 03:51:36 INFO - Usage: mozinstall [options] installer 03:51:36 INFO - Options: 03:51:36 INFO - -h, --help show this help message and exit 03:51:36 INFO - -d DEST, --destination=DEST 03:51:36 INFO - Directory to install application into. [default: 03:51:36 INFO - "/builds/slave/test"] 03:51:36 INFO - --app=APP Application being installed. [default: firefox] 03:51:36 INFO - mkdir: /builds/slave/test/build/application 03:51:36 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'] 03:51:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:51:50 INFO - Reading from file tmpfile_stdout 03:51:50 INFO - Output received: 03:51:50 INFO - /builds/slave/test/build/application/firefox/firefox 03:51:50 INFO - Running post-action listener: _resource_record_post_action 03:51:50 INFO - [mozharness: 2017-10-05 10:51:50.921680Z] Finished install step (success) 03:51:50 INFO - [mozharness: 2017-10-05 10:51:50.922018Z] Running setup-mitmproxy step. 03:51:50 INFO - Running pre-action listener: _resource_record_pre_action 03:51:50 INFO - Running main action method: setup_mitmproxy 03:51:50 INFO - Skipping: mitmproxy is not required 03:51:50 INFO - Running post-action listener: _resource_record_post_action 03:51:50 INFO - [mozharness: 2017-10-05 10:51:50.923673Z] Finished setup-mitmproxy step (success) 03:51:50 INFO - [mozharness: 2017-10-05 10:51:50.923985Z] Running run-tests step. 03:51:50 INFO - Running pre-action listener: _resource_record_pre_action 03:51:50 INFO - Running pre-action listener: _set_gcov_prefix 03:51:50 INFO - Running main action method: run_tests 03:51:50 WARNING - Try message not found. 03:51:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:51:50 INFO - Python 2.7.3 03:51:50 INFO - Return code: 0 03:51:50 INFO - grabbing minidump binary from tooltool 03:51:50 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')]} 03:51:50 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 0x2bf5090>, '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 0x2bf5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:51:50 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 03:51:50 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 03:51:50 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 03:51:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:51:51 INFO - Return code: 0 03:51:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:51:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:51:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:51:51 INFO - ENV: RUST_BACKTRACE is now full 03:51:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:51:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:51:51 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/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 03:51:51 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/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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 03:51:51 INFO - Using env: {'DISPLAY': ':0', 03:51:51 INFO - 'HOME': '/home/cltbld', 03:51:51 INFO - 'LANG': 'en_US.UTF-8', 03:51:51 INFO - 'LANGUAGE': 'en_US:en', 03:51:51 INFO - 'LOGNAME': 'cltbld', 03:51:51 INFO - 'MAIL': '/var/mail/cltbld', 03:51:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:51:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:51 INFO - 'MOZ_NO_REMOTE': '1', 03:51:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:51 INFO - 'NO_EM_RESTART': '1', 03:51:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:51 INFO - 'PWD': '/builds/slave/test', 03:51:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:51:51 INFO - 'RUST_BACKTRACE': 'full', 03:51:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:51:51 INFO - 'SHELL': '/bin/bash', 03:51:51 INFO - 'SHLVL': '1', 03:51:51 INFO - 'TERM': 'linux', 03:51:51 INFO - 'TMOUT': '86400', 03:51:51 INFO - 'USER': 'cltbld', 03:51:51 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', 03:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:51 INFO - '_': '/tools/buildbot/bin/python'} 03:51:51 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/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 03:51:51 INFO - mozversion application_buildid: 20171005092021 03:51:51 INFO - mozversion application_changeset: aff9435e51e0f183a552237f6fd44f648a68e094 03:51:51 INFO - mozversion application_display_name: Firefox 03:51:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:51:51 INFO - mozversion application_name: Firefox 03:51:51 INFO - mozversion application_remotingname: firefox 03:51:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:51:51 INFO - mozversion application_vendor: Mozilla 03:51:51 INFO - mozversion application_version: 57.0 03:51:51 INFO - mozversion platform_buildid: 20171005092021 03:51:51 INFO - mozversion platform_changeset: aff9435e51e0f183a552237f6fd44f648a68e094 03:51:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:51:51 INFO - mozversion platform_version: 57.0 03:51:51 INFO - using testdate: 1507200711 03:51:51 INFO - actual date: 1507200711 03:51:51 INFO - starting webserver on 'localhost:56436' 03:51:51 INFO - SUITE-START | Running 2 tests 03:51:51 INFO - TEST-START | dromaeo_css 03:51:51 INFO - Initialising browser for dromaeo_css test... 03:51:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56436/getInfo.html -profile /tmp/tmpEhyDia/profile 03:51:51 INFO - TEST-INFO | started process 7555 (/builds/slave/test/build/application/firefox/firefox http://localhost:56436/getInfo.html) 03:51:56 INFO - TEST-INFO | 7555: exit 0 03:51:57 INFO - Browser initialized. 03:51:57 INFO - Running cycle 1/1 for dromaeo_css test... 03:51:57 INFO - Using env: {'DISPLAY': ':0', 03:51:57 INFO - 'HOME': '/home/cltbld', 03:51:57 INFO - 'JSGC_DISABLE_POISONING': '1', 03:51:57 INFO - 'LANG': 'en_US.UTF-8', 03:51:57 INFO - 'LANGUAGE': 'en_US:en', 03:51:57 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:51:57 INFO - 'LOGNAME': 'cltbld', 03:51:57 INFO - 'MAIL': '/var/mail/cltbld', 03:51:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:51:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:51:57 INFO - 'MOZ_CRASHREPORTER': '1', 03:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:57 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:51:57 INFO - 'MOZ_NO_REMOTE': '1', 03:51:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:57 INFO - 'NO_EM_RESTART': '1', 03:51:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:57 INFO - 'PWD': '/builds/slave/test', 03:51:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:51:57 INFO - 'RUST_BACKTRACE': 'full', 03:51:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:51:57 INFO - 'SHELL': '/bin/bash', 03:51:57 INFO - 'SHLVL': '1', 03:51:57 INFO - 'TERM': 'linux', 03:51:57 INFO - 'TMOUT': '86400', 03:51:57 INFO - 'USER': 'cltbld', 03:51:57 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', 03:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:57 INFO - '_': '/tools/buildbot/bin/python'} 03:51:57 INFO - TEST-INFO | started process 7790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEhyDia/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:58 INFO - PID 7790 | 03:51:58 INFO - PID 7790 | (/builds/slave/test/build/application/firefox/firefox:7838): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:51:58 INFO - PID 7790 | 03:52:08 INFO - PID 7790 | RSS: Main: 141656064 03:52:08 INFO - PID 7790 | 03:55:05 INFO - PID 7790 | Cycle 1(1): loaded http://localhost:56436/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56436/tests/dromaeo/cssquery-ext.html) 03:55:06 INFO - PID 7790 | RSS: Main: 145092608 03:55:06 INFO - PID 7790 | 03:58:08 INFO - PID 7790 | Cycle 1(1): loaded http://localhost:56436/tests/dromaeo/cssquery-ext.html (next: http://localhost:56436/tests/dromaeo/cssquery-jquery.html) 03:58:08 INFO - PID 7790 | RSS: Main: 144093184 03:58:08 INFO - PID 7790 | 04:01:10 INFO - PID 7790 | Cycle 1(1): loaded http://localhost:56436/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56436/tests/dromaeo/cssquery-mootools.html) 04:01:11 INFO - PID 7790 | RSS: Main: 145379328 04:01:11 INFO - PID 7790 | 04:04:12 INFO - PID 7790 | Cycle 1(1): loaded http://localhost:56436/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56436/tests/dromaeo/cssquery-prototype.html) 04:04:13 INFO - PID 7790 | RSS: Main: 145227776 04:04:13 INFO - PID 7790 | 04:07:16 INFO - PID 7790 | Cycle 1(1): loaded http://localhost:56436/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56436/tests/dromaeo/cssquery-yui.html) 04:07:16 INFO - PID 7790 | RSS: Main: 146452480 04:07:16 INFO - PID 7790 | 04:10:18 INFO - PID 7790 | Cycle 1(1): loaded http://localhost:56436/tests/dromaeo/cssquery-yui.html (next: http://localhost:56436/tests/dromaeo/cssquery-dojo.html) 04:10:18 INFO - PID 7790 | RSS: Main: 148963328 04:10:18 INFO - PID 7790 | 04:10:18 INFO - PID 7790 | __start_tp_report 04:10:18 INFO - PID 7790 | _x_x_mozilla_page_load 04:10:18 INFO - PID 7790 | _x_x_mozilla_page_load_details 04:10:18 INFO - PID 7790 | |i|pagename|runs| 04:10:18 INFO - PID 7790 | |0;dojo.html;4080.6531444827187;4081.9387709184357;4096.057906681465;4102.692298077644;4102.815373308199;6685.69914353854;6686.7993960181275;6737.966310168448;6788.151481064867;6817.113775209222;6704.3295670432935;6726.058351830748;6799.76200832971;6799.796006119812;6817.2160201576835;6007.639541627505;6033.577649564532;6079.848003799896;6126;6135.631862088267;5944.851378715545;6039.365866584011;6041.577089603729;6057.273127224717;6144.723487443076;5979.1330257112695;5982.79060232892;5989.311229208632;6028;6047.516198704093;5992.0712289595185;6030.155778191057;6036.8188954331445;6072.453479186872;6177.969110154466;5942.702864856783;5980.581359304851;6026.427489388545;6070.21087258658;6120.785772497941;6584.736610535573;6631;6631.1379520662485;6691.698873550702;6697.598144111369;7302.74440394589;7349.118105827281;7354.632268386613;7355;7365.15300740411;7244.893904474295;7323.780286591411;7430.96284518574;7438.921356403345;7449.106107267108;6687.130673012477;6698.062271282024;6778.118844550177;6832.248452670252;6843.965780171067;7489.438292128112;7544.811379715441;7547.433942454338;7550.056242969629;7595.5822429765785;7149.992793348016;7152.821179470555;7182.892256616155;7257.165425976081;7270.200277969419;7285.052943117466;7314.853702926018;7339.633018349061;7391.593462359622;7393.260673932564;7134.857302854018;7231.963840180765;7256.092988376453;7364.263573642593;7369.520981136317;7261.89107163393;7262.382697470668;7334.229905859915;7341.926580734231;7366.1528924173335;5351.785928562814;5359.062164121263;5412.648177868426;5425.6202065855805;5427.457254274541;4849.684770489906;4878;4925.6305777066145;4966.180580204225;4975.701457912464;6819.761308354184;6825.829354266084;6871.9656401717675;6885.449164066863;6905.274946130685;7261.927380726125;7294.963525182447;7303.89044164338;7349.669264883093;7384;6580.309067547934;6708.19501659804;6769.8646027079185;6805.183377994672;6809.625470599066;5970.13433052205;6099.9085013724825;6166.969165154235;6176.197094377702;6178.969105154535;7559.395248380117;7562.584057876869;7669.194734552903;7681.231876812386;7682.270184332479;7223.711051558089;7277.599732014684;7293.452991025588;7316.487845850739;7318.048653675201;7547.0943486781935;7551.320381165721;7571.167171611009;7638.312551870358;7666.310032097138;7173.210946795744;7259.12890453149;7272.672729727069;7278.745243916437;7290.5625662460425;7279.235680253497;7292.307230813064;7293.671784769592;7377.372923301579;7377.4098072155175;6950.061741665013;7037.437005039482;7044.682989265393;7116.43068554504;7119.964400177966;6977.755778547727;7065.293470652894;7081.291870812877;7125.501214914906;7138.928610713826;6976.372126508639;6981.581105133709;7058.258882817436;7059.858802823812;7065.752698655522;7078.362947334765;7116.25279345682;7132.251113632994;7212.675429605575;7242.058532390966;6939.653017349011;6955.23492415844;6998.615076170656;7011.824704382431;7024.121984751906 04:10:18 INFO - PID 7790 | |1;ext.html;976.0824824664815;980.632262901412;1000.8748906386702;1029.644772553469;1040.578565680899;45582;46310;46338;46369;46469.07061858761;43743.78128109363;46934.76532617332;47412.288815667795;47413.28880066793;47643.285350719765;8773.166549177833;8931.553422328858;8937.687180948667;8949.284057275436;8951.955240223822;8748.825023499527;8850.5132217728;8883.555822208897;8900.28797696186;8925.330600204978;8863.734087977371;8882.600282987249;8890.466572005667;8904.643814247422;8920.197182253596;8829.0729473405;8841.292696584322;8843;8862.645494180226;8903.643854245822;8699.130086991314;8828.337874659426;8828.382013259074;8829.028806831244;8831.823363532758;41790.37314440286;42362.788186058875;42411;42471.36292955608;42560.57439425597;3838.4818049563232;3847.03824043989;3853.402722578005;3857.035741064734;3865.9806700966597;34238.6576134238;34266.14334641629;34298.82850585731;34341.141471463416;34524.30951380958;5593.161025846115;5652.773889044433;5654.660720356792;5657.858553536194;5728.455796699307;242199.99999999822;242391;242475;242853;243386;53297.7335113322;53438.19842702363;54101.1884821728;54839.177412338846;55098.44901551013;56210.43789562134;56219.43780562224;56220.718896405255;56369.71815140898;56395;18163.54591135206;18341;18342;18345.908270458563;18349.3577724779;14980.1011939284;14996.100233985995;15088.622784430258;15096.320665569856;15366.308516116802;14871.33079011447;15021.474248401253;15103.093814371174;15212.695746085017;15284.617884552976;5678.119891416837;5698.430156984268;5705.2012718219485;5715.914261286084;5773.480386765127;1086.7717779266284;1098.5166526728215;1098.961536346224;1116.8994790468896;1119.0823524709822;26524.336891577866;26646.600300995502;26647.86676066607;26696.59955100675;26906.730932690814;1219.9939000304942;1230.698478872682;1235.2958813476232;1237.3256575166556;1238.0405185980758;13740.725185496234;13847.515336963157;14018.719625607431;14170.362333695008;14170.433182672577;325767;341950;342814;343991;345429;63660.68169659122;63861.36138638554;64148.67925660342;64534.354656453776;64604;1531.3109100904414;1557.2758667219798;1574.4417616187727;1576.9211539422984;1581.7390130628548;30967.69032309738;31037.67217458745;31729.5240571387;31833.204169895012;32088.03735887927;42683.3597496044;42929.57070429381;42982;42983;43049.569504304556;291308;293327;294054;294394;295772;37867;38785.61214387933;39257.2148557033;39552.20895582015;39636.2072758549;47452;48731.02537949292;49707.50292497173;49882.25176622426;50085;35296.82351588226;36034.4594831083;36099.27801444009;36492.27015459729;36630.45054324134;35981.28037439289;36107.81946090358;36258.63741362658;36401.817990909876;36719.81640091782;40418;41814.581854181066;41849;41871.37192942169;42293.78853105715;34851.825740871136;34880.65119348875;34992.82503587466;35133.82433087818;35473.46789798207;25281.367965800266;25947.351316217246;26101.608475873258;26234.86882565575;26300.342491437867 04:10:18 INFO - PID 7790 | |2;jquery.html;608.2579253310959;623.3454872383995;626.1171747835552;629.7355110853443;642.3480167629855;23976.76023239767;24505.264842054745;24800.87599562002;24885;24888.875555622195;27061.729382706166;28279.151625451217;28285;28332.433351332962;28350.149495515117;6891.759483293018;7122.608256545888;7167.89248161278;7170.569765814042;7180.102487189101;6779.457643388517;7030.29697030298;7067.328603782633;7068.222495525514;7075.080239568849;7037.43700503961;7044.718211271543;7044.753433629824;7053.823654408629;7055.4002909752735;7033.964830175842;7042.154941407039;7045.048918396028;7045.401140903029;7050.330218629222;6578.868422631521;6582.93417065828;6584.703688333989;6592.340765923417;6617.50368722343;31682.207944801336;32789.83605081983;33375.6662433375;33480.832595837106;33555.83222083874;2405.0980882169188;2435.5128974205054;2439.024390243899;2442.8778561072054;2449.2774631483576;21203.151873925024;21699.34901952928;22060.88969555158;22066.558668826696;22268.109275628954;2578.5358635445614;2619.4630100829286;2630.0663264541004;2638.6569745933098;2654.1772050664354;147113;154092;165654;174440;174550.12724936422;16757.329706811834;16955.406560770312;17316.220770065378;17397.913010434866;17480.912595437196;27687;27794.861025695147;27822.582661259694;27909.302267443476;27916.860415697793;11395.316281023164;11631.917541851417;11651.242669226473;11744.706382340339;11906.226095303777;10759.623413180501;10778;10879.728006799734;10939.617113401151;11077.279976801483;10078.14335781452;10138.594456221816;10349.327293725884;10584.788304233873;10617.84073238902;3009.292816188194;3126.515390114536;3133.1070644866104;3177.158053115926;3184.232750823269;1042.8279333909973;1052.8789189243182;1057.5346847387125;1064.4624464645306;1093.4532733633184;21611;22003.33989980303;22244.221452249418;22464.663030054562;22678.433039173822;1109.606089838112;1132.1961407400838;1141.4064686363045;1142.954281828734;1165.5687395663658;12007.87992120085;12042.458089385998;12281;12424.627261182179;12443.937780311222;619157;623844;634260;635809;641034;142710;143027;144493;145731.2713436426;146210;1183.6330737471412;1239.8450193725785;1254.8431446069424;1272.6754677557349;1313.1267706974754;24002.759972400054;24031.279061628178;24238.51522969566;24522.87738561296;24615.13847015346;62159.37840621536;62310.68844655748;62816;62844.68577657083;67412;79344.20655793368;80828.59585702034;80923;82338;82453;16510.091944942662;16874.156292185588;16942.40701575439;16947;17085.23116459787;25560.23319300424;25668.871655641604;25966.480670386863;25985.350366240997;26152.73847261503;20480;20933.267335643788;21346;21495.247666331605;21522.139114435875;18344.633107338046;18447.63104737871;18560.628787424444;18966.52583685419;18990.715139273198;21295.254666086614;21421.464463387918;21753.347399578037;21771.673424898956;21790.45523861916;16320.183990800175;16559.751603726196;16676.916615416845;16681.416150434678;16761.1619419031;20620.690689639367;20646.380608581767;21071.894640526698;21207;21213.833239171377 04:10:18 INFO - PID 7790 | |3;mootools.html;1507.449780829997;1564.9608759780997;1570.1285786388557;1571.2536545141058;1579.439299048837;18128;18435.354762583313;18455.90772046138;18530.722039169406;18531.351402700908;17920.820791792077;17958.371456999008;18069.096545172753;18132.72800907984;18165.909170454128;3006.9097927062166;3114.7819652624325;3117.5323701444736;3117.953230701541;3126.2809553802526;3029.5758593796886;3086.0279012111114;3091.8299493527848;3091.922701932447;3104.8292343921075;3069.723724864773;3184.633767116788;3184.7452203823636;3186.394585028837;3195.3449542843778;3066.9693303066906;3116.22094476382;3145.2451411661264;3147.4806656901583;3158.699923507263;3099.4111118887563;3128.0459459864733;3129;3143.1513491357205;3154.4006638738565;16819.15904204785;17100.657986840317;17290.827091729047;17325.65348693019;17371.478855634352;8516.574171291411;9060.184583387527;9078.81842363149;9110.544472776335;9118.680846170351;6033.1553582498045;6083.752830669702;6222.626642401425;6317.399847014526;6317.463015643676;2205.669149627569;2248.3929339078522;2265.399669087693;2266.4220623741007;2269.2284623228184;31545;31667.524987125213;31674.683253167404;31727.84136079305;31740.841295793605;7679.232076792276;7713.537187768752;7723.266289702469;7814.570198639016;7990.403118986353;20591.588168236853;20598;20602.484937876674;20619;20632.381028569165;8842.602082906285;8957.731268061969;9002.63989440415;9005.954970225239;9016.143466370684;7739.148693643695;8103.513789172551;8169.877451838227;8187.385946053951;8206.302464290482;6119.479844213202;6170.444659980623;6218.378162183745;6229.937700622936;6276.246850377984;1686.1316422042657;1726.326732574297;1737.1661602430652;1788.642271545696;1822.7539282197;912.174482093693;921.7050543826045;925.9907400925905;929.5027160469117;938.2728385501155;10033.949830250802;10055.296129271028;10144.898551014543;10184.134348580306;10190.1338386238;1079.3362082319475;1091.410638255349;1096.3476731344838;1098.8846171152074;1115.481301194932;5650.321961364581;5684.317881854121;6312.652804095819;6318.147050148171;6433.806985790434;25956.480870382486;26454.470910582066;26567.734322656524;26783.330416739347;26846.5973010405;24732.258032259062;25862.353441164123;26039.349016274366;26307.736922630913;26325.473490530083;12867.806982895265;12952.287624180572;12992.415341309475;13087.083904126619;13113.27876966757;9889.456079915386;9974.850377244202;9981.401115933068;9987.950060249652;10177.592896284066;21592.784072159706;21763.455913602287;22213.555728885654;22319.553608927406;22782;22708.432289192242;22849.08603655835;22850;22862.31413057611;23071.423214419774;12926.353682316034;13100.475980960655;13107.410166542719;13108.082434229513;13145;14788.186649733938;14971.475998340005;15064.774028389364;15127.848721512644;15151.090934543963;13099.148555343872;13186.208827470382;13224;13263.801042984556;13720.588382348546;12216.694582635506;12247.326397048248;12422.565210217599;12500.37498125072;12577.622671319876;11679.649610511698;11828.112891533341;11899.345535995604;11919.106067045179;11943.820842687193;8994.190522852974;9014.459132452073;9038.683646072355;9084.772880678036;9148.130927561871;8368.958155209186;8466.57667116654;8550;8574.013988391414;8681.522516261666 04:10:18 INFO - PID 7790 | |4;prototype.html;553.6207697727057;559.5411762354868;570.9771609135635;576.9942300576994;581.5609215042642;6370.522210834183;6421.582597131189;6425.261094974079;6452.128962590049;6465.838354041145;6302.4012718791755;6311.674548344853;6401.5838970467;6403.775867844626;6464.41621802659;5200.191896375953;5226.79092836288;5237.319148510698;5252.3455111639905;5264.39459462161;4986.900261994758;5099.923501147486;5143.4599367066485;5159.509846564571;5251.719848323623;5044.344235249431;5099.872503187413;5109.4379618241965;5126;5168.379794424655;5077.796888124471;5127.307813445174;5138.614603904684;5154.123798954187;5157.071727089123;4706.505816889212;4728.95271047292;4736.455307639631;4742.857714268577;4746.691465054795;6307.3824362889345;6395.936040639581;6420.261669907974;6438.130852334922;6460.515461340371;5980.342162362137;6028.5478589106;6044.2746870375395;6059.151718759377;6076.848078798022;6765.289644587297;6781.593104413751;6822.795316140524;6843.931560684379;6868.896966545506;5033.622478314104;5188.896222075575;5209.244659524347;5234.738263086831;5270.156774915995;6907.480354322041;6993.685284162174;7020.859582808315;7024.613646249454;7040.331168538981;5400.432954539717;5408.3509978802795;5409.43200963901;5409.945900540944;5416.268803711528;5489.945100549024;5493.395726470085;5535.169724541351;5539.806106786243;5540.168974653834;6044.879102418015;6081.391860813972;6116.969415152985;6128.63228206309;6131.448169664663;6771.52599318043;6806.2513123557355;6860.3825655690225;6880.449564034965;6891.75878844238;1856.765251108025;1864.1052294898254;1865.1140708163784;1881.5296175956012;1888.3948643652784;1279.1621487925424;1331.9800202996962;1339.8325209348832;1342.8791408773257;1357.9796303055462;6248.812535623939;6282.591631543935;6318.62088274705;6351.523635727339;6391.488680905516;6833;6870.793876183722;6887.242403335629;6896.689628970479;6924.446044316443;6280.214973128359;6306.369363063657;6308.274548426898;6314.55798094129;6314.589551679126;3609.5488063992;3640.8361623726996;3665.4685070664605;3674.412094064937;3683.8710645127826;6964.477664175106;7127.394171495481;7148.249433809479;7153.928460715326;7163.534370265916;6929.3070692930305;6947.444204463631;6964.233934267227;7024.894626580605;7131.750388736369;7130.679119439637;7266.309700578437;7267;7280.672369743268;7303;6848.732984397902;6920.9653951729915;6949.791506254821;6966.3730264276455;6977.302269772982;6747.527673062838;6755.7973260802255;6798.7280508779095;6834;6834.897476537756;7089.0784198053925;7100.183478899786;7149.499535032498;7158.642067896689;7166.247544007804;5294.417614062527;5347.866303342447;5351.2508248844415;5375.919361209507;5376.1398176291605;6718.697658605277;6733;6829.214640316427;6979.860402792017;6982.476314276348;6694.665266736546;6796.912494000936;6797.354251346114;6809.310322422714;6822.317768223138;6675.165604299463;6685.298043705536;6716.294789047275;6730.8653826924165;6760.5464825062845;6565.540412171294;6613.214432103209;6643.833904152435;6674.199096108498;6682.498812588978;6758.797236082925;6766.5263431559315;6799.286074962058;6825.317468253135;6829.351211634887;6563.9343606565235;6588.176477940257;6598.472122230306;6624.470042396693;6704 04:10:18 INFO - PID 7790 | |5;yui.html;995.7062666513377;1019.1031891935097;1047.9895201047987;1051.295631926609;1058.4919238765392;19031.048447577617;19438.22247110114;19479.902600486996;19531.90234048828;19663.70504442431;19313.61372772544;19412.708809367872;19874.900625496888;20846.374608761722;20943.581128377424;1085.0288991352734;1100.3397961223282;1100.3892839474088;1101.047593831334;1101.5869049106584;1078.5254488025282;1101.2456467319912;1104.1001583709292;1107.0755918807806;1114.6823155400712;1183.9822402663924;1187.1393239901047;1187.6555798818333;1189.9821502677466;1191.2614179208902;1179.3808250668426;1180.9645710628608;1182.154759347071;1185.324365111878;1189.2091758980312;862.7713655881197;866.3978534918234;866.7313132928749;868.8001759595265;868.8783570300163;21008.369748907404;21395.572088558143;21554.353369398945;21576.676349854766;22199.778002219933;22488.655218599462;22698.20556280539;23021.76978230213;23058.538829223322;23090.884545577333;18123.01933873986;18198.545036374064;18235.270589176416;18275.543111422186;18325.266989320546;3986;4051.0277533391773;4065.1869626074904;4065.715399922007;4067.857624983141;168614;170068.14965925214;170134.1493292538;171870;173226;15825.208739562975;15922.840771592137;15991.920040399724;16048.919755401148;16148.192590370434;34533.82733086318;34684;34901;35086.64913350885;35096;9274.489903055397;9471.621135154517;9548.713538593853;9611.134997850228;9635.662751803793;4742.644301677388;4843.128236917389;4859.927101093486;4870.342503762017;4907.09218794517;6070.453659170607;6132.478739307209;6164;6180.690965451709;6185.257769067741;1243.5212443209248;1248.9812652810215;1257.8427696537933;1258.804885242789;1268.0299570828324;756.5611945071845;777.8366543025915;780.2197802197802;795.4431897671653;803.754854769301;12838.293893835742;13190.60428187156;13287.601371958857;13585.388657510435;13593.116447431083;736.8010637127945;750.9249075092447;757.473555878659;767.2595944913186;767.8310771630344;6214.40963108504;6236.937630623635;6257.74969001244;6374.139491168726;6424.967875160594;157217.21391393198;157223;157864.21067894588;159863;160878;134295;135202;135389;136442;138654;117517.41241293738;118221.40889295499;118567;118984.40507797405;122806;11726.237794543327;11809.822852657046;12016.63950081499;12076.275423474619;12088.758224835277;57227.713861432094;58426.4157358421;58584;59084.704576478565;59205;72939;73168.634156831;73986.26013739794;74073;76176;16548.834511654728;17224.65550689004;17393.82606173922;17636.294548217928;17792.110394479965;17064.74402883933;17147.657046859244;17253;17289.654206916042;17320.30718771235;15262.236888155327;15964.361425543313;16006.199690015686;16078;16155.515334539983;17347.219375128403;17459.38892138769;17482.213300401767;17559.297628095243;17563.473095807145;17169.227384767466;17308.134593270035;17357.218925148652;17429.564260893072;17534;13344.666383340495;13365.599032029055;13417.060805743504;13487.190768553919;13490.730185396042;12213.633590992284;12233.266004039786;12285.938570307091;12401.565945192237;12515.12394132402 04:10:18 INFO - PID 7790 | __end_tp_report 04:10:18 INFO - PID 7790 | __start_cc_report 04:10:18 INFO - PID 7790 | _x_x_mozilla_cycle_collect,228 04:10:18 INFO - PID 7790 | __end_cc_report 04:10:18 INFO - PID 7790 | __startTimestamp1507201818262__endTimestamp 04:10:18 INFO - PID 7790 | 04:10:18 INFO - PID 7790 | ------- Summary: start ------- 04:10:18 INFO - PID 7790 | Number of tests: 6 04:10:18 INFO - PID 7790 | 04:10:18 INFO - PID 7790 | [#0] dojo.html Cycles:165 Average:6738.76 Median:7011.82 stddev:799.58 (11.4%) stddev-sans-first:774.36 04:10:18 INFO - PID 7790 | Values: 4080.7 4081.9 4096.1 4102.7 4102.8 6685.7 6686.8 6738.0 6788.2 6817.1 6704.3 6726.1 6799.8 6799.8 6817.2 6007.6 6033.6 6079.8 6126.0 6135.6 5944.9 6039.4 6041.6 6057.3 6144.7 5979.1 5982.8 5989.3 6028.0 6047.5 5992.1 6030.2 6036.8 6072.5 6178.0 5942.7 5980.6 6026.4 6070.2 6120.8 6584.7 6631.0 6631.1 6691.7 6697.6 7302.7 7349.1 7354.6 7355.0 7365.2 7244.9 7323.8 7431.0 7438.9 7449.1 6687.1 6698.1 6778.1 6832.2 6844.0 7489.4 7544.8 7547.4 7550.1 7595.6 7150.0 7152.8 7182.9 7257.2 7270.2 7285.1 7314.9 7339.6 7391.6 7393.3 7134.9 7232.0 7256.1 7364.3 7369.5 7261.9 7262.4 7334.2 7341.9 7366.2 5351.8 5359.1 5412.6 5425.6 5427.5 4849.7 4878.0 4925.6 4966.2 4975.7 6819.8 6825.8 6872.0 6885.4 6905.3 7261.9 7295.0 7303.9 7349.7 7384.0 6580.3 6708.2 6769.9 6805.2 6809.6 5970.1 6099.9 6167.0 6176.2 6179.0 7559.4 7562.6 7669.2 7681.2 7682.3 7223.7 7277.6 7293.5 7316.5 7318.0 7547.1 7551.3 7571.2 7638.3 7666.3 7173.2 7259.1 7272.7 7278.7 7290.6 7279.2 7292.3 7293.7 7377.4 7377.4 6950.1 7037.4 7044.7 7116.4 7120.0 6977.8 7065.3 7081.3 7125.5 7138.9 6976.4 6981.6 7058.3 7059.9 7065.8 7078.4 7116.3 7132.3 7212.7 7242.1 6939.7 6955.2 6998.6 7011.8 7024.1 04:10:18 INFO - PID 7790 | 04:10:18 INFO - PID 7790 | [#1] ext.html Cycles:180 Average:47552.73 Median:3850.22 stddev:76979.56 (1999.4%) stddev-sans-first:77116.07 04:10:18 INFO - PID 7790 | Values: 976.1 980.6 1000.9 1029.6 1040.6 45582.0 46310.0 46338.0 46369.0 46469.1 43743.8 46934.8 47412.3 47413.3 47643.3 8773.2 8931.6 8937.7 8949.3 8952.0 8748.8 8850.5 8883.6 8900.3 8925.3 8863.7 8882.6 8890.5 8904.6 8920.2 8829.1 8841.3 8843.0 8862.6 8903.6 8699.1 8828.3 8828.4 8829.0 8831.8 41790.4 42362.8 42411.0 42471.4 42560.6 3838.5 3847.0 3853.4 3857.0 3866.0 34238.7 34266.1 34298.8 34341.1 34524.3 5593.2 5652.8 5654.7 5657.9 5728.5 242200.0 242391.0 242475.0 242853.0 243386.0 53297.7 53438.2 54101.2 54839.2 55098.4 56210.4 56219.4 56220.7 56369.7 56395.0 18163.5 18341.0 18342.0 18345.9 18349.4 14980.1 14996.1 15088.6 15096.3 15366.3 14871.3 15021.5 15103.1 15212.7 15284.6 5678.1 5698.4 5705.2 5715.9 5773.5 1086.8 1098.5 1099.0 1116.9 1119.1 26524.3 26646.6 26647.9 26696.6 26906.7 1220.0 1230.7 1235.3 1237.3 1238.0 13740.7 13847.5 14018.7 14170.4 14170.4 325767.0 341950.0 342814.0 343991.0 345429.0 63660.7 63861.4 64148.7 64534.4 64604.0 1531.3 1557.3 1574.4 1576.9 1581.7 30967.7 31037.7 31729.5 31833.2 32088.0 42683.4 42929.6 42982.0 42983.0 43049.6 291308.0 293327.0 294054.0 294394.0 295772.0 37867.0 38785.6 39257.2 39552.2 39636.2 47452.0 48731.0 49707.5 49882.3 50085.0 35296.8 36034.5 36099.3 36492.3 36630.5 35981.3 36107.8 36258.6 36401.8 36719.8 40418.0 41814.6 41849.0 41871.4 42293.8 34851.8 34880.7 34992.8 35133.8 35473.5 25281.4 25947.4 26101.6 26234.9 26300.3 04:10:18 INFO - PID 7790 | 04:10:18 INFO - PID 7790 | [#2] jquery.html Cycles:180 Average:42111.88 Median:23989.76 stddev:105864.09 (441.3%) stddev-sans-first:106115.20 04:10:18 INFO - PID 7790 | Values: 608.3 623.3 626.1 629.7 642.3 23976.8 24505.3 24800.9 24885.0 24888.9 27061.7 28279.2 28285.0 28332.4 28350.1 6891.8 7122.6 7167.9 7170.6 7180.1 6779.5 7030.3 7067.3 7068.2 7075.1 7037.4 7044.7 7044.8 7053.8 7055.4 7034.0 7042.2 7045.0 7045.4 7050.3 6578.9 6582.9 6584.7 6592.3 6617.5 31682.2 32789.8 33375.7 33480.8 33555.8 2405.1 2435.5 2439.0 2442.9 2449.3 21203.2 21699.3 22060.9 22066.6 22268.1 2578.5 2619.5 2630.1 2638.7 2654.2 147113.0 154092.0 165654.0 174440.0 174550.1 16757.3 16955.4 17316.2 17397.9 17480.9 27687.0 27794.9 27822.6 27909.3 27916.9 11395.3 11631.9 11651.2 11744.7 11906.2 10759.6 10778.0 10879.7 10939.6 11077.3 10078.1 10138.6 10349.3 10584.8 10617.8 3009.3 3126.5 3133.1 3177.2 3184.2 1042.8 1052.9 1057.5 1064.5 1093.5 21611.0 22003.3 22244.2 22464.7 22678.4 1109.6 1132.2 1141.4 1143.0 1165.6 12007.9 12042.5 12281.0 12424.6 12443.9 619157.0 623844.0 634260.0 635809.0 641034.0 142710.0 143027.0 144493.0 145731.3 146210.0 1183.6 1239.8 1254.8 1272.7 1313.1 24002.8 24031.3 24238.5 24522.9 24615.1 62159.4 62310.7 62816.0 62844.7 67412.0 79344.2 80828.6 80923.0 82338.0 82453.0 16510.1 16874.2 16942.4 16947.0 17085.2 25560.2 25668.9 25966.5 25985.4 26152.7 20480.0 20933.3 21346.0 21495.2 21522.1 18344.6 18447.6 18560.6 18966.5 18990.7 21295.3 21421.5 21753.3 21771.7 21790.5 16320.2 16559.8 16676.9 16681.4 16761.2 20620.7 20646.4 21071.9 21207.0 21213.8 04:10:18 INFO - PID 7790 | 04:10:18 INFO - PID 7790 | [#3] mootools.html Cycles:180 Average:10975.76 Median:26316.61 stddev:8002.71 (30.4%) stddev-sans-first:7993.54 04:10:18 INFO - PID 7790 | Values: 1507.4 1565.0 1570.1 1571.3 1579.4 18128.0 18435.4 18455.9 18530.7 18531.4 17920.8 17958.4 18069.1 18132.7 18165.9 3006.9 3114.8 3117.5 3118.0 3126.3 3029.6 3086.0 3091.8 3091.9 3104.8 3069.7 3184.6 3184.7 3186.4 3195.3 3067.0 3116.2 3145.2 3147.5 3158.7 3099.4 3128.0 3129.0 3143.2 3154.4 16819.2 17100.7 17290.8 17325.7 17371.5 8516.6 9060.2 9078.8 9110.5 9118.7 6033.2 6083.8 6222.6 6317.4 6317.5 2205.7 2248.4 2265.4 2266.4 2269.2 31545.0 31667.5 31674.7 31727.8 31740.8 7679.2 7713.5 7723.3 7814.6 7990.4 20591.6 20598.0 20602.5 20619.0 20632.4 8842.6 8957.7 9002.6 9006.0 9016.1 7739.1 8103.5 8169.9 8187.4 8206.3 6119.5 6170.4 6218.4 6229.9 6276.2 1686.1 1726.3 1737.2 1788.6 1822.8 912.2 921.7 926.0 929.5 938.3 10033.9 10055.3 10144.9 10184.1 10190.1 1079.3 1091.4 1096.3 1098.9 1115.5 5650.3 5684.3 6312.7 6318.1 6433.8 25956.5 26454.5 26567.7 26783.3 26846.6 24732.3 25862.4 26039.3 26307.7 26325.5 12867.8 12952.3 12992.4 13087.1 13113.3 9889.5 9974.9 9981.4 9988.0 10177.6 21592.8 21763.5 22213.6 22319.6 22782.0 22708.4 22849.1 22850.0 22862.3 23071.4 12926.4 13100.5 13107.4 13108.1 13145.0 14788.2 14971.5 15064.8 15127.8 15151.1 13099.1 13186.2 13224.0 13263.8 13720.6 12216.7 12247.3 12422.6 12500.4 12577.6 11679.6 11828.1 11899.3 11919.1 11943.8 8994.2 9014.5 9038.7 9084.8 9148.1 8369.0 8466.6 8550.0 8574.0 8681.5 04:10:18 INFO - PID 7790 | 04:10:18 INFO - PID 7790 | [#4] prototype.html Cycles:180 Average:5787.50 Median:6402.68 stddev:1604.41 (25.1%) stddev-sans-first:1560.08 04:10:18 INFO - PID 7790 | Values: 553.6 559.5 571.0 577.0 581.6 6370.5 6421.6 6425.3 6452.1 6465.8 6302.4 6311.7 6401.6 6403.8 6464.4 5200.2 5226.8 5237.3 5252.3 5264.4 4986.9 5099.9 5143.5 5159.5 5251.7 5044.3 5099.9 5109.4 5126.0 5168.4 5077.8 5127.3 5138.6 5154.1 5157.1 4706.5 4729.0 4736.5 4742.9 4746.7 6307.4 6395.9 6420.3 6438.1 6460.5 5980.3 6028.5 6044.3 6059.2 6076.8 6765.3 6781.6 6822.8 6843.9 6868.9 5033.6 5188.9 5209.2 5234.7 5270.2 6907.5 6993.7 7020.9 7024.6 7040.3 5400.4 5408.4 5409.4 5409.9 5416.3 5489.9 5493.4 5535.2 5539.8 5540.2 6044.9 6081.4 6117.0 6128.6 6131.4 6771.5 6806.3 6860.4 6880.4 6891.8 1856.8 1864.1 1865.1 1881.5 1888.4 1279.2 1332.0 1339.8 1342.9 1358.0 6248.8 6282.6 6318.6 6351.5 6391.5 6833.0 6870.8 6887.2 6896.7 6924.4 6280.2 6306.4 6308.3 6314.6 6314.6 3609.5 3640.8 3665.5 3674.4 3683.9 6964.5 7127.4 7148.2 7153.9 7163.5 6929.3 6947.4 6964.2 7024.9 7131.8 7130.7 7266.3 7267.0 7280.7 7303.0 6848.7 6921.0 6949.8 6966.4 6977.3 6747.5 6755.8 6798.7 6834.0 6834.9 7089.1 7100.2 7149.5 7158.6 7166.2 5294.4 5347.9 5351.3 5375.9 5376.1 6718.7 6733.0 6829.2 6979.9 6982.5 6694.7 6796.9 6797.4 6809.3 6822.3 6675.2 6685.3 6716.3 6730.9 6760.5 6565.5 6613.2 6643.8 6674.2 6682.5 6758.8 6766.5 6799.3 6825.3 6829.4 6563.9 6588.2 6598.5 6624.5 6704.0 04:10:18 INFO - PID 7790 | 04:10:18 INFO - PID 7790 | [#5] yui.html Cycles:180 Average:29071.20 Median:17411.70 stddev:44666.93 (256.5%) stddev-sans-first:44742.49 04:10:18 INFO - PID 7790 | Values: 995.7 1019.1 1048.0 1051.3 1058.5 19031.0 19438.2 19479.9 19531.9 19663.7 19313.6 19412.7 19874.9 20846.4 20943.6 1085.0 1100.3 1100.4 1101.0 1101.6 1078.5 1101.2 1104.1 1107.1 1114.7 1184.0 1187.1 1187.7 1190.0 1191.3 1179.4 1181.0 1182.2 1185.3 1189.2 862.8 866.4 866.7 868.8 868.9 21008.4 21395.6 21554.4 21576.7 22199.8 22488.7 22698.2 23021.8 23058.5 23090.9 18123.0 18198.5 18235.3 18275.5 18325.3 3986.0 4051.0 4065.2 4065.7 4067.9 168614.0 170068.1 170134.1 171870.0 173226.0 15825.2 15922.8 15991.9 16048.9 16148.2 34533.8 34684.0 34901.0 35086.6 35096.0 9274.5 9471.6 9548.7 9611.1 9635.7 4742.6 4843.1 4859.9 4870.3 4907.1 6070.5 6132.5 6164.0 6180.7 6185.3 1243.5 1249.0 1257.8 1258.8 1268.0 756.6 777.8 780.2 795.4 803.8 12838.3 13190.6 13287.6 13585.4 13593.1 736.8 750.9 757.5 767.3 767.8 6214.4 6236.9 6257.7 6374.1 6425.0 157217.2 157223.0 157864.2 159863.0 160878.0 134295.0 135202.0 135389.0 136442.0 138654.0 117517.4 118221.4 118567.0 118984.4 122806.0 11726.2 11809.8 12016.6 12076.3 12088.8 57227.7 58426.4 58584.0 59084.7 59205.0 72939.0 73168.6 73986.3 74073.0 76176.0 16548.8 17224.7 17393.8 17636.3 17792.1 17064.7 17147.7 17253.0 17289.7 17320.3 15262.2 15964.4 16006.2 16078.0 16155.5 17347.2 17459.4 17482.2 17559.3 17563.5 17169.2 17308.1 17357.2 17429.6 17534.0 13344.7 13365.6 13417.1 13487.2 13490.7 12213.6 12233.3 12285.9 12401.6 12515.1 04:10:18 INFO - PID 7790 | -------- Summary: end -------- 04:10:18 INFO - PID 7790 | 04:10:18 INFO - TEST-INFO | 7790: exit 0 04:10:18 INFO - TEST-OK | dromaeo_css | took 1107577ms 04:10:18 INFO - TEST-START | kraken 04:10:18 INFO - Initialising browser for kraken test... 04:10:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56436/getInfo.html -profile /tmp/tmpRwaveJ/profile 04:10:18 INFO - TEST-INFO | started process 8146 (/builds/slave/test/build/application/firefox/firefox http://localhost:56436/getInfo.html) 04:10:23 INFO - TEST-INFO | 8146: exit 0 04:10:23 INFO - Browser initialized. 04:10:23 INFO - Running cycle 1/1 for kraken test... 04:10:23 INFO - Using env: {'DISPLAY': ':0', 04:10:23 INFO - 'HOME': '/home/cltbld', 04:10:23 INFO - 'JSGC_DISABLE_POISONING': '1', 04:10:23 INFO - 'LANG': 'en_US.UTF-8', 04:10:23 INFO - 'LANGUAGE': 'en_US:en', 04:10:23 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:10:23 INFO - 'LOGNAME': 'cltbld', 04:10:23 INFO - 'MAIL': '/var/mail/cltbld', 04:10:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:10:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:10:23 INFO - 'MOZ_CRASHREPORTER': '1', 04:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:23 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:10:23 INFO - 'MOZ_NO_REMOTE': '1', 04:10:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:23 INFO - 'NO_EM_RESTART': '1', 04:10:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:23 INFO - 'PWD': '/builds/slave/test', 04:10:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:10:23 INFO - 'RUST_BACKTRACE': 'full', 04:10:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:10:23 INFO - 'SHELL': '/bin/bash', 04:10:23 INFO - 'SHLVL': '1', 04:10:23 INFO - 'TERM': 'linux', 04:10:23 INFO - 'TMOUT': '86400', 04:10:23 INFO - 'USER': 'cltbld', 04:10:23 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425', 04:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:23 INFO - '_': '/tools/buildbot/bin/python'} 04:10:23 INFO - TEST-INFO | started process 8375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRwaveJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:24 INFO - PID 8375 | 04:10:24 INFO - PID 8375 | (/builds/slave/test/build/application/firefox/firefox:8423): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:10:24 INFO - PID 8375 | 04:10:35 INFO - PID 8375 | RSS: Main: 143634432 04:10:35 INFO - PID 8375 | 04:10:37 INFO - PID 8375 | Cycle 1(1): loaded http://localhost:56436/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56436/tests/kraken/driver.html?testName=audio-beat-detection) 04:10:38 INFO - PID 8375 | RSS: Main: 149557248 04:10:38 INFO - PID 8375 | 04:10:40 INFO - PID 8375 | Cycle 1(1): loaded http://localhost:56436/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56436/tests/kraken/driver.html?testName=audio-dft) 04:10:41 INFO - PID 8375 | RSS: Main: 150265856 04:10:41 INFO - PID 8375 | 04:10:44 INFO - PID 8375 | Cycle 1(1): loaded http://localhost:56436/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56436/tests/kraken/driver.html?testName=audio-fft) 04:10:44 INFO - PID 8375 | RSS: Main: 151588864 04:10:44 INFO - PID 8375 | 04:10:46 INFO - PID 8375 | Cycle 1(1): loaded http://localhost:56436/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56436/tests/kraken/driver.html?testName=audio-oscillator) 04:10:47 INFO - PID 8375 | RSS: Main: 152162304 04:10:47 INFO - PID 8375 | 04:10:49 INFO - PID 8375 | Cycle 1(1): loaded http://localhost:56436/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56436/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:10:50 INFO - PID 8375 | RSS: Main: 151330816 04:10:50 INFO - PID 8375 | 04:10:53 INFO - PID 8375 | Cycle 1(1): loaded http://localhost:56436/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56436/tests/kraken/driver.html?testName=imaging-darkroom) 04:10:53 INFO - PID 8375 | RSS: Main: 151441408 04:10:53 INFO - PID 8375 | 04:10:57 INFO - PID 8375 | Cycle 1(1): loaded http://localhost:56436/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56436/tests/kraken/driver.html?testName=imaging-desaturate) 04:10:57 INFO - PID 8375 | RSS: Main: 152756224 04:10:57 INFO - PID 8375 | 04:11:00 INFO - PID 8375 | Cycle 1(1): loaded http://localhost:56436/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56436/tests/kraken/driver.html?testName=json-parse-financial) 04:11:01 INFO - PID 8375 | RSS: Main: 153927680 04:11:01 INFO - PID 8375 | 04:11:02 INFO - PID 8375 | Cycle 1(1): loaded http://localhost:56436/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56436/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:11:03 INFO - PID 8375 | RSS: Main: 154357760 04:11:03 INFO - PID 8375 | 04:11:04 INFO - PID 8375 | Cycle 1(1): loaded http://localhost:56436/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56436/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:11:05 INFO - PID 8375 | RSS: Main: 153849856 04:11:05 INFO - PID 8375 | 04:11:07 INFO - PID 8375 | Cycle 1(1): loaded http://localhost:56436/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56436/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:11:08 INFO - PID 8375 | RSS: Main: 150507520 04:11:08 INFO - PID 8375 | 04:11:10 INFO - PID 8375 | Cycle 1(1): loaded http://localhost:56436/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:11:11 INFO - PID 8375 | RSS: Main: 150896640 04:11:11 INFO - PID 8375 | 04:11:13 INFO - PID 8375 | Cycle 1(1): loaded http://localhost:56436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:11:14 INFO - PID 8375 | RSS: Main: 150978560 04:11:14 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | Cycle 1(1): loaded http://localhost:56436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56436/tests/kraken/driver.html?testName=ai-astar) 04:11:16 INFO - PID 8375 | RSS: Main: 152735744 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | __start_tp_report 04:11:16 INFO - PID 8375 | _x_x_mozilla_page_load 04:11:16 INFO - PID 8375 | _x_x_mozilla_page_load_details 04:11:16 INFO - PID 8375 | |i|pagename|runs| 04:11:16 INFO - PID 8375 | |0;ai-astar;106;104;104;104;104;105;107;105;104;106 04:11:16 INFO - PID 8375 | |1;audio-beat-detection;110;112;112;108;112;112;134;115;110;139 04:11:16 INFO - PID 8375 | |2;audio-dft;161;160;160;161;161;162;163;161;161;161 04:11:16 INFO - PID 8375 | |3;audio-fft;73;78;76;73;74;74;73;72;75;72 04:11:16 INFO - PID 8375 | |4;audio-oscillator;78;78;77;80;81;77;78;78;78;78 04:11:16 INFO - PID 8375 | |5;imaging-gaussian-blur;113;113;113;113;114;112;113;114;114;114 04:11:16 INFO - PID 8375 | |6;imaging-darkroom;149;147;148;148;149;149;147;149;149;149 04:11:16 INFO - PID 8375 | |7;imaging-desaturate;94;93;94;93;94;94;93;95;94;95 04:11:16 INFO - PID 8375 | |8;json-parse-financial;47;41;42;43;44;48;46;43;48;44 04:11:16 INFO - PID 8375 | |9;json-stringify-tinderbox;37;38;37;37;44;37;38;37;38;37 04:11:16 INFO - PID 8375 | |10;stanford-crypto-aes;69;72;72;71;70;70;69;70;72;70 04:11:16 INFO - PID 8375 | |11;stanford-crypto-ccm;101;105;100;105;109;102;105;103;109;99 04:11:16 INFO - PID 8375 | |12;stanford-crypto-pbkdf2;148;146;148;150;150;146;147;158;150;153 04:11:16 INFO - PID 8375 | |13;stanford-crypto-sha256-iterative;61;60;60;60;61;57;62;58;58;59 04:11:16 INFO - PID 8375 | __end_tp_report 04:11:16 INFO - PID 8375 | __start_cc_report 04:11:16 INFO - PID 8375 | _x_x_mozilla_cycle_collect,686 04:11:16 INFO - PID 8375 | __end_cc_report 04:11:16 INFO - PID 8375 | __startTimestamp1507201876326__endTimestamp 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | ------- Summary: start ------- 04:11:16 INFO - PID 8375 | Number of tests: 14 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | [#0] ai-astar Cycles:10 Average:104.90 Median:105.00 stddev:1.10 (1.0%) stddev-sans-first:1.09 04:11:16 INFO - PID 8375 | Values: 106.0 104.0 104.0 104.0 104.0 105.0 107.0 105.0 104.0 106.0 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | [#1] audio-beat-detection Cycles:10 Average:116.40 Median:112.00 stddev:10.81 (9.7%) stddev-sans-first:11.22 04:11:16 INFO - PID 8375 | Values: 110.0 112.0 112.0 108.0 112.0 112.0 134.0 115.0 110.0 139.0 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 04:11:16 INFO - PID 8375 | Values: 161.0 160.0 160.0 161.0 161.0 162.0 163.0 161.0 161.0 161.0 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | [#3] audio-fft Cycles:10 Average:74.00 Median:74.00 stddev:1.89 (2.5%) stddev-sans-first:1.96 04:11:16 INFO - PID 8375 | Values: 73.0 78.0 76.0 73.0 74.0 74.0 73.0 72.0 75.0 72.0 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | [#4] audio-oscillator Cycles:10 Average:78.30 Median:78.00 stddev:1.25 (1.6%) stddev-sans-first:1.32 04:11:16 INFO - PID 8375 | Values: 78.0 78.0 77.0 80.0 81.0 77.0 78.0 78.0 78.0 78.0 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:11:16 INFO - PID 8375 | Values: 113.0 113.0 113.0 113.0 114.0 112.0 113.0 114.0 114.0 114.0 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 04:11:16 INFO - PID 8375 | Values: 149.0 147.0 148.0 148.0 149.0 149.0 147.0 149.0 149.0 149.0 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 04:11:16 INFO - PID 8375 | Values: 94.0 93.0 94.0 93.0 94.0 94.0 93.0 95.0 94.0 95.0 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | [#8] json-parse-financial Cycles:10 Average:44.60 Median:45.00 stddev:2.50 (5.6%) stddev-sans-first:2.50 04:11:16 INFO - PID 8375 | Values: 47.0 41.0 42.0 43.0 44.0 48.0 46.0 43.0 48.0 44.0 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:37.50 stddev:2.16 (5.8%) stddev-sans-first:2.26 04:11:16 INFO - PID 8375 | Values: 37.0 38.0 37.0 37.0 44.0 37.0 38.0 37.0 38.0 37.0 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | [#10] stanford-crypto-aes Cycles:10 Average:70.50 Median:70.50 stddev:1.18 (1.7%) stddev-sans-first:1.12 04:11:16 INFO - PID 8375 | Values: 69.0 72.0 72.0 71.0 70.0 70.0 69.0 70.0 72.0 70.0 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | [#11] stanford-crypto-ccm Cycles:10 Average:103.80 Median:105.00 stddev:3.46 (3.3%) stddev-sans-first:3.52 04:11:16 INFO - PID 8375 | Values: 101.0 105.0 100.0 105.0 109.0 102.0 105.0 103.0 109.0 99.0 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:150.00 stddev:3.66 (2.4%) stddev-sans-first:3.83 04:11:16 INFO - PID 8375 | Values: 148.0 146.0 148.0 150.0 150.0 146.0 147.0 158.0 150.0 153.0 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.60 Median:60.00 stddev:1.58 (2.6%) stddev-sans-first:1.59 04:11:16 INFO - PID 8375 | Values: 61.0 60.0 60.0 60.0 61.0 57.0 62.0 58.0 58.0 59.0 04:11:16 INFO - PID 8375 | -------- Summary: end -------- 04:11:16 INFO - PID 8375 | 04:11:16 INFO - PID 8375 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:11:16 INFO - TEST-INFO | 8375: exit 0 04:11:16 INFO - TEST-OK | kraken | took 58088ms 04:11:16 INFO - SUITE-END | took 1165s 04:11:17 INFO - Completed test suite (00:19:25) 04:11:17 INFO - javascript benchmark 04:11:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9521.162874409838, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4080.6531444827187, 4081.9387709184357, 4096.057906681465, 4102.692298077644, 4102.815373308199, 6685.69914353854, 6686.7993960181275, 6737.966310168448, 6788.151481064867, 6817.113775209222, 6704.3295670432935, 6726.058351830748, 6799.76200832971, 6799.796006119812, 6817.2160201576835, 6007.639541627505, 6033.577649564532, 6079.848003799896, 6126.0, 6135.631862088267, 5944.851378715545, 6039.365866584011, 6041.577089603729, 6057.273127224717, 6144.723487443076, 5979.1330257112695, 5982.79060232892, 5989.311229208632, 6028.0, 6047.516198704093, 5992.0712289595185, 6030.155778191057, 6036.8188954331445, 6072.453479186872, 6177.969110154466, 5942.702864856783, 5980.581359304851, 6026.427489388545, 6070.21087258658, 6120.785772497941, 6584.736610535573, 6631.0, 6631.1379520662485, 6691.698873550702, 6697.598144111369, 7302.74440394589, 7349.118105827281, 7354.632268386613, 7355.0, 7365.15300740411, 7244.893904474295, 7323.780286591411, 7430.96284518574, 7438.921356403345, 7449.106107267108, 6687.130673012477, 6698.062271282024, 6778.118844550177, 6832.248452670252, 6843.965780171067, 7489.438292128112, 7544.811379715441, 7547.433942454338, 7550.056242969629, 7595.5822429765785, 7149.992793348016, 7152.821179470555, 7182.892256616155, 7257.165425976081, 7270.200277969419, 7285.052943117466, 7314.853702926018, 7339.633018349061, 7391.593462359622, 7393.260673932564, 7134.857302854018, 7231.963840180765, 7256.092988376453, 7364.263573642593, 7369.520981136317, 7261.89107163393, 7262.382697470668, 7334.229905859915, 7341.926580734231, 7366.1528924173335, 5351.785928562814, 5359.062164121263, 5412.648177868426, 5425.6202065855805, 5427.457254274541, 4849.684770489906, 4878.0, 4925.6305777066145, 4966.180580204225, 4975.701457912464, 6819.761308354184, 6825.829354266084, 6871.9656401717675, 6885.449164066863, 6905.274946130685, 7261.927380726125, 7294.963525182447, 7303.89044164338, 7349.669264883093, 7384.0, 6580.309067547934, 6708.19501659804, 6769.8646027079185, 6805.183377994672, 6809.625470599066, 5970.13433052205, 6099.9085013724825, 6166.969165154235, 6176.197094377702, 6178.969105154535, 7559.395248380117, 7562.584057876869, 7669.194734552903, 7681.231876812386, 7682.270184332479, 7223.711051558089, 7277.599732014684, 7293.452991025588, 7316.487845850739, 7318.048653675201, 7547.0943486781935, 7551.320381165721, 7571.167171611009, 7638.312551870358, 7666.310032097138, 7173.210946795744, 7259.12890453149, 7272.672729727069, 7278.745243916437, 7290.5625662460425, 7279.235680253497, 7292.307230813064, 7293.671784769592, 7377.372923301579, 7377.4098072155175, 6950.061741665013, 7037.437005039482, 7044.682989265393, 7116.43068554504, 7119.964400177966, 6977.755778547727, 7065.293470652894, 7081.291870812877, 7125.501214914906, 7138.928610713826, 6976.372126508639, 6981.581105133709, 7058.258882817436, 7059.858802823812, 7065.752698655522, 7078.362947334765, 7116.25279345682, 7132.251113632994, 7212.675429605575, 7242.058532390966, 6939.653017349011, 6955.23492415844, 6998.615076170656, 7011.824704382431, 7024.121984751906], "value": 6684.16174591765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [976.0824824664815, 980.632262901412, 1000.8748906386702, 1029.644772553469, 1040.578565680899, 45582.0, 46310.0, 46338.0, 46369.0, 46469.07061858761, 43743.78128109363, 46934.76532617332, 47412.288815667795, 47413.28880066793, 47643.285350719765, 8773.166549177833, 8931.553422328858, 8937.687180948667, 8949.284057275436, 8951.955240223822, 8748.825023499527, 8850.5132217728, 8883.555822208897, 8900.28797696186, 8925.330600204978, 8863.734087977371, 8882.600282987249, 8890.466572005667, 8904.643814247422, 8920.197182253596, 8829.0729473405, 8841.292696584322, 8843.0, 8862.645494180226, 8903.643854245822, 8699.130086991314, 8828.337874659426, 8828.382013259074, 8829.028806831244, 8831.823363532758, 41790.37314440286, 42362.788186058875, 42411.0, 42471.36292955608, 42560.57439425597, 3838.4818049563232, 3847.03824043989, 3853.402722578005, 3857.035741064734, 3865.9806700966597, 34238.6576134238, 34266.14334641629, 34298.82850585731, 34341.141471463416, 34524.30951380958, 5593.161025846115, 5652.773889044433, 5654.660720356792, 5657.858553536194, 5728.455796699307, 242199.99999999822, 242391.0, 242475.0, 242853.0, 243386.0, 53297.7335113322, 53438.19842702363, 54101.1884821728, 54839.177412338846, 55098.44901551013, 56210.43789562134, 56219.43780562224, 56220.718896405255, 56369.71815140898, 56395.0, 18163.54591135206, 18341.0, 18342.0, 18345.908270458563, 18349.3577724779, 14980.1011939284, 14996.100233985995, 15088.622784430258, 15096.320665569856, 15366.308516116802, 14871.33079011447, 15021.474248401253, 15103.093814371174, 15212.695746085017, 15284.617884552976, 5678.119891416837, 5698.430156984268, 5705.2012718219485, 5715.914261286084, 5773.480386765127, 1086.7717779266284, 1098.5166526728215, 1098.961536346224, 1116.8994790468896, 1119.0823524709822, 26524.336891577866, 26646.600300995502, 26647.86676066607, 26696.59955100675, 26906.730932690814, 1219.9939000304942, 1230.698478872682, 1235.2958813476232, 1237.3256575166556, 1238.0405185980758, 13740.725185496234, 13847.515336963157, 14018.719625607431, 14170.362333695008, 14170.433182672577, 325767.0, 341950.0, 342814.0, 343991.0, 345429.0, 63660.68169659122, 63861.36138638554, 64148.67925660342, 64534.354656453776, 64604.0, 1531.3109100904414, 1557.2758667219798, 1574.4417616187727, 1576.9211539422984, 1581.7390130628548, 30967.69032309738, 31037.67217458745, 31729.5240571387, 31833.204169895012, 32088.03735887927, 42683.3597496044, 42929.57070429381, 42982.0, 42983.0, 43049.569504304556, 291308.0, 293327.0, 294054.0, 294394.0, 295772.0, 37867.0, 38785.61214387933, 39257.2148557033, 39552.20895582015, 39636.2072758549, 47452.0, 48731.02537949292, 49707.50292497173, 49882.25176622426, 50085.0, 35296.82351588226, 36034.4594831083, 36099.27801444009, 36492.27015459729, 36630.45054324134, 35981.28037439289, 36107.81946090358, 36258.63741362658, 36401.817990909876, 36719.81640091782, 40418.0, 41814.581854181066, 41849.0, 41871.37192942169, 42293.78853105715, 34851.825740871136, 34880.65119348875, 34992.82503587466, 35133.82433087818, 35473.46789798207, 25281.367965800266, 25947.351316217246, 26101.608475873258, 26234.86882565575, 26300.342491437867], "value": 19750.275329551783, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.2579253310959, 623.3454872383995, 626.1171747835552, 629.7355110853443, 642.3480167629855, 23976.76023239767, 24505.264842054745, 24800.87599562002, 24885.0, 24888.875555622195, 27061.729382706166, 28279.151625451217, 28285.0, 28332.433351332962, 28350.149495515117, 6891.759483293018, 7122.608256545888, 7167.89248161278, 7170.569765814042, 7180.102487189101, 6779.457643388517, 7030.29697030298, 7067.328603782633, 7068.222495525514, 7075.080239568849, 7037.43700503961, 7044.718211271543, 7044.753433629824, 7053.823654408629, 7055.4002909752735, 7033.964830175842, 7042.154941407039, 7045.048918396028, 7045.401140903029, 7050.330218629222, 6578.868422631521, 6582.93417065828, 6584.703688333989, 6592.340765923417, 6617.50368722343, 31682.207944801336, 32789.83605081983, 33375.6662433375, 33480.832595837106, 33555.83222083874, 2405.0980882169188, 2435.5128974205054, 2439.024390243899, 2442.8778561072054, 2449.2774631483576, 21203.151873925024, 21699.34901952928, 22060.88969555158, 22066.558668826696, 22268.109275628954, 2578.5358635445614, 2619.4630100829286, 2630.0663264541004, 2638.6569745933098, 2654.1772050664354, 147113.0, 154092.0, 165654.0, 174440.0, 174550.12724936422, 16757.329706811834, 16955.406560770312, 17316.220770065378, 17397.913010434866, 17480.912595437196, 27687.0, 27794.861025695147, 27822.582661259694, 27909.302267443476, 27916.860415697793, 11395.316281023164, 11631.917541851417, 11651.242669226473, 11744.706382340339, 11906.226095303777, 10759.623413180501, 10778.0, 10879.728006799734, 10939.617113401151, 11077.279976801483, 10078.14335781452, 10138.594456221816, 10349.327293725884, 10584.788304233873, 10617.84073238902, 3009.292816188194, 3126.515390114536, 3133.1070644866104, 3177.158053115926, 3184.232750823269, 1042.8279333909973, 1052.8789189243182, 1057.5346847387125, 1064.4624464645306, 1093.4532733633184, 21611.0, 22003.33989980303, 22244.221452249418, 22464.663030054562, 22678.433039173822, 1109.606089838112, 1132.1961407400838, 1141.4064686363045, 1142.954281828734, 1165.5687395663658, 12007.87992120085, 12042.458089385998, 12281.0, 12424.627261182179, 12443.937780311222, 619157.0, 623844.0, 634260.0, 635809.0, 641034.0, 142710.0, 143027.0, 144493.0, 145731.2713436426, 146210.0, 1183.6330737471412, 1239.8450193725785, 1254.8431446069424, 1272.6754677557349, 1313.1267706974754, 24002.759972400054, 24031.279061628178, 24238.51522969566, 24522.87738561296, 24615.13847015346, 62159.37840621536, 62310.68844655748, 62816.0, 62844.68577657083, 67412.0, 79344.20655793368, 80828.59585702034, 80923.0, 82338.0, 82453.0, 16510.091944942662, 16874.156292185588, 16942.40701575439, 16947.0, 17085.23116459787, 25560.23319300424, 25668.871655641604, 25966.480670386863, 25985.350366240997, 26152.73847261503, 20480.0, 20933.267335643788, 21346.0, 21495.247666331605, 21522.139114435875, 18344.633107338046, 18447.63104737871, 18560.628787424444, 18966.52583685419, 18990.715139273198, 21295.254666086614, 21421.464463387918, 21753.347399578037, 21771.673424898956, 21790.45523861916, 16320.183990800175, 16559.751603726196, 16676.916615416845, 16681.416150434678, 16761.1619419031, 20620.690689639367, 20646.380608581767, 21071.894640526698, 21207.0, 21213.833239171377], "value": 13595.885717746758, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1507.449780829997, 1564.9608759780997, 1570.1285786388557, 1571.2536545141058, 1579.439299048837, 18128.0, 18435.354762583313, 18455.90772046138, 18530.722039169406, 18531.351402700908, 17920.820791792077, 17958.371456999008, 18069.096545172753, 18132.72800907984, 18165.909170454128, 3006.9097927062166, 3114.7819652624325, 3117.5323701444736, 3117.953230701541, 3126.2809553802526, 3029.5758593796886, 3086.0279012111114, 3091.8299493527848, 3091.922701932447, 3104.8292343921075, 3069.723724864773, 3184.633767116788, 3184.7452203823636, 3186.394585028837, 3195.3449542843778, 3066.9693303066906, 3116.22094476382, 3145.2451411661264, 3147.4806656901583, 3158.699923507263, 3099.4111118887563, 3128.0459459864733, 3129.0, 3143.1513491357205, 3154.4006638738565, 16819.15904204785, 17100.657986840317, 17290.827091729047, 17325.65348693019, 17371.478855634352, 8516.574171291411, 9060.184583387527, 9078.81842363149, 9110.544472776335, 9118.680846170351, 6033.1553582498045, 6083.752830669702, 6222.626642401425, 6317.399847014526, 6317.463015643676, 2205.669149627569, 2248.3929339078522, 2265.399669087693, 2266.4220623741007, 2269.2284623228184, 31545.0, 31667.524987125213, 31674.683253167404, 31727.84136079305, 31740.841295793605, 7679.232076792276, 7713.537187768752, 7723.266289702469, 7814.570198639016, 7990.403118986353, 20591.588168236853, 20598.0, 20602.484937876674, 20619.0, 20632.381028569165, 8842.602082906285, 8957.731268061969, 9002.63989440415, 9005.954970225239, 9016.143466370684, 7739.148693643695, 8103.513789172551, 8169.877451838227, 8187.385946053951, 8206.302464290482, 6119.479844213202, 6170.444659980623, 6218.378162183745, 6229.937700622936, 6276.246850377984, 1686.1316422042657, 1726.326732574297, 1737.1661602430652, 1788.642271545696, 1822.7539282197, 912.174482093693, 921.7050543826045, 925.9907400925905, 929.5027160469117, 938.2728385501155, 10033.949830250802, 10055.296129271028, 10144.898551014543, 10184.134348580306, 10190.1338386238, 1079.3362082319475, 1091.410638255349, 1096.3476731344838, 1098.8846171152074, 1115.481301194932, 5650.321961364581, 5684.317881854121, 6312.652804095819, 6318.147050148171, 6433.806985790434, 25956.480870382486, 26454.470910582066, 26567.734322656524, 26783.330416739347, 26846.5973010405, 24732.258032259062, 25862.353441164123, 26039.349016274366, 26307.736922630913, 26325.473490530083, 12867.806982895265, 12952.287624180572, 12992.415341309475, 13087.083904126619, 13113.27876966757, 9889.456079915386, 9974.850377244202, 9981.401115933068, 9987.950060249652, 10177.592896284066, 21592.784072159706, 21763.455913602287, 22213.555728885654, 22319.553608927406, 22782.0, 22708.432289192242, 22849.08603655835, 22850.0, 22862.31413057611, 23071.423214419774, 12926.353682316034, 13100.475980960655, 13107.410166542719, 13108.082434229513, 13145.0, 14788.186649733938, 14971.475998340005, 15064.774028389364, 15127.848721512644, 15151.090934543963, 13099.148555343872, 13186.208827470382, 13224.0, 13263.801042984556, 13720.588382348546, 12216.694582635506, 12247.326397048248, 12422.565210217599, 12500.37498125072, 12577.622671319876, 11679.649610511698, 11828.112891533341, 11899.345535995604, 11919.106067045179, 11943.820842687193, 8994.190522852974, 9014.459132452073, 9038.683646072355, 9084.772880678036, 9148.130927561871, 8368.958155209186, 8466.57667116654, 8550.0, 8574.013988391414, 8681.522516261666], "value": 7763.895164975871, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.6207697727057, 559.5411762354868, 570.9771609135635, 576.9942300576994, 581.5609215042642, 6370.522210834183, 6421.582597131189, 6425.261094974079, 6452.128962590049, 6465.838354041145, 6302.4012718791755, 6311.674548344853, 6401.5838970467, 6403.775867844626, 6464.41621802659, 5200.191896375953, 5226.79092836288, 5237.319148510698, 5252.3455111639905, 5264.39459462161, 4986.900261994758, 5099.923501147486, 5143.4599367066485, 5159.509846564571, 5251.719848323623, 5044.344235249431, 5099.872503187413, 5109.4379618241965, 5126.0, 5168.379794424655, 5077.796888124471, 5127.307813445174, 5138.614603904684, 5154.123798954187, 5157.071727089123, 4706.505816889212, 4728.95271047292, 4736.455307639631, 4742.857714268577, 4746.691465054795, 6307.3824362889345, 6395.936040639581, 6420.261669907974, 6438.130852334922, 6460.515461340371, 5980.342162362137, 6028.5478589106, 6044.2746870375395, 6059.151718759377, 6076.848078798022, 6765.289644587297, 6781.593104413751, 6822.795316140524, 6843.931560684379, 6868.896966545506, 5033.622478314104, 5188.896222075575, 5209.244659524347, 5234.738263086831, 5270.156774915995, 6907.480354322041, 6993.685284162174, 7020.859582808315, 7024.613646249454, 7040.331168538981, 5400.432954539717, 5408.3509978802795, 5409.43200963901, 5409.945900540944, 5416.268803711528, 5489.945100549024, 5493.395726470085, 5535.169724541351, 5539.806106786243, 5540.168974653834, 6044.879102418015, 6081.391860813972, 6116.969415152985, 6128.63228206309, 6131.448169664663, 6771.52599318043, 6806.2513123557355, 6860.3825655690225, 6880.449564034965, 6891.75878844238, 1856.765251108025, 1864.1052294898254, 1865.1140708163784, 1881.5296175956012, 1888.3948643652784, 1279.1621487925424, 1331.9800202996962, 1339.8325209348832, 1342.8791408773257, 1357.9796303055462, 6248.812535623939, 6282.591631543935, 6318.62088274705, 6351.523635727339, 6391.488680905516, 6833.0, 6870.793876183722, 6887.242403335629, 6896.689628970479, 6924.446044316443, 6280.214973128359, 6306.369363063657, 6308.274548426898, 6314.55798094129, 6314.589551679126, 3609.5488063992, 3640.8361623726996, 3665.4685070664605, 3674.412094064937, 3683.8710645127826, 6964.477664175106, 7127.394171495481, 7148.249433809479, 7153.928460715326, 7163.534370265916, 6929.3070692930305, 6947.444204463631, 6964.233934267227, 7024.894626580605, 7131.750388736369, 7130.679119439637, 7266.309700578437, 7267.0, 7280.672369743268, 7303.0, 6848.732984397902, 6920.9653951729915, 6949.791506254821, 6966.3730264276455, 6977.302269772982, 6747.527673062838, 6755.7973260802255, 6798.7280508779095, 6834.0, 6834.897476537756, 7089.0784198053925, 7100.183478899786, 7149.499535032498, 7158.642067896689, 7166.247544007804, 5294.417614062527, 5347.866303342447, 5351.2508248844415, 5375.919361209507, 5376.1398176291605, 6718.697658605277, 6733.0, 6829.214640316427, 6979.860402792017, 6982.476314276348, 6694.665266736546, 6796.912494000936, 6797.354251346114, 6809.310322422714, 6822.317768223138, 6675.165604299463, 6685.298043705536, 6716.294789047275, 6730.8653826924165, 6760.5464825062845, 6565.540412171294, 6613.214432103209, 6643.833904152435, 6674.199096108498, 6682.498812588978, 6758.797236082925, 6766.5263431559315, 6799.286074962058, 6825.317468253135, 6829.351211634887, 6563.9343606565235, 6588.176477940257, 6598.472122230306, 6624.470042396693, 6704.0], "value": 5324.095841766912, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [995.7062666513377, 1019.1031891935097, 1047.9895201047987, 1051.295631926609, 1058.4919238765392, 19031.048447577617, 19438.22247110114, 19479.902600486996, 19531.90234048828, 19663.70504442431, 19313.61372772544, 19412.708809367872, 19874.900625496888, 20846.374608761722, 20943.581128377424, 1085.0288991352734, 1100.3397961223282, 1100.3892839474088, 1101.047593831334, 1101.5869049106584, 1078.5254488025282, 1101.2456467319912, 1104.1001583709292, 1107.0755918807806, 1114.6823155400712, 1183.9822402663924, 1187.1393239901047, 1187.6555798818333, 1189.9821502677466, 1191.2614179208902, 1179.3808250668426, 1180.9645710628608, 1182.154759347071, 1185.324365111878, 1189.2091758980312, 862.7713655881197, 866.3978534918234, 866.7313132928749, 868.8001759595265, 868.8783570300163, 21008.369748907404, 21395.572088558143, 21554.353369398945, 21576.676349854766, 22199.778002219933, 22488.655218599462, 22698.20556280539, 23021.76978230213, 23058.538829223322, 23090.884545577333, 18123.01933873986, 18198.545036374064, 18235.270589176416, 18275.543111422186, 18325.266989320546, 3986.0, 4051.0277533391773, 4065.1869626074904, 4065.715399922007, 4067.857624983141, 168614.0, 170068.14965925214, 170134.1493292538, 171870.0, 173226.0, 15825.208739562975, 15922.840771592137, 15991.920040399724, 16048.919755401148, 16148.192590370434, 34533.82733086318, 34684.0, 34901.0, 35086.64913350885, 35096.0, 9274.489903055397, 9471.621135154517, 9548.713538593853, 9611.134997850228, 9635.662751803793, 4742.644301677388, 4843.128236917389, 4859.927101093486, 4870.342503762017, 4907.09218794517, 6070.453659170607, 6132.478739307209, 6164.0, 6180.690965451709, 6185.257769067741, 1243.5212443209248, 1248.9812652810215, 1257.8427696537933, 1258.804885242789, 1268.0299570828324, 756.5611945071845, 777.8366543025915, 780.2197802197802, 795.4431897671653, 803.754854769301, 12838.293893835742, 13190.60428187156, 13287.601371958857, 13585.388657510435, 13593.116447431083, 736.8010637127945, 750.9249075092447, 757.473555878659, 767.2595944913186, 767.8310771630344, 6214.40963108504, 6236.937630623635, 6257.74969001244, 6374.139491168726, 6424.967875160594, 157217.21391393198, 157223.0, 157864.21067894588, 159863.0, 160878.0, 134295.0, 135202.0, 135389.0, 136442.0, 138654.0, 117517.41241293738, 118221.40889295499, 118567.0, 118984.40507797405, 122806.0, 11726.237794543327, 11809.822852657046, 12016.63950081499, 12076.275423474619, 12088.758224835277, 57227.713861432094, 58426.4157358421, 58584.0, 59084.704576478565, 59205.0, 72939.0, 73168.634156831, 73986.26013739794, 74073.0, 76176.0, 16548.834511654728, 17224.65550689004, 17393.82606173922, 17636.294548217928, 17792.110394479965, 17064.74402883933, 17147.657046859244, 17253.0, 17289.654206916042, 17320.30718771235, 15262.236888155327, 15964.361425543313, 16006.199690015686, 16078.0, 16155.515334539983, 17347.219375128403, 17459.38892138769, 17482.213300401767, 17559.297628095243, 17563.473095807145, 17169.227384767466, 17308.134593270035, 17357.218925148652, 17429.564260893072, 17534.0, 13344.666383340495, 13365.599032029055, 13417.060805743504, 13487.190768553919, 13490.730185396042, 12213.633590992284, 12233.266004039786, 12285.938570307091, 12401.565945192237, 12515.12394132402], "value": 10040.627322128536, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1356.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 104.0, 104.0, 104.0, 104.0, 105.0, 107.0, 105.0, 104.0, 106.0], "value": 104.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 112.0, 108.0, 112.0, 112.0, 134.0, 115.0, 110.0, 139.0], "value": 116.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 161.0, 162.0, 163.0, 161.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 76.0, 73.0, 74.0, 74.0, 73.0, 72.0, 75.0, 72.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 80.0, 81.0, 77.0, 78.0, 78.0, 78.0, 78.0], "value": 78.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 114.0, 112.0, 113.0, 114.0, 114.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 148.0, 149.0, 149.0, 147.0, 149.0, 149.0, 149.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 93.0, 95.0, 94.0, 95.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 41.0, 42.0, 43.0, 44.0, 48.0, 46.0, 43.0, 48.0, 44.0], "value": 44.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 37.0, 44.0, 37.0, 38.0, 37.0, 38.0, 37.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 72.0, 71.0, 70.0, 70.0, 69.0, 70.0, 72.0, 70.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 105.0, 100.0, 105.0, 109.0, 102.0, 105.0, 103.0, 109.0, 99.0], "value": 103.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 148.0, 150.0, 150.0, 146.0, 147.0, 158.0, 150.0, 153.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 61.0, 57.0, 62.0, 58.0, 58.0, 59.0], "value": 59.6, "unit": "score"}]}]} 04:11:17 INFO - Return code: 0 04:11:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:11:17 INFO - # TBPL SUCCESS # 04:11:17 INFO - Running post-action listener: _package_coverage_data 04:11:17 INFO - Running post-action listener: _resource_record_post_action 04:11:17 INFO - [mozharness: 2017-10-05 11:11:17.158819Z] Finished run-tests step (success) 04:11:17 INFO - Running post-run listener: _resource_record_post_run 04:11:17 INFO - Total resource usage - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 348033024; Read time: 16; Write time: 180100 04:11:17 INFO - TinderboxPrint: CPU usage
13.0% 04:11:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:11:17 INFO - TinderboxPrint: I/O write bytes / time
348,033,024 / 180,100 04:11:17 INFO - TinderboxPrint: CPU idle
8,188.3 (86.9%) 04:11:17 INFO - TinderboxPrint: CPU user
1,178.9 (12.5%) 04:11:17 INFO - TinderboxPrint: Swap in / out
0 / 0 04:11:17 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 60227584; Read time: 0; Write time: 30452 04:11:17 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:11:17 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 0; Write bytes: 287395840; Read time: 0; Write time: 149624 04:11:17 INFO - Running post-run listener: _upload_blobber_files 04:11:17 INFO - Blob upload gear active. 04:11:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:11:17 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 04:11:17 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'] 04:11:17 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 04:11:18 INFO - (blobuploader) - INFO - Open directory for files ... 04:11:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:11:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:11:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:19 INFO - (blobuploader) - INFO - Done attempting. 04:11:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:11:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:11:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:23 INFO - (blobuploader) - INFO - Done attempting. 04:11:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:11:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:11:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:23 INFO - (blobuploader) - INFO - Done attempting. 04:11:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:11:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:11:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:25 INFO - (blobuploader) - INFO - Done attempting. 04:11:25 INFO - (blobuploader) - INFO - Iteration through files over. 04:11:25 INFO - Return code: 0 04:11:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:11:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:11:25 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/35e5f52e38f23b25347535e94a44ca3f486ac1705c3cc0e54b8ccb2d3a2aaed8aff1ff030da406f3a554666f8070d9a056e74da0a49f76a731d97a479da6f604", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d4fb67cae5286edb29295ad36d9de6718a0bf2595df6e3a953e9dbfad2126910c3d0edaa463185e71f3fa704d5efbdf4987fb59be0d5539cb2baa07375bf0301", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/274ef67cd6f1792df1d59cd2e38c5e1137661e042a2b0d52efb41a7b35727fe4051e6e0e467713540b5c84a85cbdb74c2b1798f57ae6bbbc62f0c76c2b304934", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b57650e10292a7a9d025e00ed97d7cbc4fd14ab95d33c8996e2d9e649a781e6a3573475e5c8d400a1ab4c38ac0ba8c5488c051aa2ac74b86ccab1f61be2f9544"} 04:11:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:11:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:11:25 INFO - Contents: 04:11:25 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/35e5f52e38f23b25347535e94a44ca3f486ac1705c3cc0e54b8ccb2d3a2aaed8aff1ff030da406f3a554666f8070d9a056e74da0a49f76a731d97a479da6f604", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d4fb67cae5286edb29295ad36d9de6718a0bf2595df6e3a953e9dbfad2126910c3d0edaa463185e71f3fa704d5efbdf4987fb59be0d5539cb2baa07375bf0301", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/274ef67cd6f1792df1d59cd2e38c5e1137661e042a2b0d52efb41a7b35727fe4051e6e0e467713540b5c84a85cbdb74c2b1798f57ae6bbbc62f0c76c2b304934", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b57650e10292a7a9d025e00ed97d7cbc4fd14ab95d33c8996e2d9e649a781e6a3573475e5c8d400a1ab4c38ac0ba8c5488c051aa2ac74b86ccab1f61be2f9544"} 04:11:25 INFO - Running post-run listener: copy_logs_to_upload_dir 04:11:25 INFO - Copying logs to upload dir... 04:11:25 INFO - mkdir: /builds/slave/test/build/upload/logs 04:11:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.796188 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2017-10-05 04:11:25.107671) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-05 04:11:25.115297) ========= 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=9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425 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/35e5f52e38f23b25347535e94a44ca3f486ac1705c3cc0e54b8ccb2d3a2aaed8aff1ff030da406f3a554666f8070d9a056e74da0a49f76a731d97a479da6f604", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d4fb67cae5286edb29295ad36d9de6718a0bf2595df6e3a953e9dbfad2126910c3d0edaa463185e71f3fa704d5efbdf4987fb59be0d5539cb2baa07375bf0301", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/274ef67cd6f1792df1d59cd2e38c5e1137661e042a2b0d52efb41a7b35727fe4051e6e0e467713540b5c84a85cbdb74c2b1798f57ae6bbbc62f0c76c2b304934", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b57650e10292a7a9d025e00ed97d7cbc4fd14ab95d33c8996e2d9e649a781e6a3573475e5c8d400a1ab4c38ac0ba8c5488c051aa2ac74b86ccab1f61be2f9544"} build_url:https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/IS7zatsMTCq1Es8WUuizWw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/35e5f52e38f23b25347535e94a44ca3f486ac1705c3cc0e54b8ccb2d3a2aaed8aff1ff030da406f3a554666f8070d9a056e74da0a49f76a731d97a479da6f604", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d4fb67cae5286edb29295ad36d9de6718a0bf2595df6e3a953e9dbfad2126910c3d0edaa463185e71f3fa704d5efbdf4987fb59be0d5539cb2baa07375bf0301", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/274ef67cd6f1792df1d59cd2e38c5e1137661e042a2b0d52efb41a7b35727fe4051e6e0e467713540b5c84a85cbdb74c2b1798f57ae6bbbc62f0c76c2b304934", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b57650e10292a7a9d025e00ed97d7cbc4fd14ab95d33c8996e2d9e649a781e6a3573475e5c8d400a1ab4c38ac0ba8c5488c051aa2ac74b86ccab1f61be2f9544"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-05 04:11:25.143777) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-05 04:11:25.147076) ========= 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=9bfb7e13875ed353a705960e000001c0-1507200655.359514-304628425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004685 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-05 04:11:25.199676) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-05 04:11:25.202994) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-05 04:11:25.203296) ========= ========= Total master_lag: 0.18 =========