builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-037 starttime: 1506008536.23 results: success (0) revision: 835a92b19e3d7666890153a84bc635bc43a44cb2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:16.226725) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:16.227289) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:16.227598) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:16.306975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:16.307239) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-21 08:42:16-- 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% 540K=0.02s 2017-09-21 08:42:16 (540 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.204227 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:16.545044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:16.545344) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017214 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:16.599422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:16.600123) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 835a92b19e3d7666890153a84bc635bc43a44cb2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 835a92b19e3d7666890153a84bc635bc43a44cb2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-21 08:42:16,471 truncating revision to first 12 chars 2017-09-21 08:42:16,471 Setting DEBUG logging. 2017-09-21 08:42:16,471 attempt 1/10 2017-09-21 08:42:16,471 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/835a92b19e3d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-21 08:42:16,719 unpacking tar archive at: mozilla-central-835a92b19e3d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.533336 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:17.149377) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:17.152717) ========= script_repo_revision: 835a92b19e3d7666890153a84bc635bc43a44cb2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:17.153110) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:17.153371) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 08:42:17.166665) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-21 08:42:17.167044) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:42:17 INFO - MultiFileLogger online at 20170921 08:42:17 in /builds/slave/test 08:42:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:42:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:17 INFO - {'append_to_log': False, 08:42:17 INFO - 'base_work_dir': '/builds/slave/test', 08:42:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:42:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:17 INFO - 'branch': 'Firefox-Non-PGO', 08:42:17 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:17 INFO - 'code_coverage': False, 08:42:17 INFO - 'config_files': ('talos/linux_config.py',), 08:42:17 INFO - 'default_actions': ('clobber', 08:42:17 INFO - 'read-buildbot-config', 08:42:17 INFO - 'download-and-extract', 08:42:17 INFO - 'populate-webroot', 08:42:17 INFO - 'create-virtualenv', 08:42:17 INFO - 'install', 08:42:17 INFO - 'setup-mitmproxy', 08:42:17 INFO - 'run-tests'), 08:42:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:17 INFO - 'disable_ccov_upload': False, 08:42:17 INFO - 'disable_stylo': False, 08:42:17 INFO - 'download_minidump_stackwalk': True, 08:42:17 INFO - 'download_symbols': 'ondemand', 08:42:17 INFO - 'enable_stylo': False, 08:42:17 INFO - 'enable_webrender': False, 08:42:17 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 08:42:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:17 INFO - 'gecko_profile': False, 08:42:17 INFO - 'gecko_profile_interval': 0, 08:42:17 INFO - 'installer_path': 'installer.exe', 08:42:17 INFO - 'log_level': 'info', 08:42:17 INFO - 'log_name': 'talos', 08:42:17 INFO - 'log_to_console': True, 08:42:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:42:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:42:17 INFO - 'opt_config_files': (), 08:42:17 INFO - 'pip_index': False, 08:42:17 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 08:42:17 INFO - 'system_bits': '32', 08:42:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:17 INFO - 'title': 'talos-linux64-ix-037', 08:42:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:17 INFO - 'use_talos_json': True, 08:42:17 INFO - 'verify': 'False', 08:42:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:17 INFO - 'work_dir': 'build'} 08:42:17 INFO - [mozharness: 2017-09-21 15:42:17.234665Z] Running clobber step. 08:42:17 INFO - Running pre-action listener: _resource_record_pre_action 08:42:17 INFO - Running main action method: clobber 08:42:17 INFO - rmtree: /builds/slave/test/build 08:42:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:18 INFO - Running post-action listener: _resource_record_post_action 08:42:18 INFO - [mozharness: 2017-09-21 15:42:18.190584Z] Finished clobber step (success) 08:42:18 INFO - [mozharness: 2017-09-21 15:42:18.190681Z] Running read-buildbot-config step. 08:42:18 INFO - Running pre-action listener: _resource_record_pre_action 08:42:18 INFO - Running main action method: read_buildbot_config 08:42:18 INFO - Using buildbot properties: 08:42:18 INFO - { 08:42:18 INFO - "project": "", 08:42:18 INFO - "product": "firefox", 08:42:18 INFO - "who": "jlorenzo@mozilla.com", 08:42:18 INFO - "installer_path": "public/build/target.tar.bz2", 08:42:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 08:42:18 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 08:42:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 08:42:18 INFO - "stage_platform": "linux64", 08:42:18 INFO - "basedir": "/builds/slave/test", 08:42:18 INFO - "buildnumber": 55, 08:42:18 INFO - "platform": "ubuntu64_hw", 08:42:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:42:18 INFO - "slavebuilddir": "test", 08:42:18 INFO - "taskId": "fClLKYOjSlqELFX-clPiug", 08:42:18 INFO - "branch": "mozilla-central", 08:42:18 INFO - "script_repo_revision": "production", 08:42:18 INFO - "revision": "835a92b19e3d7666890153a84bc635bc43a44cb2", 08:42:18 INFO - "slavename": "talos-linux64-ix-037", 08:42:18 INFO - "repo_path": "mozilla-central" 08:42:18 INFO - } 08:42:18 INFO - Finding installer, test and symbols from parent task. 08:42:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fClLKYOjSlqELFX-clPiug'}, attempt #1 08:42:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fClLKYOjSlqELFX-clPiug'}, attempt #1 08:42:19 INFO - Task dependencies: NkyEVKxfQa-s6GWN1Ap4sg 08:42:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg'}, attempt #1 08:42:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.tar.bz2 08:42:19 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.test_packages.json 08:42:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.crashreporter-symbols.zip 08:42:19 INFO - Running post-action listener: _resource_record_post_action 08:42:19 INFO - [mozharness: 2017-09-21 15:42:19.580165Z] Finished read-buildbot-config step (success) 08:42:19 INFO - [mozharness: 2017-09-21 15:42:19.580383Z] Running download-and-extract step. 08:42:19 INFO - Running pre-action listener: _resource_record_pre_action 08:42:19 INFO - Running main action method: download_and_extract 08:42:19 INFO - mkdir: /builds/slave/test/build/tests 08:42:19 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')]} 08:42:19 INFO - trying https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.test_packages.json 08:42:19 INFO - Downloading https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:42:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:42:20 INFO - Downloaded 989 bytes. 08:42:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:42:20 INFO - Using the following test package requirements: 08:42:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:42:20 INFO - u'common': [u'target.common.tests.zip'], 08:42:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:42:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:42:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:42:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:42:20 INFO - u'mozbase': [u'target.common.tests.zip'], 08:42:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:42:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:42:20 INFO - u'web-platform': [u'target.common.tests.zip', 08:42:20 INFO - u'target.web-platform.tests.tar.gz'], 08:42:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:42:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 08:42:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.common.tests.zip 08:42:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:42:20 INFO - Fetch https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.common.tests.zip into memory 08:42:21 INFO - Content-Length response header: 54741106 08:42:21 INFO - Bytes received: 54741106 08:42:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.talos.tests.zip 08:42:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:42:32 INFO - Fetch https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.talos.tests.zip into memory 08:42:33 INFO - Content-Length response header: 14509184 08:42:33 INFO - Bytes received: 14509184 08:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:33 INFO - trying https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.tar.bz2 08:42:33 INFO - Downloading https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:42:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:42:36 INFO - Downloaded 61627500 bytes. 08:42:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.tar.bz2 08:42:36 INFO - mkdir: /builds/slave/test/properties 08:42:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:36 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:36 INFO - Contents: 08:42:36 INFO - build_url:https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.tar.bz2 08:42:36 INFO - Running post-action listener: _resource_record_post_action 08:42:36 INFO - Running post-action listener: find_tests_for_verification 08:42:36 INFO - Running post-action listener: set_extra_try_arguments 08:42:36 INFO - [mozharness: 2017-09-21 15:42:36.572606Z] Finished download-and-extract step (success) 08:42:36 INFO - [mozharness: 2017-09-21 15:42:36.572811Z] Running populate-webroot step. 08:42:36 INFO - Running pre-action listener: _resource_record_pre_action 08:42:36 INFO - Running main action method: populate_webroot 08:42:36 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:42:36 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:42:36 INFO - 'tests': ['tresize', 08:42:36 INFO - 'tcanvasmark']}, 08:42:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:42:36 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:42:36 INFO - 'tests': ['dromaeo_css', 08:42:36 INFO - 'kraken']}, 08:42:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:42:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:36 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:42:36 INFO - 'talos_options': ['--disable-stylo'], 08:42:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:42:36 INFO - 'tests': ['damp', 'tps']}, 08:42:36 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:42:36 INFO - 'talos_options': ['--disable-stylo'], 08:42:36 INFO - 'tests': ['damp', 'tps']}, 08:42:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:36 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:42:36 INFO - 'tests': ['dromaeo_dom']}, 08:42:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:42:36 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:42:36 INFO - 'tests': ['basic_compositor_video', 08:42:36 INFO - 'glvideo']}, 08:42:36 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:42:36 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:42:36 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:42:36 INFO - 'talos_options': ['--disable-stylo'], 08:42:36 INFO - 'tests': ['ts_paint_webext', 08:42:36 INFO - 'tp5o_webext']}, 08:42:36 INFO - 'other-e10s': {'tests': ['a11yr', 08:42:36 INFO - 'ts_paint', 08:42:36 INFO - 'tpaint', 08:42:36 INFO - 'sessionrestore', 08:42:36 INFO - 'sessionrestore_many_windows', 08:42:36 INFO - 'sessionrestore_no_auto_restore', 08:42:36 INFO - 'tabpaint']}, 08:42:36 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:42:36 INFO - 'tests': ['a11yr', 08:42:36 INFO - 'ts_paint', 08:42:36 INFO - 'tpaint', 08:42:36 INFO - 'sessionrestore', 08:42:36 INFO - 'sessionrestore_many_windows', 08:42:36 INFO - 'sessionrestore_no_auto_restore', 08:42:36 INFO - 'tabpaint']}, 08:42:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:42:36 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 08:42:36 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:42:36 INFO - 'tests': ['perf_reftest_singletons']}, 08:42:36 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:42:36 INFO - 'tests': ['bloom_basic']}, 08:42:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:42:36 INFO - 'tsvgr_opacity', 08:42:36 INFO - 'tart', 08:42:36 INFO - 'tscrollx', 08:42:36 INFO - 'tsvg_static']}, 08:42:36 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:42:36 INFO - 'tests': ['tsvgx', 08:42:36 INFO - 'tsvgr_opacity', 08:42:36 INFO - 'tart', 08:42:36 INFO - 'tscrollx', 08:42:36 INFO - 'tsvg_static']}, 08:42:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:42:36 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:42:36 INFO - 'talos_options': ['--disable-stylo'], 08:42:36 INFO - 'tests': ['tp5o']}, 08:42:36 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:42:36 INFO - 'talos_options': ['--mitmproxy', 08:42:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:42:36 INFO - '--firstNonBlankPaint'], 08:42:36 INFO - 'tests': ['tp6_google', 08:42:36 INFO - 'tp6_youtube', 08:42:36 INFO - 'tp6_amazon', 08:42:36 INFO - 'tp6_facebook']}, 08:42:36 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:42:36 INFO - 'talos_options': ['--disable-stylo', 08:42:36 INFO - '--mitmproxy', 08:42:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:42:36 INFO - '--firstNonBlankPaint'], 08:42:36 INFO - 'tests': ['tp6_google', 08:42:36 INFO - 'tp6_youtube', 08:42:36 INFO - 'tp6_amazon', 08:42:36 INFO - 'tp6_facebook']}, 08:42:36 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:42:36 INFO - 'talos_options': ['--stylo-threads=1', 08:42:36 INFO - '--mitmproxy', 08:42:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:42:36 INFO - '--firstNonBlankPaint'], 08:42:36 INFO - 'tests': ['tp6_google', 08:42:36 INFO - 'tp6_youtube', 08:42:36 INFO - 'tp6_amazon', 08:42:36 INFO - 'tp6_facebook']}, 08:42:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:42:36 INFO - 'talos_options': ['--xperf_path', 08:42:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:36 INFO - 'tests': ['tp5n']}, 08:42:36 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:42:36 INFO - 'talos_options': ['--disable-stylo', 08:42:36 INFO - '--xperf_path', 08:42:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:36 INFO - 'tests': ['tp5n']}}} 08:42:36 INFO - Running post-action listener: _resource_record_post_action 08:42:36 INFO - [mozharness: 2017-09-21 15:42:36.594125Z] Finished populate-webroot step (success) 08:42:36 INFO - [mozharness: 2017-09-21 15:42:36.594214Z] Running create-virtualenv step. 08:42:36 INFO - Running pre-action listener: _resource_record_pre_action 08:42:36 INFO - Running main action method: create_virtualenv 08:42:36 INFO - Creating virtualenv /builds/slave/test/build/venv 08:42:36 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:42:36 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 08:42:36 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:42:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:42:38 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:38 INFO - Installing pip...............done. 08:42:38 INFO - Return code: 0 08:42:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:42:39 INFO - Reading from file tmpfile_stdout 08:42:39 INFO - Output received: 08:42:39 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 08:42:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:42:39 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')]} 08:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:39 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')]} 08:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:39 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 0x1e1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218f090>, '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 0x218fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2189f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', '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 08:42:39 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 08:42:39 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 08:42:39 INFO - Using env: {'DISPLAY': ':0', 08:42:39 INFO - 'HOME': '/home/cltbld', 08:42:39 INFO - 'LANG': 'en_US.UTF-8', 08:42:39 INFO - 'LANGUAGE': 'en_US:en', 08:42:39 INFO - 'LOGNAME': 'cltbld', 08:42:39 INFO - 'MAIL': '/var/mail/cltbld', 08:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:39 INFO - 'MOZ_NO_REMOTE': '1', 08:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:39 INFO - 'NO_EM_RESTART': '1', 08:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:39 INFO - 'PWD': '/builds/slave/test', 08:42:39 INFO - 'SHELL': '/bin/bash', 08:42:39 INFO - 'SHLVL': '1', 08:42:39 INFO - 'TERM': 'linux', 08:42:39 INFO - 'TMOUT': '86400', 08:42:39 INFO - 'USER': 'cltbld', 08:42:39 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', 08:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:39 INFO - '_': '/tools/buildbot/bin/python'} 08:42:40 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:42:40 INFO - Downloading/unpacking pip>=1.5 08:42:40 INFO - Running setup.py egg_info for package pip 08:42:40 INFO - warning: no files found matching 'pip/cacert.pem' 08:42:40 INFO - warning: no files found matching '*.html' under directory 'docs' 08:42:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:42:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:42:40 INFO - Installing collected packages: pip 08:42:40 INFO - Found existing installation: pip 1.1 08:42:40 INFO - Uninstalling pip: 08:42:40 INFO - Successfully uninstalled pip 08:42:40 INFO - Running setup.py install for pip 08:42:40 INFO - warning: no files found matching 'pip/cacert.pem' 08:42:40 INFO - warning: no files found matching '*.html' under directory 'docs' 08:42:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:42:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:42:40 INFO - Installing pip script to /builds/slave/test/build/venv/bin 08:42:40 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 08:42:40 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 08:42:40 INFO - Successfully installed pip 08:42:40 INFO - Cleaning up... 08:42:40 INFO - Return code: 0 08:42:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218f090>, '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 0x218fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2189f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', '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 08:42:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:42:40 INFO - Using env: {'DISPLAY': ':0', 08:42:40 INFO - 'HOME': '/home/cltbld', 08:42:40 INFO - 'LANG': 'en_US.UTF-8', 08:42:40 INFO - 'LANGUAGE': 'en_US:en', 08:42:40 INFO - 'LOGNAME': 'cltbld', 08:42:40 INFO - 'MAIL': '/var/mail/cltbld', 08:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:40 INFO - 'MOZ_NO_REMOTE': '1', 08:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:40 INFO - 'NO_EM_RESTART': '1', 08:42:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:40 INFO - 'PWD': '/builds/slave/test', 08:42:40 INFO - 'SHELL': '/bin/bash', 08:42:40 INFO - 'SHLVL': '1', 08:42:40 INFO - 'TERM': 'linux', 08:42:40 INFO - 'TMOUT': '86400', 08:42:40 INFO - 'USER': 'cltbld', 08:42:40 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', 08:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:40 INFO - '_': '/tools/buildbot/bin/python'} 08:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:40 INFO - Downloading/unpacking psutil>=3.1.1 08:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:41 INFO - Installing collected packages: psutil 08:42:41 INFO - Running setup.py install for psutil 08:42:41 INFO - building 'psutil._psutil_linux' extension 08:42:41 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 08:42:42 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 08:42:43 INFO - building 'psutil._psutil_posix' extension 08:42:43 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 08:42:43 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 08:42:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:43 INFO - Successfully installed psutil 08:42:43 INFO - Cleaning up... 08:42:43 INFO - Return code: 0 08:42:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:42:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218f090>, '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 0x218fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2189f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', '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 08:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:42:43 INFO - Using env: {'DISPLAY': ':0', 08:42:43 INFO - 'HOME': '/home/cltbld', 08:42:43 INFO - 'LANG': 'en_US.UTF-8', 08:42:43 INFO - 'LANGUAGE': 'en_US:en', 08:42:43 INFO - 'LOGNAME': 'cltbld', 08:42:43 INFO - 'MAIL': '/var/mail/cltbld', 08:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:43 INFO - 'MOZ_NO_REMOTE': '1', 08:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:43 INFO - 'NO_EM_RESTART': '1', 08:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:43 INFO - 'PWD': '/builds/slave/test', 08:42:43 INFO - 'SHELL': '/bin/bash', 08:42:43 INFO - 'SHLVL': '1', 08:42:43 INFO - 'TERM': 'linux', 08:42:43 INFO - 'TMOUT': '86400', 08:42:43 INFO - 'USER': 'cltbld', 08:42:43 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', 08:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:43 INFO - '_': '/tools/buildbot/bin/python'} 08:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:42:43 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 08:42:43 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 08:42:43 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 08:42:43 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 08:42:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:42:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:42:44 INFO - Installing collected packages: mozsystemmonitor 08:42:44 INFO - Running setup.py install for mozsystemmonitor 08:42:44 INFO - Successfully installed mozsystemmonitor 08:42:44 INFO - Cleaning up... 08:42:44 INFO - Return code: 0 08:42:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218f090>, '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 0x218fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2189f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', '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 08:42:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:42:44 INFO - Using env: {'DISPLAY': ':0', 08:42:44 INFO - 'HOME': '/home/cltbld', 08:42:44 INFO - 'LANG': 'en_US.UTF-8', 08:42:44 INFO - 'LANGUAGE': 'en_US:en', 08:42:44 INFO - 'LOGNAME': 'cltbld', 08:42:44 INFO - 'MAIL': '/var/mail/cltbld', 08:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:44 INFO - 'MOZ_NO_REMOTE': '1', 08:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:44 INFO - 'NO_EM_RESTART': '1', 08:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:44 INFO - 'PWD': '/builds/slave/test', 08:42:44 INFO - 'SHELL': '/bin/bash', 08:42:44 INFO - 'SHLVL': '1', 08:42:44 INFO - 'TERM': 'linux', 08:42:44 INFO - 'TMOUT': '86400', 08:42:44 INFO - 'USER': 'cltbld', 08:42:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', 08:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:44 INFO - '_': '/tools/buildbot/bin/python'} 08:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:45 INFO - Downloading/unpacking jsonschema==2.5.1 08:42:45 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 08:42:45 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 08:42:45 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 08:42:45 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 08:42:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:42:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:46 INFO - Downloading functools32-3.2.3-2.tar.gz 08:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:42:46 INFO - warning: no files found matching '*.txt' 08:42:46 INFO - no previously-included directories found matching 'build' 08:42:46 INFO - no previously-included directories found matching 'dist' 08:42:46 INFO - no previously-included directories found matching '.git*' 08:42:46 INFO - Installing collected packages: jsonschema, functools32 08:42:46 INFO - Running setup.py install for functools32 08:42:46 INFO - warning: no files found matching '*.txt' 08:42:46 INFO - no previously-included directories found matching 'build' 08:42:46 INFO - no previously-included directories found matching 'dist' 08:42:46 INFO - no previously-included directories found matching '.git*' 08:42:46 INFO - Successfully installed jsonschema functools32 08:42:46 INFO - Cleaning up... 08:42:46 INFO - Return code: 0 08:42:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218f090>, '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 0x218fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2189f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', '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 08:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:42:46 INFO - Using env: {'DISPLAY': ':0', 08:42:46 INFO - 'HOME': '/home/cltbld', 08:42:46 INFO - 'LANG': 'en_US.UTF-8', 08:42:46 INFO - 'LANGUAGE': 'en_US:en', 08:42:46 INFO - 'LOGNAME': 'cltbld', 08:42:46 INFO - 'MAIL': '/var/mail/cltbld', 08:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:46 INFO - 'MOZ_NO_REMOTE': '1', 08:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:46 INFO - 'NO_EM_RESTART': '1', 08:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:46 INFO - 'PWD': '/builds/slave/test', 08:42:46 INFO - 'SHELL': '/bin/bash', 08:42:46 INFO - 'SHLVL': '1', 08:42:46 INFO - 'TERM': 'linux', 08:42:46 INFO - 'TMOUT': '86400', 08:42:46 INFO - 'USER': 'cltbld', 08:42:46 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', 08:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:46 INFO - '_': '/tools/buildbot/bin/python'} 08:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:42:46 INFO - Cleaning up... 08:42:46 INFO - Return code: 0 08:42:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218f090>, '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 0x218fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2189f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', '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 08:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:42:46 INFO - Using env: {'DISPLAY': ':0', 08:42:46 INFO - 'HOME': '/home/cltbld', 08:42:46 INFO - 'LANG': 'en_US.UTF-8', 08:42:46 INFO - 'LANGUAGE': 'en_US:en', 08:42:46 INFO - 'LOGNAME': 'cltbld', 08:42:46 INFO - 'MAIL': '/var/mail/cltbld', 08:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:46 INFO - 'MOZ_NO_REMOTE': '1', 08:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:46 INFO - 'NO_EM_RESTART': '1', 08:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:46 INFO - 'PWD': '/builds/slave/test', 08:42:46 INFO - 'SHELL': '/bin/bash', 08:42:46 INFO - 'SHLVL': '1', 08:42:46 INFO - 'TERM': 'linux', 08:42:46 INFO - 'TMOUT': '86400', 08:42:46 INFO - 'USER': 'cltbld', 08:42:46 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', 08:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:46 INFO - '_': '/tools/buildbot/bin/python'} 08:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:46 INFO - Downloading/unpacking blobuploader==1.2.4 08:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:48 INFO - Downloading blobuploader-1.2.4.tar.gz 08:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:42:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:42:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:48 INFO - Downloading docopt-0.6.1.tar.gz 08:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:42:48 INFO - Installing collected packages: blobuploader, requests, docopt 08:42:48 INFO - Running setup.py install for blobuploader 08:42:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:42:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:42:48 INFO - Running setup.py install for requests 08:42:49 INFO - Running setup.py install for docopt 08:42:49 INFO - Successfully installed blobuploader requests docopt 08:42:49 INFO - Cleaning up... 08:42:49 INFO - Return code: 0 08:42:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:49 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 0x1e1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218f090>, '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 0x218fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2189f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', '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 08:42:49 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 08:42:49 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 08:42:49 INFO - Using env: {'DISPLAY': ':0', 08:42:49 INFO - 'HOME': '/home/cltbld', 08:42:49 INFO - 'LANG': 'en_US.UTF-8', 08:42:49 INFO - 'LANGUAGE': 'en_US:en', 08:42:49 INFO - 'LOGNAME': 'cltbld', 08:42:49 INFO - 'MAIL': '/var/mail/cltbld', 08:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:49 INFO - 'MOZ_NO_REMOTE': '1', 08:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:49 INFO - 'NO_EM_RESTART': '1', 08:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:49 INFO - 'PWD': '/builds/slave/test', 08:42:49 INFO - 'SHELL': '/bin/bash', 08:42:49 INFO - 'SHLVL': '1', 08:42:49 INFO - 'TERM': 'linux', 08:42:49 INFO - 'TMOUT': '86400', 08:42:49 INFO - 'USER': 'cltbld', 08:42:49 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', 08:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:49 INFO - '_': '/tools/buildbot/bin/python'} 08:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:49 INFO - Running setup.py (path:/tmp/pip-y95HgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:49 INFO - Running setup.py (path:/tmp/pip-t2whKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:49 INFO - Running setup.py (path:/tmp/pip-QtcIn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:49 INFO - Running setup.py (path:/tmp/pip-RM8aew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:49 INFO - Running setup.py (path:/tmp/pip-4u1aIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:49 INFO - Running setup.py (path:/tmp/pip-E8Fu9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:49 INFO - Running setup.py (path:/tmp/pip-F_p_hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:49 INFO - Running setup.py (path:/tmp/pip-qGnIaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:50 INFO - Running setup.py (path:/tmp/pip-4QtOIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:50 INFO - Running setup.py (path:/tmp/pip-Xp1tF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:50 INFO - Running setup.py (path:/tmp/pip-3udGVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:50 INFO - Running setup.py (path:/tmp/pip-DzfQog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:50 INFO - Running setup.py (path:/tmp/pip-phwa8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:50 INFO - Running setup.py (path:/tmp/pip-pBZ3ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:50 INFO - Running setup.py (path:/tmp/pip-mtOlTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:50 INFO - Running setup.py (path:/tmp/pip-ueYLUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:50 INFO - Running setup.py (path:/tmp/pip-VEXoVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:42:50 INFO - Running setup.py install for manifestparser 08:42:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Running setup.py install for mozcrash 08:42:50 INFO - Running setup.py install for mozdebug 08:42:50 INFO - Running setup.py install for mozdevice 08:42:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Running setup.py install for mozfile 08:42:51 INFO - Running setup.py install for mozhttpd 08:42:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Running setup.py install for mozinfo 08:42:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Running setup.py install for mozInstall 08:42:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Running setup.py install for mozleak 08:42:51 INFO - Running setup.py install for mozlog 08:42:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Running setup.py install for moznetwork 08:42:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Running setup.py install for mozprocess 08:42:51 INFO - Running setup.py install for mozprofile 08:42:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Running setup.py install for mozrunner 08:42:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:52 INFO - Running setup.py install for mozscreenshot 08:42:52 INFO - Running setup.py install for moztest 08:42:52 INFO - Running setup.py install for mozversion 08:42:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:52 INFO - Cleaning up... 08:42:52 INFO - Return code: 0 08:42:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:52 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 0x1e1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218f090>, '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 0x218fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2189f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', '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 08:42:52 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 08:42:52 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 08:42:52 INFO - Using env: {'DISPLAY': ':0', 08:42:52 INFO - 'HOME': '/home/cltbld', 08:42:52 INFO - 'LANG': 'en_US.UTF-8', 08:42:52 INFO - 'LANGUAGE': 'en_US:en', 08:42:52 INFO - 'LOGNAME': 'cltbld', 08:42:52 INFO - 'MAIL': '/var/mail/cltbld', 08:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:52 INFO - 'MOZ_NO_REMOTE': '1', 08:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:52 INFO - 'NO_EM_RESTART': '1', 08:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:52 INFO - 'PWD': '/builds/slave/test', 08:42:52 INFO - 'SHELL': '/bin/bash', 08:42:52 INFO - 'SHLVL': '1', 08:42:52 INFO - 'TERM': 'linux', 08:42:52 INFO - 'TMOUT': '86400', 08:42:52 INFO - 'USER': 'cltbld', 08:42:52 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', 08:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:52 INFO - '_': '/tools/buildbot/bin/python'} 08:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:52 INFO - Running setup.py (path:/tmp/pip-DxUdDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:52 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)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:52 INFO - Running setup.py (path:/tmp/pip-dileOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:52 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)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:52 INFO - Running setup.py (path:/tmp/pip-xV9ljU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:52 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)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:52 INFO - Running setup.py (path:/tmp/pip-TEY5UO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:52 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)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:52 INFO - Running setup.py (path:/tmp/pip-e4mk3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:52 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)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:52 INFO - Running setup.py (path:/tmp/pip-8AOoAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:53 INFO - Running setup.py (path:/tmp/pip-fS9AN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:53 INFO - Running setup.py (path:/tmp/pip-ds2FhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:53 INFO - Running setup.py (path:/tmp/pip-mGTH0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:53 INFO - Running setup.py (path:/tmp/pip-ufd98z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:53 INFO - Running setup.py (path:/tmp/pip-lkPgIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:53 INFO - Running setup.py (path:/tmp/pip-gr9j7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:53 INFO - Running setup.py (path:/tmp/pip-BSuUUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:53 INFO - Running setup.py (path:/tmp/pip-xH2iny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:53 INFO - Running setup.py (path:/tmp/pip-HMn48L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:53 INFO - Running setup.py (path:/tmp/pip-nPQVBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:53 INFO - Running setup.py (path:/tmp/pip-9UDYIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:53 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)) 08:42:53 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)) 08:42:53 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)) 08:42:53 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)) 08:42:53 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)) 08:42:53 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)) 08:42:53 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)) 08:42:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:54 INFO - Downloading blessings-1.6.tar.gz 08:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:42:55 INFO - Installing collected packages: blessings 08:42:55 INFO - Running setup.py install for blessings 08:42:55 INFO - Successfully installed blessings 08:42:55 INFO - Cleaning up... 08:42:55 INFO - Return code: 0 08:42:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:42:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:55 INFO - Reading from file tmpfile_stdout 08:42:55 INFO - Current package versions: 08:42:55 INFO - argparse == 1.2.1 08:42:55 INFO - blessings == 1.6 08:42:55 INFO - blobuploader == 1.2.4 08:42:55 INFO - docopt == 0.6.1 08:42:55 INFO - functools32 == 3.2.3-2 08:42:55 INFO - jsonschema == 2.5.1 08:42:55 INFO - manifestparser == 1.1 08:42:55 INFO - mozInstall == 1.13 08:42:55 INFO - mozcrash == 1.0 08:42:55 INFO - mozdebug == 0.1 08:42:55 INFO - mozdevice == 0.51 08:42:55 INFO - mozfile == 1.2 08:42:55 INFO - mozhttpd == 0.7 08:42:55 INFO - mozinfo == 0.10 08:42:55 INFO - mozleak == 0.1 08:42:55 INFO - mozlog == 3.5 08:42:55 INFO - moznetwork == 0.27 08:42:55 INFO - mozprocess == 0.25 08:42:55 INFO - mozprofile == 0.28 08:42:55 INFO - mozrunner == 6.13 08:42:55 INFO - mozscreenshot == 0.1 08:42:55 INFO - mozsystemmonitor == 0.3 08:42:55 INFO - moztest == 0.8 08:42:55 INFO - mozversion == 1.4 08:42:55 INFO - psutil == 3.1.1 08:42:55 INFO - requests == 1.2.3 08:42:55 INFO - wsgiref == 0.1.2 08:42:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:55 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')]} 08:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:55 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')]} 08:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:55 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 0x1e1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218f090>, '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 0x218fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2189f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', '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 08:42:55 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 08:42:55 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 08:42:55 INFO - Using env: {'DISPLAY': ':0', 08:42:55 INFO - 'HOME': '/home/cltbld', 08:42:55 INFO - 'LANG': 'en_US.UTF-8', 08:42:55 INFO - 'LANGUAGE': 'en_US:en', 08:42:55 INFO - 'LOGNAME': 'cltbld', 08:42:55 INFO - 'MAIL': '/var/mail/cltbld', 08:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:55 INFO - 'MOZ_NO_REMOTE': '1', 08:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:55 INFO - 'NO_EM_RESTART': '1', 08:42:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:55 INFO - 'PWD': '/builds/slave/test', 08:42:55 INFO - 'SHELL': '/bin/bash', 08:42:55 INFO - 'SHLVL': '1', 08:42:55 INFO - 'TERM': 'linux', 08:42:55 INFO - 'TMOUT': '86400', 08:42:55 INFO - 'USER': 'cltbld', 08:42:55 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', 08:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:55 INFO - '_': '/tools/buildbot/bin/python'} 08:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:55 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)) 08:42:55 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)) 08:42:55 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)) 08:42:55 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)) 08:42:55 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)) 08:42:55 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)) 08:42:55 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)) 08:42:55 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)) 08:42:55 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)) 08:42:55 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:42:56 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)) 08:42:56 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)) 08:42:56 INFO - Installing collected packages: simplejson 08:42:56 INFO - Running setup.py install for simplejson 08:42:56 INFO - building 'simplejson._speedups' extension 08:42:56 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 08:42:57 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 08:42:57 INFO - Successfully installed simplejson 08:42:57 INFO - Cleaning up... 08:42:57 INFO - Return code: 0 08:42:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:57 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 0x1e1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218f090>, '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 0x218fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2189f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', '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 08:42:57 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 08:42:57 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 08:42:57 INFO - Using env: {'DISPLAY': ':0', 08:42:57 INFO - 'HOME': '/home/cltbld', 08:42:57 INFO - 'LANG': 'en_US.UTF-8', 08:42:57 INFO - 'LANGUAGE': 'en_US:en', 08:42:57 INFO - 'LOGNAME': 'cltbld', 08:42:57 INFO - 'MAIL': '/var/mail/cltbld', 08:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:57 INFO - 'MOZ_NO_REMOTE': '1', 08:42:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:57 INFO - 'NO_EM_RESTART': '1', 08:42:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:57 INFO - 'PWD': '/builds/slave/test', 08:42:57 INFO - 'SHELL': '/bin/bash', 08:42:57 INFO - 'SHLVL': '1', 08:42:57 INFO - 'TERM': 'linux', 08:42:57 INFO - 'TMOUT': '86400', 08:42:57 INFO - 'USER': 'cltbld', 08:42:57 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', 08:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:57 INFO - '_': '/tools/buildbot/bin/python'} 08:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:42:58 INFO - Cleaning up... 08:42:58 INFO - Return code: 0 08:42:58 INFO - Running post-action listener: _resource_record_post_action 08:42:58 INFO - Running post-action listener: _start_resource_monitoring 08:42:58 INFO - Starting resource monitoring. 08:42:58 INFO - [mozharness: 2017-09-21 15:42:58.137474Z] Finished create-virtualenv step (success) 08:42:58 INFO - [mozharness: 2017-09-21 15:42:58.137977Z] Running install step. 08:42:58 INFO - Running pre-action listener: _resource_record_pre_action 08:42:58 INFO - Running main action method: install 08:42:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:58 INFO - Reading from file tmpfile_stdout 08:42:58 INFO - Detecting whether we're running mozinstall >=1.0... 08:42:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:42:58 INFO - Reading from file tmpfile_stdout 08:42:58 INFO - Output received: 08:42:58 INFO - Usage: mozinstall [options] installer 08:42:58 INFO - Options: 08:42:58 INFO - -h, --help show this help message and exit 08:42:58 INFO - -d DEST, --destination=DEST 08:42:58 INFO - Directory to install application into. [default: 08:42:58 INFO - "/builds/slave/test"] 08:42:58 INFO - --app=APP Application being installed. [default: firefox] 08:42:58 INFO - mkdir: /builds/slave/test/build/application 08:42:58 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'] 08:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:43:16 INFO - Reading from file tmpfile_stdout 08:43:16 INFO - Output received: 08:43:16 INFO - /builds/slave/test/build/application/firefox/firefox 08:43:16 INFO - Running post-action listener: _resource_record_post_action 08:43:16 INFO - [mozharness: 2017-09-21 15:43:16.285547Z] Finished install step (success) 08:43:16 INFO - [mozharness: 2017-09-21 15:43:16.285796Z] Running setup-mitmproxy step. 08:43:16 INFO - Running pre-action listener: _resource_record_pre_action 08:43:16 INFO - Running main action method: setup_mitmproxy 08:43:16 INFO - Skipping: mitmproxy is not required 08:43:16 INFO - Running post-action listener: _resource_record_post_action 08:43:16 INFO - [mozharness: 2017-09-21 15:43:16.286926Z] Finished setup-mitmproxy step (success) 08:43:16 INFO - [mozharness: 2017-09-21 15:43:16.287146Z] Running run-tests step. 08:43:16 INFO - Running pre-action listener: _resource_record_pre_action 08:43:16 INFO - Running pre-action listener: _set_gcov_prefix 08:43:16 INFO - Running main action method: run_tests 08:43:16 WARNING - Try message not found. 08:43:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:16 INFO - Python 2.7.3 08:43:16 INFO - Return code: 0 08:43:16 INFO - grabbing minidump binary from tooltool 08:43: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')]} 08:43:16 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 0x218f090>, '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 0x218fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2189f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:16 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 08:43:16 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 08:43:16 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 08:43:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:16 INFO - Return code: 0 08:43:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:43:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:16 INFO - ENV: RUST_BACKTRACE is now full 08:43:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:43:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 08:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 08:43:16 INFO - Using env: {'DISPLAY': ':0', 08:43:16 INFO - 'HOME': '/home/cltbld', 08:43:16 INFO - 'LANG': 'en_US.UTF-8', 08:43:16 INFO - 'LANGUAGE': 'en_US:en', 08:43:16 INFO - 'LOGNAME': 'cltbld', 08:43:16 INFO - 'MAIL': '/var/mail/cltbld', 08:43:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:16 INFO - 'MOZ_NO_REMOTE': '1', 08:43:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:16 INFO - 'NO_EM_RESTART': '1', 08:43:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:16 INFO - 'PWD': '/builds/slave/test', 08:43:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:16 INFO - 'RUST_BACKTRACE': 'full', 08:43:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:43:16 INFO - 'SHELL': '/bin/bash', 08:43:16 INFO - 'SHLVL': '1', 08:43:16 INFO - 'TERM': 'linux', 08:43:16 INFO - 'TMOUT': '86400', 08:43:16 INFO - 'USER': 'cltbld', 08:43:16 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', 08:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:16 INFO - '_': '/tools/buildbot/bin/python'} 08:43:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 08:43:16 INFO - mozversion application_buildid: 20170921144305 08:43:16 INFO - mozversion application_changeset: 835a92b19e3d7666890153a84bc635bc43a44cb2 08:43:16 INFO - mozversion application_display_name: Nightly 08:43:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:16 INFO - mozversion application_name: Firefox 08:43:16 INFO - mozversion application_remotingname: firefox 08:43:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:43:16 INFO - mozversion application_vendor: Mozilla 08:43:16 INFO - mozversion application_version: 58.0a1 08:43:16 INFO - mozversion platform_buildid: 20170921144305 08:43:16 INFO - mozversion platform_changeset: 835a92b19e3d7666890153a84bc635bc43a44cb2 08:43:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:43:16 INFO - mozversion platform_version: 58.0a1 08:43:16 INFO - using testdate: 1506008596 08:43:16 INFO - actual date: 1506008596 08:43:16 INFO - starting webserver on 'localhost:48174' 08:43:16 INFO - SUITE-START | Running 2 tests 08:43:16 INFO - TEST-START | dromaeo_css 08:43:16 INFO - Initialising browser for dromaeo_css test... 08:43:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48174/getInfo.html -profile /tmp/tmpXllteq/profile 08:43:16 INFO - TEST-INFO | started process 3528 (/builds/slave/test/build/application/firefox/firefox http://localhost:48174/getInfo.html) 08:43:26 INFO - TEST-INFO | 3528: exit 0 08:43:26 INFO - Browser initialized. 08:43:26 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:26 INFO - Using env: {'DISPLAY': ':0', 08:43:26 INFO - 'HOME': '/home/cltbld', 08:43:26 INFO - 'JSGC_DISABLE_POISONING': '1', 08:43:26 INFO - 'LANG': 'en_US.UTF-8', 08:43:26 INFO - 'LANGUAGE': 'en_US:en', 08:43:26 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:43:26 INFO - 'LOGNAME': 'cltbld', 08:43:26 INFO - 'MAIL': '/var/mail/cltbld', 08:43:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:43:26 INFO - 'MOZ_CRASHREPORTER': '1', 08:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:26 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:43:26 INFO - 'MOZ_NO_REMOTE': '1', 08:43:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:26 INFO - 'NO_EM_RESTART': '1', 08:43:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:26 INFO - 'PWD': '/builds/slave/test', 08:43:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:26 INFO - 'RUST_BACKTRACE': 'full', 08:43:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:43:26 INFO - 'SHELL': '/bin/bash', 08:43:26 INFO - 'SHLVL': '1', 08:43:26 INFO - 'STYLO_FORCE_DISABLED': '1', 08:43:26 INFO - 'TERM': 'linux', 08:43:26 INFO - 'TMOUT': '86400', 08:43:26 INFO - 'USER': 'cltbld', 08:43:26 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', 08:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:26 INFO - '_': '/tools/buildbot/bin/python'} 08:43:26 INFO - TEST-INFO | started process 3756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXllteq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:27 INFO - PID 3756 | 08:43:27 INFO - PID 3756 | (/builds/slave/test/build/application/firefox/firefox:3805): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:43:27 INFO - PID 3756 | 08:43:37 INFO - PID 3756 | RSS: Main: 150380544 08:43:37 INFO - PID 3756 | 08:46:34 INFO - PID 3756 | Cycle 1(1): loaded http://localhost:48174/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48174/tests/dromaeo/cssquery-ext.html) 08:46:36 INFO - PID 3756 | RSS: Main: 155013120 08:46:36 INFO - PID 3756 | 08:49:38 INFO - PID 3756 | Cycle 1(1): loaded http://localhost:48174/tests/dromaeo/cssquery-ext.html (next: http://localhost:48174/tests/dromaeo/cssquery-jquery.html) 08:49:38 INFO - PID 3756 | RSS: Main: 154746880 08:49:38 INFO - PID 3756 | 08:52:40 INFO - PID 3756 | Cycle 1(1): loaded http://localhost:48174/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48174/tests/dromaeo/cssquery-mootools.html) 08:52:40 INFO - PID 3756 | RSS: Main: 156131328 08:52:40 INFO - PID 3756 | 08:55:42 INFO - PID 3756 | Cycle 1(1): loaded http://localhost:48174/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48174/tests/dromaeo/cssquery-prototype.html) 08:55:43 INFO - PID 3756 | RSS: Main: 154689536 08:55:43 INFO - PID 3756 | 08:58:46 INFO - PID 3756 | Cycle 1(1): loaded http://localhost:48174/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48174/tests/dromaeo/cssquery-yui.html) 08:58:46 INFO - PID 3756 | RSS: Main: 156557312 08:58:46 INFO - PID 3756 | 09:01:48 INFO - PID 3756 | Cycle 1(1): loaded http://localhost:48174/tests/dromaeo/cssquery-yui.html (next: http://localhost:48174/tests/dromaeo/cssquery-dojo.html) 09:01:48 INFO - PID 3756 | RSS: Main: 158928896 09:01:48 INFO - PID 3756 | 09:01:48 INFO - PID 3756 | __start_tp_report 09:01:48 INFO - PID 3756 | _x_x_mozilla_page_load 09:01:48 INFO - PID 3756 | _x_x_mozilla_page_load_details 09:01:48 INFO - PID 3756 | |i|pagename|runs| 09:01:48 INFO - PID 3756 | |0;dojo.html;3162.288485090855;3169.033444799337;3179.5230715392704;3188.8086714797114;3201.215702152973;6344.080108384293;6348.269948955872;6396.200474940632;6398.424141827246;6459.3217712140195;6384;6495.0582165585965;6497.18785151856;6525.5758375705545;6533.509986750989;5703.800366987156;5822.912656310159;5867.677277749712;5927.02204136317;5977.641341519501;5639.351474580435;5812.854678633025;5876.823695289148;5921.082232253986;6019.277686677605;5763.798267060653;5799.536037117042;5838.182654428383;5873.295204575457;5878.235829342201;5805.854853628651;5881.294244690622;5897.587168898179;5916.526677865761;5939.465448109648;5809.919109264179;5843;5913.113033045035;5914.37899020601;5920.437558431942;6289.622622642656;6339.8415039623915;6402.679866006681;6408.198975128109;6450.322716114787;6834.384905358492;6927.064846245793;6932.410745086674;6940.958856171565;6954.513184077116;6858.348456896637;6916.6541672916655;6932.514723969324;7006.649667516604;7023.367896889305;6237.87524249517;6332.810015699536;6337.7781777637565;6338.746450141989;6340.270868850095;7008.26413226614;7011.1586609607175;7030.296970303031;7049.4712896532965;7129.2870712929325;6780.457563394916;6805.4895882808;6866.210385805696;6868.347506986828;6868.519203655696;6873.20958089826;6895.034695142684;6909.136357955255;6981.2669669683955;6987.266337034538;6616.139901812733;6637.435817955431;6751.358620931003;6829.4877884157895;6914.412274956685;6788.830279243059;6835.07726456922;6856.314368563204;6865.347791959756;6880.174379074543;5386.622936394415;5439.5376393006245;5442.047641662693;5447.727613619382;5454.563634909197;4645.9303110453375;4659;4703.623710103184;4733.573978341966;4741.336212930192;5664.320281566238;5736.942630573641;5803.8549036274435;5854.8536286592325;5880.8235752927485;6925;6927.272636373209;6929.549579277432;6945.166580010431;6952.5480843745;5680;5853.912191317134;5857.4435428634215;5867.207926929896;5872.236609240771;5883.764649413975;5891.440313170242;5955.731992060368;5960.165576819249;5965.254343207099;6473.643949582724;6534.346565343522;6547.050677651714;6647.5346725729705;6740.528163028639;6799.898001529882;6826.317368263134;6827.6244806536115;6828.453723702191;6830.146231721035;6596.439302659136;6633.867322653617;6710.966445167743;6715.664216789239;6733;6728.629925354153;6780.050792889098;6784.660766961731;6819.522633415613;6823.249442561413;6853.280405557344;6863.965680171567;6882.552634078769;6952.270011648704;6965.547239429421;6537.967310163419;6630.83422914431;6635.933640663531;6648.301928297459;6729.192496900403;6625.337466253336;6631.668416579055;6634.668266586747;6707.899381509379;6730.158730158731;6647;6657.866842663217;6663.13379260693;6674.16572928384;6691.5650482718465;6619.569727967667;6702.162229721285;6722.731090756315;6772.288909664414;6824.863502730017;6309.211348581427;6470.320616335217;6476.0933469313395;6515.576487528296;6605.834854128685 09:01:48 INFO - PID 3756 | |1;ext.html;861.8707193920911;880.058337578791;893.9597718102686;894.7539426657672;906.2795077913054;42070.789646051766;42527.36208956864;42581;42644.57355426448;42742.78628606853;39269.41095883564;39273.21453570934;39469;39520.407193892046;39636.801815990955;7014.473914456411;7123.180834204055;7154.67803948821;7160.033395491594;7168.032315637401;7069.25772793857;7163.391111755507;7168.784936451915;7180.928190718104;7181.640917954108;7947.4834135781275;8110.553919534424;8119.066307374668;8122.959385203066;8129.918700813005;7998.320142787812;8024.799380015488;8061.476004059776;8068;8090.797730056766;7397.778066658009;7945.920540794576;8015.639296231683;8025.839483210303;8028.0767711713315;39241.01897452558;39674;39724;39816.20367592632;39845.40231896495;3546.202104526487;3569.8929032128817;3601;3604.837782299777;3609.205974685591;31938.840305798323;32219.838900805582;32297.67702322994;32359.838200808845;32391;5206.271122042917;5259.447757985433;5267.078261304295;5292.92060619091;5303.840884773463;187481;187599;188105;188293;188606;42057;42852.57147428486;48842.75578622084;49475.50524494709;49875.501244987085;51132.74433627808;51171.48828511742;51188;51444;51444.48555514472;15108.622284442758;15177.924110379598;15213.163276019925;15221.162836044125;15256.923715381352;12276.263424194398;12321.137520373668;12345.753084938431;12355.567555135527;12365.258084514959;13814.37835297414;13817.378217980015;13885.722285554435;13897.444102235999;14015.229162395963;5519.337679478488;5603.355614104348;5626.746796394172;5632.5212356950115;5672.688002159921;1013.4071568132725;1018.7351288664852;1025.3489034463169;1032.4476405123223;1046.7016900183412;22760.88619556925;22776.31671049871;23090.094574415132;23200.071997119925;23270.534589308118;1124.083871644607;1133.2855321861018;1133.665568657248;1140.3158105136852;1143.8341440491083;12053.939730301292;12141.603715572823;12146.331951742739;12173.513059477522;12296.20074695142;235912;238189;238280;238490;238491;53009.734951325765;53047.46952530502;53092.46907530953;53302.73348633232;53339.73330133402;1444.9060811047248;1451.7241724072392;1457.6064462595252;1469.0598017268956;1478.2756449339747;21858.234961776896;22832.429189270402;22854.54290914139;22940;23085.076596936608;37047.81476092602;37069.07327316839;37091.814540927124;37116.628833711315;37153.814230929755;195516;195758;196035;196145;196278;33109.66890331162;34545;35422.822885885405;35450.29099418049;35456.29087418289;44896.32655510235;46151.53848461607;46310.53689463062;46482.07035859196;46528.302075468215;33539.496907545916;33705.662943370255;33803;33805.66194338025;33862.15344616404;33060.834695826365;33277.83361083179;33322;33853.492197616564;34104;37204.255914882095;37247.81376093102;37421;37450.43824342582;37531;32943;33438;33520.16199595029;33589.83205084057;33874.49188262227;23742.881285593463;23814;23873.52252954966;24100.15649452261;24368.63447048331 09:01:48 INFO - PID 3756 | |2;jquery.html;579.2903692976105;589.7110415896212;595.9821205363838;617.6818938246803;617.7528988404638;22021.66967495487;23107.30678079656;23141.768582314173;23168.189113381035;23182.188623398186;24288.27135185943;24398.146064887733;24847.627285590686;24914.626280605804;24992.625110623354;6472.838179045526;6642.036904648823;6642.9667851660915;6644.368784965444;6646.435053020499;6346.746130154788;6518.57629254097;6589.077529145923;6624.668766561676;6626.602403855784;6603;6610.272869984322;6616.338366163369;6619.238787539446;6620.668966551677;6586.802395928154;6586.901196482057;6588.571742836701;6607.141071660653;6611.107500487421;6121.112438696408;6124.1732366130445;6125.111858780497;6138.263408390977;6145.4161854623735;27542.724572754218;28559.143225703054;28596.285092872844;29019.70980290212;29155;2018.0817727933754;2049.907754151067;2051.4256008317548;2052.7126202331688;2052.8973551322524;18507.352242671575;19001;19017.239310427565;19035.428937131906;19176.232950681955;2120.4486833423266;2153.493928926701;2191.704119943819;2202.8458007939453;2203.151786562169;119835.4008229962;126427.36786316101;132602.3369883154;133445;142306.28846855802;14906.403743850342;14979.625509362135;15075.170865602278;15114.470993515175;15123.773143402857;23837.284881453583;23880.164194253117;23904.40238994004;23928.521429571312;23956.88021559881;9615;9659.517024148765;9696.660616878375;9711.077447642463;9843.655472058586;8724.432911860835;8763;8774.60514276859;8867.201951824367;8883.333749968779;9158.313126515539;9194.724158275263;9301.255899528021;9355.29835262358;9566.426014439156;2637.973620263811;2639.4853003664484;2660.162048954573;2756.131818477173;2763.8618069096465;944.6457578408097;953.8616900549381;962.4177372689422;970.6311601591491;973.776031512756;18799.15403806832;19148;19541.902290488742;19603.215871364984;19829.20683172657;1011.3375738891039;1011.6307547745167;1021.1524434719165;1026.4764969865423;1029.897010298964;10752.247342685936;10914.945425272823;11011.669649910515;11026.393548354918;11076.889231107747;453820;464136;468662;469102;497863;112834.43582782033;114765;117593;118573.40713296551;118845;999.2156157416393;1036.4196050211906;1047.486731501574;1112.6161474291196;1115.1524841120645;19914.60170796547;19931.302404415776;20113.29603463872;20219.29232476856;20306.79693203108;55937.72031139981;56209;56288.71855640696;56652;57610.423895762186;70540.64729676319;70651.64674176596;70852.29147708457;71097.6445117771;72000.63999679968;14294.785578216542;14839.777403338743;14880.851191487947;14884.776728348867;15042.097474151586;22924.88537557368;22961.770382295963;22971.081156753542;23229.41926451852;23558.646620301053;18193;18293.085345732925;18597.34909278169;18624.5343866399;18629;16450.424235151713;16522.83477165213;16639.9184053041;16791;16912.661746765243;17995.640087198444;18890.43328700141;18890.905545472735;19000.334988275343;19118.426447206606;14482.855171448573;14562.708745825235;14600;14621.830253579476;14656.413743450143;17576.648467030333;18084.186211620246;18135.909320453313;18212.36256731008;18217.544561386072 09:01:48 INFO - PID 3756 | |3;mootools.html;1301.7982212757022;1368.5894231730485;1374.7387996280713;1379.227632525785;1397.6645605054787;15124.621884452894;15664.843351566495;15733.213339333044;15850.682986340265;15866.682666346695;15369.385224591031;15455.69088618227;15480.225988700577;15507;15534.922325388385;2743.478739039576;2788.3168623687125;2802.0192932473574;2806.6070750095005;2819.3092692290315;2741.369485018447;2742.465219282241;2762.337039110609;2771.1270949650793;2774.375765452767;2695.892164313425;2710.132757517595;2716.497447972122;2743.862806859649;2857.8428186449737;2834.702356252584;2860.356419805548;2869.397426540429;2870.0385370900667;2870.799044066916;2742.149933520615;2784.958225626617;2800.593913882496;2801.3836955869674;2803.6074949507083;15266;15634.374625014985;15659.530214093595;15668.686626267525;15693;8093.716719914833;8369.121242269535;8382.748517544422;8384.916150838475;8400.159984001551;5425.674459532441;5608.55131589476;5662.660240385549;5729.169270455761;5742.454466825687;1891.224597914862;1918.0793219254697;1938.2150229157073;1966.6263409952064;1972.3195497553465;27653.170404887886;27999.720002799913;28015.71984280172;28045.71954280472;28156.436871262664;6523.934760652332;6655.833604159935;6769.289224631441;6799.048133261347;6886.380225779704;17106.230219640147;17118.14409279531;17146.485605431855;17146.657066858592;17184.1407929603;7549.660265288076;7931.881021784678;8131.430799844073;8131.95934020338;8139.674413023413;7278.126624805057;7476.140243871915;7495.737649182252;7496.212897645669;7508.474406791473;5461.481159289861;5479.178123281539;5514.365847927459;5583.162525621189;5609.747561359749;1499.8200215974152;1546.3969052069701;1557.649528856021;1566.3421363027555;1575.866051385645;863.8963324401112;864.2351518905814;875.3216257400566;878.2315473960285;888.2006194425069;7346.11846578414;7350.154732205758;7392.778216653509;7409.296116868889;7437.628118594049;679.813051410866;710.7086094701251;713.5468977199515;713.9785806425815;745.3552676934521;4934.136526107916;5076.801614982537;5144.7942082316285;5224.634275600672;5462.262594549765;22010.559788804454;22394.55210895773;22470.213542525933;22671.546569068527;22933.655995160087;21747.67378489324;22588.54822903533;22666.093356265894;22722;22952.4261893454;11469.713257168638;11505.137114716263;11728.120390970711;11738.413079345999;11745.236559623427;8196.221358970888;8233.053198881966;8249.133840946613;8289.751307460545;8334.333253339839;18714.906425467787;18866.622667546846;18946.905265473586;19125.90437047806;19372.515687107934;19718.80281197227;19815.900920495304;19882.90058549698;19910.90044549768;19947.301844435377;10854.891451085388;11204.383758893338;11269.323840569592;11270.380129092979;11273.549058037586;14204.573862784133;14311.212883291519;14414.711705766036;14418.351174197396;14428.639284017563;11038.392888390894;11045.558177672803;11159.55361785552;11228.214025018171;11375.43122843838;11466.31202127875;11499.13756468285;11602.129840262183;11776.941115294712;12052.337121458404;10105.494725263854;10170.135538479311;10291.94854025725;10298.897011030094;10322.071013608811;7018.903929870497;7188.993540904173;7245.38414234796;7264.982902393564;7331.78004659861;7355.8896616551865;7619.238076192337;7627.656755445907;7629.809254768676;7674.769756907302 09:01:48 INFO - PID 3756 | |4;prototype.html;512.226537927729;519.9896002079957;525.6530689744769;537.5726297593413;540.4838379347723;6235.906461403082;6276.794547653072;6296.198191804643;6343.460805831504;6399.776007839727;6132.846678833032;6161.630302181861;6180.134781130634;6228.532860035492;6321.6207027578375;4893.584045356149;4975.751212439382;5212.713300768456;5239.423663397023;5247.842564723045;5067.721275329855;5093.541581257686;5098.801781581344;5131.3842338919385;5137.306463627418;4945.653804233705;4975.850724478271;5015.3730783652045;5064.670796398223;5077.33994580704;4984.96218063368;5056.949430505703;5064.518870707277;5079.288899554065;5083;4529.569690879362;4579.656525760582;4588.609968152711;4605.286180642006;4629.768511574442;6235.314115447297;6297.716602752841;6337.778177763802;6342.5243106767175;6361.4414468455525;5744.138379243105;5744.770209191627;5777.971110144423;5792.4497172768515;5799.9130013049835;6603.537752357337;6656.633885136315;6674.3325667433355;6701.564398314094;6710.3289671033;4994.325766021577;4995.875103122415;5010.198368261097;5027.09512287788;5027.27104569839;7003.719851205946;7087.964560177218;7093.964530177368;7112.039874616912;7119.537230080028;5095.490450954949;5099.4390617032095;5118.59051275897;5141.614378921596;5150.742462876841;5200.947990520046;5206.453322401169;5208.166693329125;5213.348331458567;5226.869328266747;5703.885922281531;5705;5725.227094342294;5727.77088916447;5802.100674395476;6281.434670879643;6322.936770632326;6398.936010639927;6597.208334999831;6604;1751.1769468349855;1765.161548264564;1767.1517671517743;1771.176402972624;1775.14792899409;1220.6887243752785;1223.5562036796487;1238.2632333761399;1246.9812952805714;1263.1242604731965;5595.621860709182;5768.2501274834;5807.5063619591965;5820.82537523875;5842.853928651818;6859.211190713032;6957.199922008933;6981.232064472904;6989;7014.22843487216;5701.173329867146;5721.542276617861;5761.308642962871;5836.649801011953;5857;3592.7126679088865;3625.021244264034;3652.3973544365413;3656.3601369760186;3686.4701149022853;6670.39966403026;6674.432673222734;6683.866322673616;6736.696848641823;6750.122484077038;7011.929880701127;7057.4001209896705;7061;7117.92882071183;7182.42540596751;6510.3489651034515;6512.120863683437;6575.375339342755;6647.767328143492;6699.2435370887215;6757.425618822259;6769.966150169218;6784.251024282923;6815.42068924147;6823.55646882951;6654.866902662016;6678.365555272241;6687.966560167168;6707.5975441473665;6775.695093720696;6561.737530498726;6565.638889861103;6579.309172537006;6585.703643335965;6603;5025.623078269217;5040.899182016413;5067.163917953644;5085.694858308513;5097.566706829961;6787.966060169668;6833.487488438288;6853.691583878837;6905.1713794345;6946.6179360135675;6607.47140228771;6711.966440167768;6713.295104014008;6761.628110453972;6768.3755898583;6578.440832529097;6674.332566743286;6701.32986701326;6707.1616047994;6740.460763138839;6541.901871471837;6548.770793022221;6578.177727784027;6590.604563726191;6627.204735431586;6268.780592679234;6409.871802563829;6649.401553860176;6767.086443330088;6809.38715515606;6452.645104519109;6455.128557644845;6462.289148193601;6494.545381823227;6524.380183882524 09:01:48 INFO - PID 3756 | |5;yui.html;901.1034021148955;916.4134953629679;917.8531434970406;920.07992007992;933.407286373153;19728.605427891453;20328;20512.69230961533;20607.896960515194;20625.484362890897;17667.469975900745;17733.7339939901;17879.55301117473;17915.372961946334;17967.281308747635;952.552300418802;958.9472579008152;962.9614815407375;965.5220665770454;970.4759429907841;988.4514094677451;990.400807511456;990.6780296403662;991.6628346362236;994.3089552760835;1010.5907107621425;1029.907308342249;1030.309692506019;1041.4324193314624;1041.4896700616719;1032.0659802878406;1035.7928414317091;1036.1503567075001;1037.1443559063764;1037.3827572594294;743.2084829656453;754.6641744423733;754.8829931360593;755.1353700013509;755.7732680195919;18487.445376638723;18625.81374186268;18644.533886652942;18686.25254989799;18761.530961726065;21710.240141595128;21863;21907.342779716473;21997.450063748533;22099.116035358726;17471.737923931152;17699.115044247865;17729.911350443293;17748.645027099516;17868.195931183;3790.886273411802;3809.657130858236;3815.2560250751117;3817.503724515823;3817.7136714746225;101169;106769;144616;145697;148175.2591237037;17967.460976170736;18115.275388984555;18177.182026808827;18311.267549297878;18327.266909323476;32017.83991080076;32523.512147317808;32743.18142046468;32841.17897052593;32854.67145328564;9266.073392660815;9276.768080798034;9288.11762882525;9308.44149351041;9314.580843862042;4344.261475549164;4417.955820441754;4420.425344705232;4423.380726698265;4425.601695847389;5461.453854614586;5537.916931246034;5550.7779688812;5603.327600687943;5645.068563686946;1079.983800242997;1121.545773961547;1135.2620796482188;1136.091127098318;1136.323887287063;650.7331993882485;680.1059050544211;696.5228818259509;697.8953157026486;699.9930000699928;11033.779324413466;11299.717507062389;11434.828477572843;11496.252743571642;11523.711907202387;662.1359126340076;673.1518286958468;680.1260380411148;685.2804555217002;693.7918624412656;5426;5448.891022179613;5461.9453805461435;5483.095289277305;5577.888442231214;113242;116275;118310;118480.40759796146;122383;102190.48904755578;103000.48499757453;104105.47947260215;104763;106378;94399.52800235956;95691.52154239184;96469;96693.51653241689;98206.50896745613;10148.746281343025;10224.409095889308;10268.537915793659;10276.897231027893;10334.844977325196;42989.78505107454;44009.55990440182;44330.55669443264;45618.087638247714;46264.768676156404;57232;57714.42285577091;58407.70796146162;58576;60153.69923150356;15971.361145554049;16220.27008784584;16388.508344749676;16438.095904725356;16442.17789110516;18668.906655466635;18850.811491884906;19068.141933613297;19085;19360.322388716326;15715;15914.7612785806;16021.439249626206;16030.038197707709;16198.352065917232;16632.3347066116;16736.163191840114;16794.244259008618;17012.319507219574;17013.23440445158;15702.685946281239;15734.9213253933;15930.123843188272;16084.67830643404;16210.108444035692;11760.58837940668;11892;11894.34581098048;11905.761884762429;11933.76132477363;11392.202545821712;11401;11414.885851141715;11578.189526733047;11810.996065334542 09:01:48 INFO - PID 3756 | __end_tp_report 09:01:48 INFO - PID 3756 | __start_cc_report 09:01:48 INFO - PID 3756 | _x_x_mozilla_cycle_collect,265 09:01:48 INFO - PID 3756 | __end_cc_report 09:01:48 INFO - PID 3756 | __startTimestamp1506009708780__endTimestamp 09:01:48 INFO - PID 3756 | 09:01:48 INFO - PID 3756 | ------- Summary: start ------- 09:01:48 INFO - PID 3756 | Number of tests: 6 09:01:48 INFO - PID 3756 | 09:01:48 INFO - PID 3756 | [#0] dojo.html Cycles:165 Average:6300.08 Median:6547.05 stddev:769.91 (11.8%) stddev-sans-first:731.87 09:01:48 INFO - PID 3756 | Values: 3162.3 3169.0 3179.5 3188.8 3201.2 6344.1 6348.3 6396.2 6398.4 6459.3 6384.0 6495.1 6497.2 6525.6 6533.5 5703.8 5822.9 5867.7 5927.0 5977.6 5639.4 5812.9 5876.8 5921.1 6019.3 5763.8 5799.5 5838.2 5873.3 5878.2 5805.9 5881.3 5897.6 5916.5 5939.5 5809.9 5843.0 5913.1 5914.4 5920.4 6289.6 6339.8 6402.7 6408.2 6450.3 6834.4 6927.1 6932.4 6941.0 6954.5 6858.3 6916.7 6932.5 7006.6 7023.4 6237.9 6332.8 6337.8 6338.7 6340.3 7008.3 7011.2 7030.3 7049.5 7129.3 6780.5 6805.5 6866.2 6868.3 6868.5 6873.2 6895.0 6909.1 6981.3 6987.3 6616.1 6637.4 6751.4 6829.5 6914.4 6788.8 6835.1 6856.3 6865.3 6880.2 5386.6 5439.5 5442.0 5447.7 5454.6 4645.9 4659.0 4703.6 4733.6 4741.3 5664.3 5736.9 5803.9 5854.9 5880.8 6925.0 6927.3 6929.5 6945.2 6952.5 5680.0 5853.9 5857.4 5867.2 5872.2 5883.8 5891.4 5955.7 5960.2 5965.3 6473.6 6534.3 6547.1 6647.5 6740.5 6799.9 6826.3 6827.6 6828.5 6830.1 6596.4 6633.9 6711.0 6715.7 6733.0 6728.6 6780.1 6784.7 6819.5 6823.2 6853.3 6864.0 6882.6 6952.3 6965.5 6538.0 6630.8 6635.9 6648.3 6729.2 6625.3 6631.7 6634.7 6707.9 6730.2 6647.0 6657.9 6663.1 6674.2 6691.6 6619.6 6702.2 6722.7 6772.3 6824.9 6309.2 6470.3 6476.1 6515.6 6605.8 09:01:48 INFO - PID 3756 | 09:01:48 INFO - PID 3756 | [#1] ext.html Cycles:180 Average:37871.51 Median:3558.05 stddev:54032.70 (1518.6%) stddev-sans-first:54112.82 09:01:48 INFO - PID 3756 | Values: 861.9 880.1 894.0 894.8 906.3 42070.8 42527.4 42581.0 42644.6 42742.8 39269.4 39273.2 39469.0 39520.4 39636.8 7014.5 7123.2 7154.7 7160.0 7168.0 7069.3 7163.4 7168.8 7180.9 7181.6 7947.5 8110.6 8119.1 8123.0 8129.9 7998.3 8024.8 8061.5 8068.0 8090.8 7397.8 7945.9 8015.6 8025.8 8028.1 39241.0 39674.0 39724.0 39816.2 39845.4 3546.2 3569.9 3601.0 3604.8 3609.2 31938.8 32219.8 32297.7 32359.8 32391.0 5206.3 5259.4 5267.1 5292.9 5303.8 187481.0 187599.0 188105.0 188293.0 188606.0 42057.0 42852.6 48842.8 49475.5 49875.5 51132.7 51171.5 51188.0 51444.0 51444.5 15108.6 15177.9 15213.2 15221.2 15256.9 12276.3 12321.1 12345.8 12355.6 12365.3 13814.4 13817.4 13885.7 13897.4 14015.2 5519.3 5603.4 5626.7 5632.5 5672.7 1013.4 1018.7 1025.3 1032.4 1046.7 22760.9 22776.3 23090.1 23200.1 23270.5 1124.1 1133.3 1133.7 1140.3 1143.8 12053.9 12141.6 12146.3 12173.5 12296.2 235912.0 238189.0 238280.0 238490.0 238491.0 53009.7 53047.5 53092.5 53302.7 53339.7 1444.9 1451.7 1457.6 1469.1 1478.3 21858.2 22832.4 22854.5 22940.0 23085.1 37047.8 37069.1 37091.8 37116.6 37153.8 195516.0 195758.0 196035.0 196145.0 196278.0 33109.7 34545.0 35422.8 35450.3 35456.3 44896.3 46151.5 46310.5 46482.1 46528.3 33539.5 33705.7 33803.0 33805.7 33862.2 33060.8 33277.8 33322.0 33853.5 34104.0 37204.3 37247.8 37421.0 37450.4 37531.0 32943.0 33438.0 33520.2 33589.8 33874.5 23742.9 23814.0 23873.5 24100.2 24368.6 09:01:48 INFO - PID 3756 | 09:01:48 INFO - PID 3756 | [#2] jquery.html Cycles:180 Average:34043.62 Median:23175.19 stddev:79427.09 (342.7%) stddev-sans-first:79610.16 09:01:48 INFO - PID 3756 | Values: 579.3 589.7 596.0 617.7 617.8 22021.7 23107.3 23141.8 23168.2 23182.2 24288.3 24398.1 24847.6 24914.6 24992.6 6472.8 6642.0 6643.0 6644.4 6646.4 6346.7 6518.6 6589.1 6624.7 6626.6 6603.0 6610.3 6616.3 6619.2 6620.7 6586.8 6586.9 6588.6 6607.1 6611.1 6121.1 6124.2 6125.1 6138.3 6145.4 27542.7 28559.1 28596.3 29019.7 29155.0 2018.1 2049.9 2051.4 2052.7 2052.9 18507.4 19001.0 19017.2 19035.4 19176.2 2120.4 2153.5 2191.7 2202.8 2203.2 119835.4 126427.4 132602.3 133445.0 142306.3 14906.4 14979.6 15075.2 15114.5 15123.8 23837.3 23880.2 23904.4 23928.5 23956.9 9615.0 9659.5 9696.7 9711.1 9843.7 8724.4 8763.0 8774.6 8867.2 8883.3 9158.3 9194.7 9301.3 9355.3 9566.4 2638.0 2639.5 2660.2 2756.1 2763.9 944.6 953.9 962.4 970.6 973.8 18799.2 19148.0 19541.9 19603.2 19829.2 1011.3 1011.6 1021.2 1026.5 1029.9 10752.2 10914.9 11011.7 11026.4 11076.9 453820.0 464136.0 468662.0 469102.0 497863.0 112834.4 114765.0 117593.0 118573.4 118845.0 999.2 1036.4 1047.5 1112.6 1115.2 19914.6 19931.3 20113.3 20219.3 20306.8 55937.7 56209.0 56288.7 56652.0 57610.4 70540.6 70651.6 70852.3 71097.6 72000.6 14294.8 14839.8 14880.9 14884.8 15042.1 22924.9 22961.8 22971.1 23229.4 23558.6 18193.0 18293.1 18597.3 18624.5 18629.0 16450.4 16522.8 16639.9 16791.0 16912.7 17995.6 18890.4 18890.9 19000.3 19118.4 14482.9 14562.7 14600.0 14621.8 14656.4 17576.6 18084.2 18135.9 18212.4 18217.5 09:01:48 INFO - PID 3756 | 09:01:48 INFO - PID 3756 | [#3] mootools.html Cycles:180 Average:9544.28 Median:2742.97 stddev:6950.86 (253.4%) stddev-sans-first:6942.77 09:01:48 INFO - PID 3756 | Values: 1301.8 1368.6 1374.7 1379.2 1397.7 15124.6 15664.8 15733.2 15850.7 15866.7 15369.4 15455.7 15480.2 15507.0 15534.9 2743.5 2788.3 2802.0 2806.6 2819.3 2741.4 2742.5 2762.3 2771.1 2774.4 2695.9 2710.1 2716.5 2743.9 2857.8 2834.7 2860.4 2869.4 2870.0 2870.8 2742.1 2785.0 2800.6 2801.4 2803.6 15266.0 15634.4 15659.5 15668.7 15693.0 8093.7 8369.1 8382.7 8384.9 8400.2 5425.7 5608.6 5662.7 5729.2 5742.5 1891.2 1918.1 1938.2 1966.6 1972.3 27653.2 27999.7 28015.7 28045.7 28156.4 6523.9 6655.8 6769.3 6799.0 6886.4 17106.2 17118.1 17146.5 17146.7 17184.1 7549.7 7931.9 8131.4 8132.0 8139.7 7278.1 7476.1 7495.7 7496.2 7508.5 5461.5 5479.2 5514.4 5583.2 5609.7 1499.8 1546.4 1557.6 1566.3 1575.9 863.9 864.2 875.3 878.2 888.2 7346.1 7350.2 7392.8 7409.3 7437.6 679.8 710.7 713.5 714.0 745.4 4934.1 5076.8 5144.8 5224.6 5462.3 22010.6 22394.6 22470.2 22671.5 22933.7 21747.7 22588.5 22666.1 22722.0 22952.4 11469.7 11505.1 11728.1 11738.4 11745.2 8196.2 8233.1 8249.1 8289.8 8334.3 18714.9 18866.6 18946.9 19125.9 19372.5 19718.8 19815.9 19882.9 19910.9 19947.3 10854.9 11204.4 11269.3 11270.4 11273.5 14204.6 14311.2 14414.7 14418.4 14428.6 11038.4 11045.6 11159.6 11228.2 11375.4 11466.3 11499.1 11602.1 11776.9 12052.3 10105.5 10170.1 10291.9 10298.9 10322.1 7018.9 7189.0 7245.4 7265.0 7331.8 7355.9 7619.2 7627.7 7629.8 7674.8 09:01:48 INFO - PID 3756 | 09:01:48 INFO - PID 3756 | [#4] prototype.html Cycles:180 Average:5606.41 Median:6252.34 stddev:1573.77 (25.2%) stddev-sans-first:1531.03 09:01:48 INFO - PID 3756 | Values: 512.2 520.0 525.7 537.6 540.5 6235.9 6276.8 6296.2 6343.5 6399.8 6132.8 6161.6 6180.1 6228.5 6321.6 4893.6 4975.8 5212.7 5239.4 5247.8 5067.7 5093.5 5098.8 5131.4 5137.3 4945.7 4975.9 5015.4 5064.7 5077.3 4985.0 5056.9 5064.5 5079.3 5083.0 4529.6 4579.7 4588.6 4605.3 4629.8 6235.3 6297.7 6337.8 6342.5 6361.4 5744.1 5744.8 5778.0 5792.4 5799.9 6603.5 6656.6 6674.3 6701.6 6710.3 4994.3 4995.9 5010.2 5027.1 5027.3 7003.7 7088.0 7094.0 7112.0 7119.5 5095.5 5099.4 5118.6 5141.6 5150.7 5200.9 5206.5 5208.2 5213.3 5226.9 5703.9 5705.0 5725.2 5727.8 5802.1 6281.4 6322.9 6398.9 6597.2 6604.0 1751.2 1765.2 1767.2 1771.2 1775.1 1220.7 1223.6 1238.3 1247.0 1263.1 5595.6 5768.3 5807.5 5820.8 5842.9 6859.2 6957.2 6981.2 6989.0 7014.2 5701.2 5721.5 5761.3 5836.6 5857.0 3592.7 3625.0 3652.4 3656.4 3686.5 6670.4 6674.4 6683.9 6736.7 6750.1 7011.9 7057.4 7061.0 7117.9 7182.4 6510.3 6512.1 6575.4 6647.8 6699.2 6757.4 6770.0 6784.3 6815.4 6823.6 6654.9 6678.4 6688.0 6707.6 6775.7 6561.7 6565.6 6579.3 6585.7 6603.0 5025.6 5040.9 5067.2 5085.7 5097.6 6788.0 6833.5 6853.7 6905.2 6946.6 6607.5 6712.0 6713.3 6761.6 6768.4 6578.4 6674.3 6701.3 6707.2 6740.5 6541.9 6548.8 6578.2 6590.6 6627.2 6268.8 6409.9 6649.4 6767.1 6809.4 6452.6 6455.1 6462.3 6494.5 6524.4 09:01:48 INFO - PID 3756 | 09:01:48 INFO - PID 3756 | [#5] yui.html Cycles:180 Average:23985.10 Median:18806.17 stddev:33927.48 (180.4%) stddev-sans-first:33978.37 09:01:48 INFO - PID 3756 | Values: 901.1 916.4 917.9 920.1 933.4 19728.6 20328.0 20512.7 20607.9 20625.5 17667.5 17733.7 17879.6 17915.4 17967.3 952.6 958.9 963.0 965.5 970.5 988.5 990.4 990.7 991.7 994.3 1010.6 1029.9 1030.3 1041.4 1041.5 1032.1 1035.8 1036.2 1037.1 1037.4 743.2 754.7 754.9 755.1 755.8 18487.4 18625.8 18644.5 18686.3 18761.5 21710.2 21863.0 21907.3 21997.5 22099.1 17471.7 17699.1 17729.9 17748.6 17868.2 3790.9 3809.7 3815.3 3817.5 3817.7 101169.0 106769.0 144616.0 145697.0 148175.3 17967.5 18115.3 18177.2 18311.3 18327.3 32017.8 32523.5 32743.2 32841.2 32854.7 9266.1 9276.8 9288.1 9308.4 9314.6 4344.3 4418.0 4420.4 4423.4 4425.6 5461.5 5537.9 5550.8 5603.3 5645.1 1080.0 1121.5 1135.3 1136.1 1136.3 650.7 680.1 696.5 697.9 700.0 11033.8 11299.7 11434.8 11496.3 11523.7 662.1 673.2 680.1 685.3 693.8 5426.0 5448.9 5461.9 5483.1 5577.9 113242.0 116275.0 118310.0 118480.4 122383.0 102190.5 103000.5 104105.5 104763.0 106378.0 94399.5 95691.5 96469.0 96693.5 98206.5 10148.7 10224.4 10268.5 10276.9 10334.8 42989.8 44009.6 44330.6 45618.1 46264.8 57232.0 57714.4 58407.7 58576.0 60153.7 15971.4 16220.3 16388.5 16438.1 16442.2 18668.9 18850.8 19068.1 19085.0 19360.3 15715.0 15914.8 16021.4 16030.0 16198.4 16632.3 16736.2 16794.2 17012.3 17013.2 15702.7 15734.9 15930.1 16084.7 16210.1 11760.6 11892.0 11894.3 11905.8 11933.8 11392.2 11401.0 11414.9 11578.2 11811.0 09:01:48 INFO - PID 3756 | -------- Summary: end -------- 09:01:48 INFO - PID 3756 | 09:01:49 INFO - TEST-INFO | 3756: exit 0 09:01:49 INFO - TEST-OK | dromaeo_css | took 1112742ms 09:01:49 INFO - TEST-START | kraken 09:01:49 INFO - Initialising browser for kraken test... 09:01:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48174/getInfo.html -profile /tmp/tmpxAKAeX/profile 09:01:49 INFO - TEST-INFO | started process 4117 (/builds/slave/test/build/application/firefox/firefox http://localhost:48174/getInfo.html) 09:01:55 INFO - TEST-INFO | 4117: exit 0 09:01:55 INFO - Browser initialized. 09:01:55 INFO - Running cycle 1/1 for kraken test... 09:01:55 INFO - Using env: {'DISPLAY': ':0', 09:01:55 INFO - 'HOME': '/home/cltbld', 09:01:55 INFO - 'JSGC_DISABLE_POISONING': '1', 09:01:55 INFO - 'LANG': 'en_US.UTF-8', 09:01:55 INFO - 'LANGUAGE': 'en_US:en', 09:01:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:01:55 INFO - 'LOGNAME': 'cltbld', 09:01:55 INFO - 'MAIL': '/var/mail/cltbld', 09:01:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:01:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:01:55 INFO - 'MOZ_CRASHREPORTER': '1', 09:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:01:55 INFO - 'MOZ_NO_REMOTE': '1', 09:01:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:55 INFO - 'NO_EM_RESTART': '1', 09:01:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:55 INFO - 'PWD': '/builds/slave/test', 09:01:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:01:55 INFO - 'RUST_BACKTRACE': 'full', 09:01:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:01:55 INFO - 'SHELL': '/bin/bash', 09:01:55 INFO - 'SHLVL': '1', 09:01:55 INFO - 'STYLO_FORCE_DISABLED': '1', 09:01:55 INFO - 'TERM': 'linux', 09:01:55 INFO - 'TMOUT': '86400', 09:01:55 INFO - 'USER': 'cltbld', 09:01:55 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501', 09:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:55 INFO - '_': '/tools/buildbot/bin/python'} 09:01:55 INFO - TEST-INFO | started process 4352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxAKAeX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:56 INFO - PID 4352 | 09:01:56 INFO - PID 4352 | (/builds/slave/test/build/application/firefox/firefox:4400): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:01:56 INFO - PID 4352 | 09:02:06 INFO - PID 4352 | RSS: Main: 154120192 09:02:06 INFO - PID 4352 | 09:02:09 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:48174/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48174/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:10 INFO - PID 4352 | RSS: Main: 159125504 09:02:10 INFO - PID 4352 | 09:02:12 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:48174/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48174/tests/kraken/driver.html?testName=audio-dft) 09:02:13 INFO - PID 4352 | RSS: Main: 159731712 09:02:13 INFO - PID 4352 | 09:02:16 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:48174/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48174/tests/kraken/driver.html?testName=audio-fft) 09:02:17 INFO - PID 4352 | RSS: Main: 156499968 09:02:17 INFO - PID 4352 | 09:02:19 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:48174/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48174/tests/kraken/driver.html?testName=audio-oscillator) 09:02:19 INFO - PID 4352 | RSS: Main: 157073408 09:02:19 INFO - PID 4352 | 09:02:21 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:48174/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48174/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:22 INFO - PID 4352 | RSS: Main: 157511680 09:02:22 INFO - PID 4352 | 09:02:25 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:48174/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48174/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:26 INFO - PID 4352 | RSS: Main: 159641600 09:02:26 INFO - PID 4352 | 09:02:29 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:48174/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48174/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:30 INFO - PID 4352 | RSS: Main: 159576064 09:02:30 INFO - PID 4352 | 09:02:33 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:48174/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48174/tests/kraken/driver.html?testName=json-parse-financial) 09:02:34 INFO - PID 4352 | RSS: Main: 160079872 09:02:34 INFO - PID 4352 | 09:02:35 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:48174/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48174/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:36 INFO - PID 4352 | RSS: Main: 159850496 09:02:36 INFO - PID 4352 | 09:02:37 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:48174/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48174/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:38 INFO - PID 4352 | RSS: Main: 160055296 09:02:38 INFO - PID 4352 | 09:02:40 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:48174/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48174/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:41 INFO - PID 4352 | RSS: Main: 156975104 09:02:41 INFO - PID 4352 | 09:02:43 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:48174/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48174/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:44 INFO - PID 4352 | RSS: Main: 157638656 09:02:44 INFO - PID 4352 | 09:02:47 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:48174/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48174/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:02:48 INFO - PID 4352 | RSS: Main: 157749248 09:02:48 INFO - PID 4352 | 09:02:49 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:48174/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48174/tests/kraken/driver.html?testName=ai-astar) 09:02:50 INFO - PID 4352 | RSS: Main: 159301632 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | __start_tp_report 09:02:50 INFO - PID 4352 | _x_x_mozilla_page_load 09:02:50 INFO - PID 4352 | _x_x_mozilla_page_load_details 09:02:50 INFO - PID 4352 | |i|pagename|runs| 09:02:50 INFO - PID 4352 | |0;ai-astar;108;108;108;107;108;95;111;107;106;106 09:02:50 INFO - PID 4352 | |1;audio-beat-detection;121;115;119;114;117;115;120;117;116;119 09:02:50 INFO - PID 4352 | |2;audio-dft;163;160;163;161;162;162;160;168;169;163 09:02:50 INFO - PID 4352 | |3;audio-fft;74;75;75;74;74;73;81;74;76;73 09:02:50 INFO - PID 4352 | |4;audio-oscillator;81;80;78;82;79;79;79;77;80;142 09:02:50 INFO - PID 4352 | |5;imaging-gaussian-blur;115;113;113;113;114;113;114;115;111;113 09:02:50 INFO - PID 4352 | |6;imaging-darkroom;156;147;148;147;148;148;147;147;148;148 09:02:50 INFO - PID 4352 | |7;imaging-desaturate;94;93;94;99;93;94;94;94;94;95 09:02:50 INFO - PID 4352 | |8;json-parse-financial;52;52;53;52;53;51;57;55;53;51 09:02:50 INFO - PID 4352 | |9;json-stringify-tinderbox;39;39;42;43;39;38;38;40;38;38 09:02:50 INFO - PID 4352 | |10;stanford-crypto-aes;77;73;72;74;73;73;70;72;71;71 09:02:50 INFO - PID 4352 | |11;stanford-crypto-ccm;119;111;108;109;116;112;110;116;121;117 09:02:50 INFO - PID 4352 | |12;stanford-crypto-pbkdf2;173;173;170;168;173;174;174;166;176;174 09:02:50 INFO - PID 4352 | |13;stanford-crypto-sha256-iterative;72;68;66;64;65;66;70;63;67;65 09:02:50 INFO - PID 4352 | __end_tp_report 09:02:50 INFO - PID 4352 | __start_cc_report 09:02:50 INFO - PID 4352 | _x_x_mozilla_cycle_collect,723 09:02:50 INFO - PID 4352 | __end_cc_report 09:02:50 INFO - PID 4352 | __startTimestamp1506009770134__endTimestamp 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | ------- Summary: start ------- 09:02:50 INFO - PID 4352 | Number of tests: 14 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | [#0] ai-astar Cycles:10 Average:106.40 Median:108.00 stddev:4.25 (3.9%) stddev-sans-first:4.47 09:02:50 INFO - PID 4352 | Values: 108.0 108.0 108.0 107.0 108.0 95.0 111.0 107.0 106.0 106.0 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | [#1] audio-beat-detection Cycles:10 Average:117.30 Median:118.00 stddev:2.36 (2.0%) stddev-sans-first:2.09 09:02:50 INFO - PID 4352 | Values: 121.0 115.0 119.0 114.0 117.0 115.0 120.0 117.0 116.0 119.0 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:3.07 (1.9%) stddev-sans-first:3.26 09:02:50 INFO - PID 4352 | Values: 163.0 160.0 163.0 161.0 162.0 162.0 160.0 168.0 169.0 163.0 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | [#3] audio-fft Cycles:10 Average:74.90 Median:74.50 stddev:2.33 (3.1%) stddev-sans-first:2.45 09:02:50 INFO - PID 4352 | Values: 74.0 75.0 75.0 74.0 74.0 73.0 81.0 74.0 76.0 73.0 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | [#4] audio-oscillator Cycles:10 Average:85.70 Median:79.50 stddev:19.83 (24.9%) stddev-sans-first:20.96 09:02:50 INFO - PID 4352 | Values: 81.0 80.0 78.0 82.0 79.0 79.0 79.0 77.0 80.0 142.0 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.50 stddev:1.17 (1.0%) stddev-sans-first:1.09 09:02:50 INFO - PID 4352 | Values: 115.0 113.0 113.0 113.0 114.0 113.0 114.0 115.0 111.0 113.0 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:2.72 (1.8%) stddev-sans-first:0.53 09:02:50 INFO - PID 4352 | Values: 156.0 147.0 148.0 147.0 148.0 148.0 147.0 147.0 148.0 148.0 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.71 (1.8%) stddev-sans-first:1.81 09:02:50 INFO - PID 4352 | Values: 94.0 93.0 94.0 99.0 93.0 94.0 94.0 94.0 94.0 95.0 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.85 (3.5%) stddev-sans-first:1.94 09:02:50 INFO - PID 4352 | Values: 52.0 52.0 53.0 52.0 53.0 51.0 57.0 55.0 53.0 51.0 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | [#9] json-stringify-tinderbox Cycles:10 Average:39.40 Median:39.00 stddev:1.78 (4.6%) stddev-sans-first:1.88 09:02:50 INFO - PID 4352 | Values: 39.0 39.0 42.0 43.0 39.0 38.0 38.0 40.0 38.0 38.0 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | [#10] stanford-crypto-aes Cycles:10 Average:72.60 Median:73.00 stddev:1.96 (2.7%) stddev-sans-first:1.27 09:02:50 INFO - PID 4352 | Values: 77.0 73.0 72.0 74.0 73.0 73.0 70.0 72.0 71.0 71.0 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | [#11] stanford-crypto-ccm Cycles:10 Average:113.90 Median:116.00 stddev:4.48 (3.9%) stddev-sans-first:4.36 09:02:50 INFO - PID 4352 | Values: 119.0 111.0 108.0 109.0 116.0 112.0 110.0 116.0 121.0 117.0 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:173.50 stddev:3.11 (1.8%) stddev-sans-first:3.28 09:02:50 INFO - PID 4352 | Values: 173.0 173.0 170.0 168.0 173.0 174.0 174.0 166.0 176.0 174.0 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:2.76 (4.1%) stddev-sans-first:2.12 09:02:50 INFO - PID 4352 | Values: 72.0 68.0 66.0 64.0 65.0 66.0 70.0 63.0 67.0 65.0 09:02:50 INFO - PID 4352 | -------- Summary: end -------- 09:02:50 INFO - PID 4352 | 09:02:50 INFO - PID 4352 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:02:50 INFO - TEST-INFO | 4352: exit 0 09:02:51 INFO - TEST-OK | kraken | took 61516ms 09:02:51 INFO - SUITE-END | took 1174s 09:02:51 INFO - Completed test suite (00:19:34) 09:02:51 INFO - javascript benchmark 09:02:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8579.929484017921, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3162.288485090855, 3169.033444799337, 3179.5230715392704, 3188.8086714797114, 3201.215702152973, 6344.080108384293, 6348.269948955872, 6396.200474940632, 6398.424141827246, 6459.3217712140195, 6384.0, 6495.0582165585965, 6497.18785151856, 6525.5758375705545, 6533.509986750989, 5703.800366987156, 5822.912656310159, 5867.677277749712, 5927.02204136317, 5977.641341519501, 5639.351474580435, 5812.854678633025, 5876.823695289148, 5921.082232253986, 6019.277686677605, 5763.798267060653, 5799.536037117042, 5838.182654428383, 5873.295204575457, 5878.235829342201, 5805.854853628651, 5881.294244690622, 5897.587168898179, 5916.526677865761, 5939.465448109648, 5809.919109264179, 5843.0, 5913.113033045035, 5914.37899020601, 5920.437558431942, 6289.622622642656, 6339.8415039623915, 6402.679866006681, 6408.198975128109, 6450.322716114787, 6834.384905358492, 6927.064846245793, 6932.410745086674, 6940.958856171565, 6954.513184077116, 6858.348456896637, 6916.6541672916655, 6932.514723969324, 7006.649667516604, 7023.367896889305, 6237.87524249517, 6332.810015699536, 6337.7781777637565, 6338.746450141989, 6340.270868850095, 7008.26413226614, 7011.1586609607175, 7030.296970303031, 7049.4712896532965, 7129.2870712929325, 6780.457563394916, 6805.4895882808, 6866.210385805696, 6868.347506986828, 6868.519203655696, 6873.20958089826, 6895.034695142684, 6909.136357955255, 6981.2669669683955, 6987.266337034538, 6616.139901812733, 6637.435817955431, 6751.358620931003, 6829.4877884157895, 6914.412274956685, 6788.830279243059, 6835.07726456922, 6856.314368563204, 6865.347791959756, 6880.174379074543, 5386.622936394415, 5439.5376393006245, 5442.047641662693, 5447.727613619382, 5454.563634909197, 4645.9303110453375, 4659.0, 4703.623710103184, 4733.573978341966, 4741.336212930192, 5664.320281566238, 5736.942630573641, 5803.8549036274435, 5854.8536286592325, 5880.8235752927485, 6925.0, 6927.272636373209, 6929.549579277432, 6945.166580010431, 6952.5480843745, 5680.0, 5853.912191317134, 5857.4435428634215, 5867.207926929896, 5872.236609240771, 5883.764649413975, 5891.440313170242, 5955.731992060368, 5960.165576819249, 5965.254343207099, 6473.643949582724, 6534.346565343522, 6547.050677651714, 6647.5346725729705, 6740.528163028639, 6799.898001529882, 6826.317368263134, 6827.6244806536115, 6828.453723702191, 6830.146231721035, 6596.439302659136, 6633.867322653617, 6710.966445167743, 6715.664216789239, 6733.0, 6728.629925354153, 6780.050792889098, 6784.660766961731, 6819.522633415613, 6823.249442561413, 6853.280405557344, 6863.965680171567, 6882.552634078769, 6952.270011648704, 6965.547239429421, 6537.967310163419, 6630.83422914431, 6635.933640663531, 6648.301928297459, 6729.192496900403, 6625.337466253336, 6631.668416579055, 6634.668266586747, 6707.899381509379, 6730.158730158731, 6647.0, 6657.866842663217, 6663.13379260693, 6674.16572928384, 6691.5650482718465, 6619.569727967667, 6702.162229721285, 6722.731090756315, 6772.288909664414, 6824.863502730017, 6309.211348581427, 6470.320616335217, 6476.0933469313395, 6515.576487528296, 6605.834854128685], "value": 6240.285736350782, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [861.8707193920911, 880.058337578791, 893.9597718102686, 894.7539426657672, 906.2795077913054, 42070.789646051766, 42527.36208956864, 42581.0, 42644.57355426448, 42742.78628606853, 39269.41095883564, 39273.21453570934, 39469.0, 39520.407193892046, 39636.801815990955, 7014.473914456411, 7123.180834204055, 7154.67803948821, 7160.033395491594, 7168.032315637401, 7069.25772793857, 7163.391111755507, 7168.784936451915, 7180.928190718104, 7181.640917954108, 7947.4834135781275, 8110.553919534424, 8119.066307374668, 8122.959385203066, 8129.918700813005, 7998.320142787812, 8024.799380015488, 8061.476004059776, 8068.0, 8090.797730056766, 7397.778066658009, 7945.920540794576, 8015.639296231683, 8025.839483210303, 8028.0767711713315, 39241.01897452558, 39674.0, 39724.0, 39816.20367592632, 39845.40231896495, 3546.202104526487, 3569.8929032128817, 3601.0, 3604.837782299777, 3609.205974685591, 31938.840305798323, 32219.838900805582, 32297.67702322994, 32359.838200808845, 32391.0, 5206.271122042917, 5259.447757985433, 5267.078261304295, 5292.92060619091, 5303.840884773463, 187481.0, 187599.0, 188105.0, 188293.0, 188606.0, 42057.0, 42852.57147428486, 48842.75578622084, 49475.50524494709, 49875.501244987085, 51132.74433627808, 51171.48828511742, 51188.0, 51444.0, 51444.48555514472, 15108.622284442758, 15177.924110379598, 15213.163276019925, 15221.162836044125, 15256.923715381352, 12276.263424194398, 12321.137520373668, 12345.753084938431, 12355.567555135527, 12365.258084514959, 13814.37835297414, 13817.378217980015, 13885.722285554435, 13897.444102235999, 14015.229162395963, 5519.337679478488, 5603.355614104348, 5626.746796394172, 5632.5212356950115, 5672.688002159921, 1013.4071568132725, 1018.7351288664852, 1025.3489034463169, 1032.4476405123223, 1046.7016900183412, 22760.88619556925, 22776.31671049871, 23090.094574415132, 23200.071997119925, 23270.534589308118, 1124.083871644607, 1133.2855321861018, 1133.665568657248, 1140.3158105136852, 1143.8341440491083, 12053.939730301292, 12141.603715572823, 12146.331951742739, 12173.513059477522, 12296.20074695142, 235912.0, 238189.0, 238280.0, 238490.0, 238491.0, 53009.734951325765, 53047.46952530502, 53092.46907530953, 53302.73348633232, 53339.73330133402, 1444.9060811047248, 1451.7241724072392, 1457.6064462595252, 1469.0598017268956, 1478.2756449339747, 21858.234961776896, 22832.429189270402, 22854.54290914139, 22940.0, 23085.076596936608, 37047.81476092602, 37069.07327316839, 37091.814540927124, 37116.628833711315, 37153.814230929755, 195516.0, 195758.0, 196035.0, 196145.0, 196278.0, 33109.66890331162, 34545.0, 35422.822885885405, 35450.29099418049, 35456.29087418289, 44896.32655510235, 46151.53848461607, 46310.53689463062, 46482.07035859196, 46528.302075468215, 33539.496907545916, 33705.662943370255, 33803.0, 33805.66194338025, 33862.15344616404, 33060.834695826365, 33277.83361083179, 33322.0, 33853.492197616564, 34104.0, 37204.255914882095, 37247.81376093102, 37421.0, 37450.43824342582, 37531.0, 32943.0, 33438.0, 33520.16199595029, 33589.83205084057, 33874.49188262227, 23742.881285593463, 23814.0, 23873.52252954966, 24100.15649452261, 24368.63447048331], "value": 17250.609375695436, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.2903692976105, 589.7110415896212, 595.9821205363838, 617.6818938246803, 617.7528988404638, 22021.66967495487, 23107.30678079656, 23141.768582314173, 23168.189113381035, 23182.188623398186, 24288.27135185943, 24398.146064887733, 24847.627285590686, 24914.626280605804, 24992.625110623354, 6472.838179045526, 6642.036904648823, 6642.9667851660915, 6644.368784965444, 6646.435053020499, 6346.746130154788, 6518.57629254097, 6589.077529145923, 6624.668766561676, 6626.602403855784, 6603.0, 6610.272869984322, 6616.338366163369, 6619.238787539446, 6620.668966551677, 6586.802395928154, 6586.901196482057, 6588.571742836701, 6607.141071660653, 6611.107500487421, 6121.112438696408, 6124.1732366130445, 6125.111858780497, 6138.263408390977, 6145.4161854623735, 27542.724572754218, 28559.143225703054, 28596.285092872844, 29019.70980290212, 29155.0, 2018.0817727933754, 2049.907754151067, 2051.4256008317548, 2052.7126202331688, 2052.8973551322524, 18507.352242671575, 19001.0, 19017.239310427565, 19035.428937131906, 19176.232950681955, 2120.4486833423266, 2153.493928926701, 2191.704119943819, 2202.8458007939453, 2203.151786562169, 119835.4008229962, 126427.36786316101, 132602.3369883154, 133445.0, 142306.28846855802, 14906.403743850342, 14979.625509362135, 15075.170865602278, 15114.470993515175, 15123.773143402857, 23837.284881453583, 23880.164194253117, 23904.40238994004, 23928.521429571312, 23956.88021559881, 9615.0, 9659.517024148765, 9696.660616878375, 9711.077447642463, 9843.655472058586, 8724.432911860835, 8763.0, 8774.60514276859, 8867.201951824367, 8883.333749968779, 9158.313126515539, 9194.724158275263, 9301.255899528021, 9355.29835262358, 9566.426014439156, 2637.973620263811, 2639.4853003664484, 2660.162048954573, 2756.131818477173, 2763.8618069096465, 944.6457578408097, 953.8616900549381, 962.4177372689422, 970.6311601591491, 973.776031512756, 18799.15403806832, 19148.0, 19541.902290488742, 19603.215871364984, 19829.20683172657, 1011.3375738891039, 1011.6307547745167, 1021.1524434719165, 1026.4764969865423, 1029.897010298964, 10752.247342685936, 10914.945425272823, 11011.669649910515, 11026.393548354918, 11076.889231107747, 453820.0, 464136.0, 468662.0, 469102.0, 497863.0, 112834.43582782033, 114765.0, 117593.0, 118573.40713296551, 118845.0, 999.2156157416393, 1036.4196050211906, 1047.486731501574, 1112.6161474291196, 1115.1524841120645, 19914.60170796547, 19931.302404415776, 20113.29603463872, 20219.29232476856, 20306.79693203108, 55937.72031139981, 56209.0, 56288.71855640696, 56652.0, 57610.423895762186, 70540.64729676319, 70651.64674176596, 70852.29147708457, 71097.6445117771, 72000.63999679968, 14294.785578216542, 14839.777403338743, 14880.851191487947, 14884.776728348867, 15042.097474151586, 22924.88537557368, 22961.770382295963, 22971.081156753542, 23229.41926451852, 23558.646620301053, 18193.0, 18293.085345732925, 18597.34909278169, 18624.5343866399, 18629.0, 16450.424235151713, 16522.83477165213, 16639.9184053041, 16791.0, 16912.661746765243, 17995.640087198444, 18890.43328700141, 18890.905545472735, 19000.334988275343, 19118.426447206606, 14482.855171448573, 14562.708745825235, 14600.0, 14621.830253579476, 14656.413743450143, 17576.648467030333, 18084.186211620246, 18135.909320453313, 18212.36256731008, 18217.544561386072], "value": 11876.106018716537, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.7982212757022, 1368.5894231730485, 1374.7387996280713, 1379.227632525785, 1397.6645605054787, 15124.621884452894, 15664.843351566495, 15733.213339333044, 15850.682986340265, 15866.682666346695, 15369.385224591031, 15455.69088618227, 15480.225988700577, 15507.0, 15534.922325388385, 2743.478739039576, 2788.3168623687125, 2802.0192932473574, 2806.6070750095005, 2819.3092692290315, 2741.369485018447, 2742.465219282241, 2762.337039110609, 2771.1270949650793, 2774.375765452767, 2695.892164313425, 2710.132757517595, 2716.497447972122, 2743.862806859649, 2857.8428186449737, 2834.702356252584, 2860.356419805548, 2869.397426540429, 2870.0385370900667, 2870.799044066916, 2742.149933520615, 2784.958225626617, 2800.593913882496, 2801.3836955869674, 2803.6074949507083, 15266.0, 15634.374625014985, 15659.530214093595, 15668.686626267525, 15693.0, 8093.716719914833, 8369.121242269535, 8382.748517544422, 8384.916150838475, 8400.159984001551, 5425.674459532441, 5608.55131589476, 5662.660240385549, 5729.169270455761, 5742.454466825687, 1891.224597914862, 1918.0793219254697, 1938.2150229157073, 1966.6263409952064, 1972.3195497553465, 27653.170404887886, 27999.720002799913, 28015.71984280172, 28045.71954280472, 28156.436871262664, 6523.934760652332, 6655.833604159935, 6769.289224631441, 6799.048133261347, 6886.380225779704, 17106.230219640147, 17118.14409279531, 17146.485605431855, 17146.657066858592, 17184.1407929603, 7549.660265288076, 7931.881021784678, 8131.430799844073, 8131.95934020338, 8139.674413023413, 7278.126624805057, 7476.140243871915, 7495.737649182252, 7496.212897645669, 7508.474406791473, 5461.481159289861, 5479.178123281539, 5514.365847927459, 5583.162525621189, 5609.747561359749, 1499.8200215974152, 1546.3969052069701, 1557.649528856021, 1566.3421363027555, 1575.866051385645, 863.8963324401112, 864.2351518905814, 875.3216257400566, 878.2315473960285, 888.2006194425069, 7346.11846578414, 7350.154732205758, 7392.778216653509, 7409.296116868889, 7437.628118594049, 679.813051410866, 710.7086094701251, 713.5468977199515, 713.9785806425815, 745.3552676934521, 4934.136526107916, 5076.801614982537, 5144.7942082316285, 5224.634275600672, 5462.262594549765, 22010.559788804454, 22394.55210895773, 22470.213542525933, 22671.546569068527, 22933.655995160087, 21747.67378489324, 22588.54822903533, 22666.093356265894, 22722.0, 22952.4261893454, 11469.713257168638, 11505.137114716263, 11728.120390970711, 11738.413079345999, 11745.236559623427, 8196.221358970888, 8233.053198881966, 8249.133840946613, 8289.751307460545, 8334.333253339839, 18714.906425467787, 18866.622667546846, 18946.905265473586, 19125.90437047806, 19372.515687107934, 19718.80281197227, 19815.900920495304, 19882.90058549698, 19910.90044549768, 19947.301844435377, 10854.891451085388, 11204.383758893338, 11269.323840569592, 11270.380129092979, 11273.549058037586, 14204.573862784133, 14311.212883291519, 14414.711705766036, 14418.351174197396, 14428.639284017563, 11038.392888390894, 11045.558177672803, 11159.55361785552, 11228.214025018171, 11375.43122843838, 11466.31202127875, 11499.13756468285, 11602.129840262183, 11776.941115294712, 12052.337121458404, 10105.494725263854, 10170.135538479311, 10291.94854025725, 10298.897011030094, 10322.071013608811, 7018.903929870497, 7188.993540904173, 7245.38414234796, 7264.982902393564, 7331.78004659861, 7355.8896616551865, 7619.238076192337, 7627.656755445907, 7629.809254768676, 7674.769756907302], "value": 6736.239357158256, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [512.226537927729, 519.9896002079957, 525.6530689744769, 537.5726297593413, 540.4838379347723, 6235.906461403082, 6276.794547653072, 6296.198191804643, 6343.460805831504, 6399.776007839727, 6132.846678833032, 6161.630302181861, 6180.134781130634, 6228.532860035492, 6321.6207027578375, 4893.584045356149, 4975.751212439382, 5212.713300768456, 5239.423663397023, 5247.842564723045, 5067.721275329855, 5093.541581257686, 5098.801781581344, 5131.3842338919385, 5137.306463627418, 4945.653804233705, 4975.850724478271, 5015.3730783652045, 5064.670796398223, 5077.33994580704, 4984.96218063368, 5056.949430505703, 5064.518870707277, 5079.288899554065, 5083.0, 4529.569690879362, 4579.656525760582, 4588.609968152711, 4605.286180642006, 4629.768511574442, 6235.314115447297, 6297.716602752841, 6337.778177763802, 6342.5243106767175, 6361.4414468455525, 5744.138379243105, 5744.770209191627, 5777.971110144423, 5792.4497172768515, 5799.9130013049835, 6603.537752357337, 6656.633885136315, 6674.3325667433355, 6701.564398314094, 6710.3289671033, 4994.325766021577, 4995.875103122415, 5010.198368261097, 5027.09512287788, 5027.27104569839, 7003.719851205946, 7087.964560177218, 7093.964530177368, 7112.039874616912, 7119.537230080028, 5095.490450954949, 5099.4390617032095, 5118.59051275897, 5141.614378921596, 5150.742462876841, 5200.947990520046, 5206.453322401169, 5208.166693329125, 5213.348331458567, 5226.869328266747, 5703.885922281531, 5705.0, 5725.227094342294, 5727.77088916447, 5802.100674395476, 6281.434670879643, 6322.936770632326, 6398.936010639927, 6597.208334999831, 6604.0, 1751.1769468349855, 1765.161548264564, 1767.1517671517743, 1771.176402972624, 1775.14792899409, 1220.6887243752785, 1223.5562036796487, 1238.2632333761399, 1246.9812952805714, 1263.1242604731965, 5595.621860709182, 5768.2501274834, 5807.5063619591965, 5820.82537523875, 5842.853928651818, 6859.211190713032, 6957.199922008933, 6981.232064472904, 6989.0, 7014.22843487216, 5701.173329867146, 5721.542276617861, 5761.308642962871, 5836.649801011953, 5857.0, 3592.7126679088865, 3625.021244264034, 3652.3973544365413, 3656.3601369760186, 3686.4701149022853, 6670.39966403026, 6674.432673222734, 6683.866322673616, 6736.696848641823, 6750.122484077038, 7011.929880701127, 7057.4001209896705, 7061.0, 7117.92882071183, 7182.42540596751, 6510.3489651034515, 6512.120863683437, 6575.375339342755, 6647.767328143492, 6699.2435370887215, 6757.425618822259, 6769.966150169218, 6784.251024282923, 6815.42068924147, 6823.55646882951, 6654.866902662016, 6678.365555272241, 6687.966560167168, 6707.5975441473665, 6775.695093720696, 6561.737530498726, 6565.638889861103, 6579.309172537006, 6585.703643335965, 6603.0, 5025.623078269217, 5040.899182016413, 5067.163917953644, 5085.694858308513, 5097.566706829961, 6787.966060169668, 6833.487488438288, 6853.691583878837, 6905.1713794345, 6946.6179360135675, 6607.47140228771, 6711.966440167768, 6713.295104014008, 6761.628110453972, 6768.3755898583, 6578.440832529097, 6674.332566743286, 6701.32986701326, 6707.1616047994, 6740.460763138839, 6541.901871471837, 6548.770793022221, 6578.177727784027, 6590.604563726191, 6627.204735431586, 6268.780592679234, 6409.871802563829, 6649.401553860176, 6767.086443330088, 6809.38715515606, 6452.645104519109, 6455.128557644845, 6462.289148193601, 6494.545381823227, 6524.380183882524], "value": 5143.748512731532, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.1034021148955, 916.4134953629679, 917.8531434970406, 920.07992007992, 933.407286373153, 19728.605427891453, 20328.0, 20512.69230961533, 20607.896960515194, 20625.484362890897, 17667.469975900745, 17733.7339939901, 17879.55301117473, 17915.372961946334, 17967.281308747635, 952.552300418802, 958.9472579008152, 962.9614815407375, 965.5220665770454, 970.4759429907841, 988.4514094677451, 990.400807511456, 990.6780296403662, 991.6628346362236, 994.3089552760835, 1010.5907107621425, 1029.907308342249, 1030.309692506019, 1041.4324193314624, 1041.4896700616719, 1032.0659802878406, 1035.7928414317091, 1036.1503567075001, 1037.1443559063764, 1037.3827572594294, 743.2084829656453, 754.6641744423733, 754.8829931360593, 755.1353700013509, 755.7732680195919, 18487.445376638723, 18625.81374186268, 18644.533886652942, 18686.25254989799, 18761.530961726065, 21710.240141595128, 21863.0, 21907.342779716473, 21997.450063748533, 22099.116035358726, 17471.737923931152, 17699.115044247865, 17729.911350443293, 17748.645027099516, 17868.195931183, 3790.886273411802, 3809.657130858236, 3815.2560250751117, 3817.503724515823, 3817.7136714746225, 101169.0, 106769.0, 144616.0, 145697.0, 148175.2591237037, 17967.460976170736, 18115.275388984555, 18177.182026808827, 18311.267549297878, 18327.266909323476, 32017.83991080076, 32523.512147317808, 32743.18142046468, 32841.17897052593, 32854.67145328564, 9266.073392660815, 9276.768080798034, 9288.11762882525, 9308.44149351041, 9314.580843862042, 4344.261475549164, 4417.955820441754, 4420.425344705232, 4423.380726698265, 4425.601695847389, 5461.453854614586, 5537.916931246034, 5550.7779688812, 5603.327600687943, 5645.068563686946, 1079.983800242997, 1121.545773961547, 1135.2620796482188, 1136.091127098318, 1136.323887287063, 650.7331993882485, 680.1059050544211, 696.5228818259509, 697.8953157026486, 699.9930000699928, 11033.779324413466, 11299.717507062389, 11434.828477572843, 11496.252743571642, 11523.711907202387, 662.1359126340076, 673.1518286958468, 680.1260380411148, 685.2804555217002, 693.7918624412656, 5426.0, 5448.891022179613, 5461.9453805461435, 5483.095289277305, 5577.888442231214, 113242.0, 116275.0, 118310.0, 118480.40759796146, 122383.0, 102190.48904755578, 103000.48499757453, 104105.47947260215, 104763.0, 106378.0, 94399.52800235956, 95691.52154239184, 96469.0, 96693.51653241689, 98206.50896745613, 10148.746281343025, 10224.409095889308, 10268.537915793659, 10276.897231027893, 10334.844977325196, 42989.78505107454, 44009.55990440182, 44330.55669443264, 45618.087638247714, 46264.768676156404, 57232.0, 57714.42285577091, 58407.70796146162, 58576.0, 60153.69923150356, 15971.361145554049, 16220.27008784584, 16388.508344749676, 16438.095904725356, 16442.17789110516, 18668.906655466635, 18850.811491884906, 19068.141933613297, 19085.0, 19360.322388716326, 15715.0, 15914.7612785806, 16021.439249626206, 16030.038197707709, 16198.352065917232, 16632.3347066116, 16736.163191840114, 16794.244259008618, 17012.319507219574, 17013.23440445158, 15702.685946281239, 15734.9213253933, 15930.123843188272, 16084.67830643404, 16210.108444035692, 11760.58837940668, 11892.0, 11894.34581098048, 11905.761884762429, 11933.76132477363, 11392.202545821712, 11401.0, 11414.885851141715, 11578.189526733047, 11810.996065334542], "value": 9005.28231040694, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1421.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 108.0, 107.0, 108.0, 95.0, 111.0, 107.0, 106.0, 106.0], "value": 106.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 115.0, 119.0, 114.0, 117.0, 115.0, 120.0, 117.0, 116.0, 119.0], "value": 117.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 163.0, 161.0, 162.0, 162.0, 160.0, 168.0, 169.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 74.0, 74.0, 73.0, 81.0, 74.0, 76.0, 73.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 78.0, 82.0, 79.0, 79.0, 79.0, 77.0, 80.0, 142.0], "value": 85.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0, 115.0, 111.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 99.0, 93.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 52.0, 53.0, 51.0, 57.0, 55.0, 53.0, 51.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 42.0, 43.0, 39.0, 38.0, 38.0, 40.0, 38.0, 38.0], "value": 39.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 72.0, 74.0, 73.0, 73.0, 70.0, 72.0, 71.0, 71.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 111.0, 108.0, 109.0, 116.0, 112.0, 110.0, 116.0, 121.0, 117.0], "value": 113.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 170.0, 168.0, 173.0, 174.0, 174.0, 166.0, 176.0, 174.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 66.0, 64.0, 65.0, 66.0, 70.0, 63.0, 67.0, 65.0], "value": 66.6, "unit": "score"}]}]} 09:02:51 INFO - Return code: 0 09:02:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:02:51 INFO - # TBPL SUCCESS # 09:02:51 INFO - Running post-action listener: _package_coverage_data 09:02:51 INFO - Running post-action listener: _resource_record_post_action 09:02:51 INFO - [mozharness: 2017-09-21 16:02:51.408053Z] Finished run-tests step (success) 09:02:51 INFO - Running post-run listener: _resource_record_post_run 09:02:51 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 10887168; Write bytes: 466042880; Read time: 5232; Write time: 458824 09:02:51 INFO - TinderboxPrint: CPU usage
13.1% 09:02:51 INFO - TinderboxPrint: I/O read bytes / time
10,887,168 / 5,232 09:02:51 INFO - TinderboxPrint: I/O write bytes / time
466,042,880 / 458,824 09:02:51 INFO - TinderboxPrint: CPU idle
8,261.7 (86.9%) 09:02:51 INFO - TinderboxPrint: CPU user
1,193.4 (12.5%) 09:02:51 INFO - TinderboxPrint: Swap in / out
0 / 0 09:02:51 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 20480; Write bytes: 38801408; Read time: 116; Write time: 10032 09:02:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:02:51 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8622080; Write bytes: 427241472; Read time: 4904; Write time: 448792 09:02:52 INFO - Running post-run listener: _upload_blobber_files 09:02:52 INFO - Blob upload gear active. 09:02:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:02:52 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 09:02:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:02:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:02:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:02:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:02:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:59 INFO - (blobuploader) - INFO - Done attempting. 09:02:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 09:02:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 09:03:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:00 INFO - (blobuploader) - INFO - Done attempting. 09:03:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:03:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:03:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:01 INFO - (blobuploader) - INFO - Done attempting. 09:03:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 09:03:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 09:03:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:02 INFO - (blobuploader) - INFO - Done attempting. 09:03:02 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:02 INFO - Return code: 0 09:03:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8fcccc9c4684df8aaf2ae8fa7d978b5f539b95fda6579f880efa7ee199e09f7c3589d63814ae81c62008fd3efda50ef991974eeb9b9b7cd00decf60476cf6db0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/41fcc5b918a930247b76e2e1e165ee62b2c599be992697504b1fb5601d47ca23b5771e59a947463cb041eb9e7d8dcefbd8d229ef0a4739411c6441ce479c9148", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1eaa9842d9ab1f6414ff747403402bf94473a7af0454db948c5b9a6986e5c14234579884814454af7a006067584b92bd772dacbc47de6983980f62f794a6264", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45229aa619b45ab5cb60ea641c027b6de70ff7fc1b4ad8449d15b49537980795155fcdc2fb183e3465594d0f0d1ab87299c0720de52a29dcd6ae85df932ceed9"} 09:03:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:02 INFO - Contents: 09:03:02 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8fcccc9c4684df8aaf2ae8fa7d978b5f539b95fda6579f880efa7ee199e09f7c3589d63814ae81c62008fd3efda50ef991974eeb9b9b7cd00decf60476cf6db0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/41fcc5b918a930247b76e2e1e165ee62b2c599be992697504b1fb5601d47ca23b5771e59a947463cb041eb9e7d8dcefbd8d229ef0a4739411c6441ce479c9148", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1eaa9842d9ab1f6414ff747403402bf94473a7af0454db948c5b9a6986e5c14234579884814454af7a006067584b92bd772dacbc47de6983980f62f794a6264", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45229aa619b45ab5cb60ea641c027b6de70ff7fc1b4ad8449d15b49537980795155fcdc2fb183e3465594d0f0d1ab87299c0720de52a29dcd6ae85df932ceed9"} 09:03:02 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:02 INFO - Copying logs to upload dir... 09:03:02 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.458408 ========= master_lag: 0.70 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-21 09:03:03.324377) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 09:03:03.329094) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8fcccc9c4684df8aaf2ae8fa7d978b5f539b95fda6579f880efa7ee199e09f7c3589d63814ae81c62008fd3efda50ef991974eeb9b9b7cd00decf60476cf6db0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/41fcc5b918a930247b76e2e1e165ee62b2c599be992697504b1fb5601d47ca23b5771e59a947463cb041eb9e7d8dcefbd8d229ef0a4739411c6441ce479c9148", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1eaa9842d9ab1f6414ff747403402bf94473a7af0454db948c5b9a6986e5c14234579884814454af7a006067584b92bd772dacbc47de6983980f62f794a6264", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45229aa619b45ab5cb60ea641c027b6de70ff7fc1b4ad8449d15b49537980795155fcdc2fb183e3465594d0f0d1ab87299c0720de52a29dcd6ae85df932ceed9"} build_url:https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011130 build_url: 'https://queue.taskcluster.net/v1/task/NkyEVKxfQa-s6GWN1Ap4sg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8fcccc9c4684df8aaf2ae8fa7d978b5f539b95fda6579f880efa7ee199e09f7c3589d63814ae81c62008fd3efda50ef991974eeb9b9b7cd00decf60476cf6db0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/41fcc5b918a930247b76e2e1e165ee62b2c599be992697504b1fb5601d47ca23b5771e59a947463cb041eb9e7d8dcefbd8d229ef0a4739411c6441ce479c9148", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1eaa9842d9ab1f6414ff747403402bf94473a7af0454db948c5b9a6986e5c14234579884814454af7a006067584b92bd772dacbc47de6983980f62f794a6264", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45229aa619b45ab5cb60ea641c027b6de70ff7fc1b4ad8449d15b49537980795155fcdc2fb183e3465594d0f0d1ab87299c0720de52a29dcd6ae85df932ceed9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 09:03:03.356822) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:03:03.357122) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1506006354.547047-39991501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:03:03.441450) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 09:03:03.443797) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 09:03:03.444103) ========= ========= Total master_lag: 0.88 =========