builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-079 starttime: 1505342894.8 results: success (0) revision: 0b3646aa9cbf3f77ee574a553ade9685e9229ab5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 15:48:14.796902) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 15:48:14.797344) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 15:48:14.797619) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 15:48:14.815483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:48:14.815870) ========= 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=1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 15:48:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2017-09-13 15:48:14 (46.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.172989 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:48:15.004868) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:48:15.005226) ========= 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=1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020114 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:48:15.055306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:48:15.055636) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0b3646aa9cbf3f77ee574a553ade9685e9229ab5 --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 0b3646aa9cbf3f77ee574a553ade9685e9229ab5 --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=1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 15:48:15,113 truncating revision to first 12 chars 2017-09-13 15:48:15,113 Setting DEBUG logging. 2017-09-13 15:48:15,113 attempt 1/10 2017-09-13 15:48:15,113 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0b3646aa9cbf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 15:48:15,392 unpacking tar archive at: mozilla-central-0b3646aa9cbf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584698 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:48:15.656669) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 15:48:15.656997) ========= script_repo_revision: 0b3646aa9cbf3f77ee574a553ade9685e9229ab5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 15:48:15.657374) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 15:48:15.657636) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 15:48:15.670865) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-13 15:48:15.671161) ========= /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=1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:48:15 INFO - MultiFileLogger online at 20170913 15:48:15 in /builds/slave/test 15:48:15 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 15:48:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:48:15 INFO - {'append_to_log': False, 15:48:15 INFO - 'base_work_dir': '/builds/slave/test', 15:48:15 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:48:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:48:15 INFO - 'branch': 'Firefox-Non-PGO', 15:48:15 INFO - 'buildbot_json_path': 'buildprops.json', 15:48:15 INFO - 'code_coverage': False, 15:48:15 INFO - 'config_files': ('talos/linux_config.py',), 15:48:15 INFO - 'default_actions': ('clobber', 15:48:15 INFO - 'read-buildbot-config', 15:48:15 INFO - 'download-and-extract', 15:48:15 INFO - 'populate-webroot', 15:48:15 INFO - 'create-virtualenv', 15:48:15 INFO - 'install', 15:48:15 INFO - 'setup-mitmproxy', 15:48:15 INFO - 'run-tests'), 15:48:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:48:15 INFO - 'disable_ccov_upload': False, 15:48:15 INFO - 'disable_stylo': False, 15:48:15 INFO - 'download_minidump_stackwalk': True, 15:48:15 INFO - 'download_symbols': 'ondemand', 15:48:15 INFO - 'enable_stylo': False, 15:48:15 INFO - 'enable_webrender': False, 15:48:15 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:48:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:48:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:48:15 INFO - 'gecko_profile': False, 15:48:15 INFO - 'gecko_profile_interval': 0, 15:48:15 INFO - 'installer_path': 'installer.exe', 15:48:15 INFO - 'log_level': 'info', 15:48:15 INFO - 'log_name': 'talos', 15:48:15 INFO - 'log_to_console': True, 15:48:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:48:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:48:15 INFO - 'opt_config_files': (), 15:48:15 INFO - 'pip_index': False, 15:48:15 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:48:15 INFO - 'system_bits': '32', 15:48:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:48:15 INFO - 'title': 'talos-linux64-ix-079', 15:48:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:48:15 INFO - 'use_talos_json': True, 15:48:15 INFO - 'verify': 'False', 15:48:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:48:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:48:15 INFO - 'work_dir': 'build'} 15:48:15 INFO - [mozharness: 2017-09-13 22:48:15.863891Z] Running clobber step. 15:48:15 INFO - Running pre-action listener: _resource_record_pre_action 15:48:15 INFO - Running main action method: clobber 15:48:15 INFO - rmtree: /builds/slave/test/build 15:48:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:48:16 INFO - Running post-action listener: _resource_record_post_action 15:48:16 INFO - [mozharness: 2017-09-13 22:48:16.858587Z] Finished clobber step (success) 15:48:16 INFO - [mozharness: 2017-09-13 22:48:16.858685Z] Running read-buildbot-config step. 15:48:16 INFO - Running pre-action listener: _resource_record_pre_action 15:48:16 INFO - Running main action method: read_buildbot_config 15:48:16 INFO - Using buildbot properties: 15:48:16 INFO - { 15:48:16 INFO - "project": "", 15:48:16 INFO - "product": "firefox", 15:48:16 INFO - "who": "archaeopteryx@coole-files.de", 15:48:16 INFO - "installer_path": "public/build/target.tar.bz2", 15:48:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:48:16 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:48:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 15:48:16 INFO - "stage_platform": "linux64", 15:48:16 INFO - "basedir": "/builds/slave/test", 15:48:16 INFO - "buildnumber": 18, 15:48:16 INFO - "platform": "ubuntu64_hw", 15:48:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:48:16 INFO - "slavebuilddir": "test", 15:48:16 INFO - "taskId": "PqUPrJtcR3iBXXxh99KRnQ", 15:48:16 INFO - "branch": "mozilla-central", 15:48:16 INFO - "script_repo_revision": "production", 15:48:16 INFO - "revision": "0b3646aa9cbf3f77ee574a553ade9685e9229ab5", 15:48:16 INFO - "slavename": "talos-linux64-ix-079", 15:48:16 INFO - "repo_path": "mozilla-central" 15:48:16 INFO - } 15:48:16 INFO - Finding installer, test and symbols from parent task. 15:48:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PqUPrJtcR3iBXXxh99KRnQ'}, attempt #1 15:48:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PqUPrJtcR3iBXXxh99KRnQ'}, attempt #1 15:48:17 INFO - Task dependencies: JQ2c2hz0RGOZPHj6Jy9JKA 15:48:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA'}, attempt #1 15:48:18 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.tar.bz2 15:48:18 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.test_packages.json 15:48:18 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.crashreporter-symbols.zip 15:48:18 INFO - Running post-action listener: _resource_record_post_action 15:48:18 INFO - [mozharness: 2017-09-13 22:48:18.227412Z] Finished read-buildbot-config step (success) 15:48:18 INFO - [mozharness: 2017-09-13 22:48:18.227628Z] Running download-and-extract step. 15:48:18 INFO - Running pre-action listener: _resource_record_pre_action 15:48:18 INFO - Running main action method: download_and_extract 15:48:18 INFO - mkdir: /builds/slave/test/build/tests 15:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:18 INFO - trying https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.test_packages.json 15:48:18 INFO - Downloading https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:48:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:48:18 INFO - Downloaded 989 bytes. 15:48:18 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:48:18 INFO - Using the following test package requirements: 15:48:18 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:48:18 INFO - u'common': [u'target.common.tests.zip'], 15:48:18 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:48:18 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:48:18 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:48:18 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:48:18 INFO - u'mozbase': [u'target.common.tests.zip'], 15:48:18 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:48:18 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:48:18 INFO - u'web-platform': [u'target.common.tests.zip', 15:48:18 INFO - u'target.web-platform.tests.tar.gz'], 15:48:18 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:48:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:48:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.common.tests.zip 15:48:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:48:18 INFO - Fetch https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.common.tests.zip into memory 15:48:19 INFO - Content-Length response header: 54572968 15:48:19 INFO - Bytes received: 54572968 15:48:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.talos.tests.zip 15:48:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:48:30 INFO - Fetch https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.talos.tests.zip into memory 15:48:31 INFO - Content-Length response header: 14499226 15:48:31 INFO - Bytes received: 14499226 15:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:31 INFO - trying https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.tar.bz2 15:48:31 INFO - Downloading https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:48:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:48:32 INFO - Downloaded 61501949 bytes. 15:48:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.tar.bz2 15:48:32 INFO - mkdir: /builds/slave/test/properties 15:48:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:48:32 INFO - Writing to file /builds/slave/test/properties/build_url 15:48:32 INFO - Contents: 15:48:32 INFO - build_url:https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.tar.bz2 15:48:32 INFO - Running post-action listener: _resource_record_post_action 15:48:32 INFO - Running post-action listener: find_tests_for_verification 15:48:32 INFO - Running post-action listener: set_extra_try_arguments 15:48:32 INFO - [mozharness: 2017-09-13 22:48:32.569383Z] Finished download-and-extract step (success) 15:48:32 INFO - [mozharness: 2017-09-13 22:48:32.569480Z] Running populate-webroot step. 15:48:32 INFO - Running pre-action listener: _resource_record_pre_action 15:48:32 INFO - Running main action method: populate_webroot 15:48:32 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:48:32 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:32 INFO - 'tests': ['tresize', 15:48:32 INFO - 'tcanvasmark']}, 15:48:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:48:32 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:32 INFO - 'tests': ['dromaeo_css', 15:48:32 INFO - 'kraken']}, 15:48:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:48:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:32 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:48:32 INFO - 'talos_options': ['--disable-stylo'], 15:48:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:48:32 INFO - 'tests': ['damp', 'tps']}, 15:48:32 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:48:32 INFO - 'talos_options': ['--disable-stylo'], 15:48:32 INFO - 'tests': ['damp', 'tps']}, 15:48:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:48:32 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:32 INFO - 'tests': ['dromaeo_dom']}, 15:48:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:48:32 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:32 INFO - 'tests': ['basic_compositor_video', 15:48:32 INFO - 'glvideo']}, 15:48:32 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:48:32 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:48:32 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:48:32 INFO - 'talos_options': ['--disable-stylo'], 15:48:32 INFO - 'tests': ['ts_paint_webext', 15:48:32 INFO - 'tp5o_webext']}, 15:48:32 INFO - 'other-e10s': {'tests': ['a11yr', 15:48:32 INFO - 'ts_paint', 15:48:32 INFO - 'tpaint', 15:48:32 INFO - 'sessionrestore', 15:48:32 INFO - 'sessionrestore_many_windows', 15:48:32 INFO - 'sessionrestore_no_auto_restore', 15:48:32 INFO - 'tabpaint']}, 15:48:32 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:32 INFO - 'tests': ['a11yr', 15:48:32 INFO - 'ts_paint', 15:48:32 INFO - 'tpaint', 15:48:32 INFO - 'sessionrestore', 15:48:32 INFO - 'sessionrestore_many_windows', 15:48:32 INFO - 'sessionrestore_no_auto_restore', 15:48:32 INFO - 'tabpaint']}, 15:48:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:48:32 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:48:32 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:32 INFO - 'tests': ['bloom_basic_singleton']}, 15:48:32 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:32 INFO - 'tests': ['bloom_basic']}, 15:48:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:48:32 INFO - 'tsvgr_opacity', 15:48:32 INFO - 'tart', 15:48:32 INFO - 'tscrollx', 15:48:32 INFO - 'tsvg_static']}, 15:48:32 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:32 INFO - 'tests': ['tsvgx', 15:48:32 INFO - 'tsvgr_opacity', 15:48:32 INFO - 'tart', 15:48:32 INFO - 'tscrollx', 15:48:32 INFO - 'tsvg_static']}, 15:48:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:48:32 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:48:32 INFO - 'talos_options': ['--disable-stylo'], 15:48:32 INFO - 'tests': ['tp5o']}, 15:48:32 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:48:32 INFO - 'talos_options': ['--mitmproxy', 15:48:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:48:32 INFO - '--firstNonBlankPaint'], 15:48:32 INFO - 'tests': ['tp6_google', 15:48:32 INFO - 'tp6_youtube', 15:48:32 INFO - 'tp6_amazon', 15:48:32 INFO - 'tp6_facebook']}, 15:48:32 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:48:32 INFO - 'talos_options': ['--disable-stylo', 15:48:32 INFO - '--mitmproxy', 15:48:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:48:32 INFO - '--firstNonBlankPaint'], 15:48:32 INFO - 'tests': ['tp6_google', 15:48:32 INFO - 'tp6_youtube', 15:48:32 INFO - 'tp6_amazon', 15:48:32 INFO - 'tp6_facebook']}, 15:48:32 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:48:32 INFO - 'talos_options': ['--stylo-threads=1', 15:48:32 INFO - '--mitmproxy', 15:48:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:48:32 INFO - '--firstNonBlankPaint'], 15:48:32 INFO - 'tests': ['tp6_google', 15:48:32 INFO - 'tp6_youtube', 15:48:32 INFO - 'tp6_amazon', 15:48:32 INFO - 'tp6_facebook']}, 15:48:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:48:32 INFO - 'talos_options': ['--xperf_path', 15:48:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:32 INFO - 'tests': ['tp5n']}, 15:48:32 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:48:32 INFO - 'talos_options': ['--disable-stylo', 15:48:32 INFO - '--xperf_path', 15:48:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:32 INFO - 'tests': ['tp5n']}}} 15:48:32 INFO - Running post-action listener: _resource_record_post_action 15:48:32 INFO - [mozharness: 2017-09-13 22:48:32.584437Z] Finished populate-webroot step (success) 15:48:32 INFO - [mozharness: 2017-09-13 22:48:32.584526Z] Running create-virtualenv step. 15:48:32 INFO - Running pre-action listener: _resource_record_pre_action 15:48:32 INFO - Running main action method: create_virtualenv 15:48:32 INFO - Creating virtualenv /builds/slave/test/build/venv 15:48:32 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:48:32 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:48:32 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:48:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:48:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:48:33 INFO - Installing distribute.............................................................................................................................................................................................done. 15:48:33 INFO - Installing pip...............done. 15:48:33 INFO - Return code: 0 15:48:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:48:33 INFO - Reading from file tmpfile_stdout 15:48:33 INFO - Output received: 15:48:33 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:48:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48: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')]} 15:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f9090>, '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 0x11f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, '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': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:48:33 INFO - Using env: {'DISPLAY': ':0', 15:48:33 INFO - 'HOME': '/home/cltbld', 15:48:33 INFO - 'LANG': 'en_US.UTF-8', 15:48:33 INFO - 'LANGUAGE': 'en_US:en', 15:48:33 INFO - 'LOGNAME': 'cltbld', 15:48:33 INFO - 'MAIL': '/var/mail/cltbld', 15:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:33 INFO - 'MOZ_NO_REMOTE': '1', 15:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:33 INFO - 'NO_EM_RESTART': '1', 15:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:33 INFO - 'PWD': '/builds/slave/test', 15:48:33 INFO - 'SHELL': '/bin/bash', 15:48:33 INFO - 'SHLVL': '1', 15:48:33 INFO - 'TERM': 'linux', 15:48:33 INFO - 'TMOUT': '86400', 15:48:33 INFO - 'USER': 'cltbld', 15:48:33 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 15:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:33 INFO - '_': '/tools/buildbot/bin/python'} 15:48:34 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:48:34 INFO - Downloading/unpacking pip>=1.5 15:48:34 INFO - Running setup.py egg_info for package pip 15:48:34 INFO - warning: no files found matching 'pip/cacert.pem' 15:48:34 INFO - warning: no files found matching '*.html' under directory 'docs' 15:48:34 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:48:34 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:48:34 INFO - Installing collected packages: pip 15:48:34 INFO - Found existing installation: pip 1.1 15:48:34 INFO - Uninstalling pip: 15:48:34 INFO - Successfully uninstalled pip 15:48:34 INFO - Running setup.py install for pip 15:48:34 INFO - warning: no files found matching 'pip/cacert.pem' 15:48:34 INFO - warning: no files found matching '*.html' under directory 'docs' 15:48:34 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:48:34 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:48:34 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:48:34 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:48:34 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:48:34 INFO - Successfully installed pip 15:48:34 INFO - Cleaning up... 15:48:34 INFO - Return code: 0 15:48:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:34 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 0xe891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f9090>, '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 0x11f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, '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': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:48:34 INFO - Using env: {'DISPLAY': ':0', 15:48:34 INFO - 'HOME': '/home/cltbld', 15:48:34 INFO - 'LANG': 'en_US.UTF-8', 15:48:34 INFO - 'LANGUAGE': 'en_US:en', 15:48:34 INFO - 'LOGNAME': 'cltbld', 15:48:34 INFO - 'MAIL': '/var/mail/cltbld', 15:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:34 INFO - 'MOZ_NO_REMOTE': '1', 15:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:34 INFO - 'NO_EM_RESTART': '1', 15:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:34 INFO - 'PWD': '/builds/slave/test', 15:48:34 INFO - 'SHELL': '/bin/bash', 15:48:34 INFO - 'SHLVL': '1', 15:48:34 INFO - 'TERM': 'linux', 15:48:34 INFO - 'TMOUT': '86400', 15:48:34 INFO - 'USER': 'cltbld', 15:48:34 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 15:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:34 INFO - '_': '/tools/buildbot/bin/python'} 15:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:35 INFO - Downloading/unpacking psutil>=3.1.1 15:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:48:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:36 INFO - Installing collected packages: psutil 15:48:36 INFO - Running setup.py install for psutil 15:48:36 INFO - building 'psutil._psutil_linux' extension 15:48:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:48:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:48:36 INFO - building 'psutil._psutil_posix' extension 15:48:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:48:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:48:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:36 INFO - Successfully installed psutil 15:48:36 INFO - Cleaning up... 15:48:36 INFO - Return code: 0 15:48:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:36 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 0xe891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f9090>, '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 0x11f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, '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': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:48:36 INFO - Using env: {'DISPLAY': ':0', 15:48:36 INFO - 'HOME': '/home/cltbld', 15:48:36 INFO - 'LANG': 'en_US.UTF-8', 15:48:36 INFO - 'LANGUAGE': 'en_US:en', 15:48:36 INFO - 'LOGNAME': 'cltbld', 15:48:36 INFO - 'MAIL': '/var/mail/cltbld', 15:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:36 INFO - 'MOZ_NO_REMOTE': '1', 15:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:36 INFO - 'NO_EM_RESTART': '1', 15:48:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:36 INFO - 'PWD': '/builds/slave/test', 15:48:36 INFO - 'SHELL': '/bin/bash', 15:48:36 INFO - 'SHLVL': '1', 15:48:36 INFO - 'TERM': 'linux', 15:48:36 INFO - 'TMOUT': '86400', 15:48:36 INFO - 'USER': 'cltbld', 15:48:36 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 15:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:36 INFO - '_': '/tools/buildbot/bin/python'} 15:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:48:38 INFO - Installing collected packages: mozsystemmonitor 15:48:38 INFO - Running setup.py install for mozsystemmonitor 15:48:38 INFO - Successfully installed mozsystemmonitor 15:48:38 INFO - Cleaning up... 15:48:39 INFO - Return code: 0 15:48:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48: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')]} 15:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48: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', '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 0xe891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f9090>, '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 0x11f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, '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': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:48: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 jsonschema==2.5.1 15:48:39 INFO - Using env: {'DISPLAY': ':0', 15:48:39 INFO - 'HOME': '/home/cltbld', 15:48:39 INFO - 'LANG': 'en_US.UTF-8', 15:48:39 INFO - 'LANGUAGE': 'en_US:en', 15:48:39 INFO - 'LOGNAME': 'cltbld', 15:48:39 INFO - 'MAIL': '/var/mail/cltbld', 15:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:39 INFO - 'MOZ_NO_REMOTE': '1', 15:48:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:39 INFO - 'NO_EM_RESTART': '1', 15:48:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:39 INFO - 'PWD': '/builds/slave/test', 15:48:39 INFO - 'SHELL': '/bin/bash', 15:48:39 INFO - 'SHLVL': '1', 15:48:39 INFO - 'TERM': 'linux', 15:48:39 INFO - 'TMOUT': '86400', 15:48:39 INFO - 'USER': 'cltbld', 15:48:39 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 15:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:39 INFO - '_': '/tools/buildbot/bin/python'} 15:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:39 INFO - Downloading/unpacking jsonschema==2.5.1 15:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:48:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:42 INFO - Downloading functools32-3.2.3-2.tar.gz 15:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:48:42 INFO - warning: no files found matching '*.txt' 15:48:42 INFO - no previously-included directories found matching 'build' 15:48:42 INFO - no previously-included directories found matching 'dist' 15:48:42 INFO - no previously-included directories found matching '.git*' 15:48:42 INFO - Installing collected packages: jsonschema, functools32 15:48:42 INFO - Running setup.py install for functools32 15:48:42 INFO - warning: no files found matching '*.txt' 15:48:42 INFO - no previously-included directories found matching 'build' 15:48:42 INFO - no previously-included directories found matching 'dist' 15:48:42 INFO - no previously-included directories found matching '.git*' 15:48:42 INFO - Successfully installed jsonschema functools32 15:48:42 INFO - Cleaning up... 15:48:42 INFO - Return code: 0 15:48:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:42 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 0xe891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f9090>, '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 0x11f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, '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': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:48:42 INFO - Using env: {'DISPLAY': ':0', 15:48:42 INFO - 'HOME': '/home/cltbld', 15:48:42 INFO - 'LANG': 'en_US.UTF-8', 15:48:42 INFO - 'LANGUAGE': 'en_US:en', 15:48:42 INFO - 'LOGNAME': 'cltbld', 15:48:42 INFO - 'MAIL': '/var/mail/cltbld', 15:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:42 INFO - 'MOZ_NO_REMOTE': '1', 15:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:42 INFO - 'NO_EM_RESTART': '1', 15:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:42 INFO - 'PWD': '/builds/slave/test', 15:48:42 INFO - 'SHELL': '/bin/bash', 15:48:42 INFO - 'SHLVL': '1', 15:48:42 INFO - 'TERM': 'linux', 15:48:42 INFO - 'TMOUT': '86400', 15:48:42 INFO - 'USER': 'cltbld', 15:48:42 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 15:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:42 INFO - '_': '/tools/buildbot/bin/python'} 15:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:48:42 INFO - Cleaning up... 15:48:42 INFO - Return code: 0 15:48:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:42 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 0xe891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f9090>, '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 0x11f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, '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': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:48:42 INFO - Using env: {'DISPLAY': ':0', 15:48:42 INFO - 'HOME': '/home/cltbld', 15:48:42 INFO - 'LANG': 'en_US.UTF-8', 15:48:42 INFO - 'LANGUAGE': 'en_US:en', 15:48:42 INFO - 'LOGNAME': 'cltbld', 15:48:42 INFO - 'MAIL': '/var/mail/cltbld', 15:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:42 INFO - 'MOZ_NO_REMOTE': '1', 15:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:42 INFO - 'NO_EM_RESTART': '1', 15:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:42 INFO - 'PWD': '/builds/slave/test', 15:48:42 INFO - 'SHELL': '/bin/bash', 15:48:42 INFO - 'SHLVL': '1', 15:48:42 INFO - 'TERM': 'linux', 15:48:42 INFO - 'TMOUT': '86400', 15:48:42 INFO - 'USER': 'cltbld', 15:48:42 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 15:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:42 INFO - '_': '/tools/buildbot/bin/python'} 15:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:43 INFO - Downloading/unpacking blobuploader==1.2.4 15:48: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 15:48: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 15:48: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 15:48: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 15:48:44 INFO - Downloading blobuploader-1.2.4.tar.gz 15:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:48:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:48:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:44 INFO - Downloading docopt-0.6.1.tar.gz 15:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:48:44 INFO - Installing collected packages: blobuploader, requests, docopt 15:48:44 INFO - Running setup.py install for blobuploader 15:48:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:48:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:48:44 INFO - Running setup.py install for requests 15:48:45 INFO - Running setup.py install for docopt 15:48:45 INFO - Successfully installed blobuploader requests docopt 15:48:45 INFO - Cleaning up... 15:48:45 INFO - Return code: 0 15:48:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:45 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 0xe891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f9090>, '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 0x11f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, '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': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:45 INFO - Using env: {'DISPLAY': ':0', 15:48:45 INFO - 'HOME': '/home/cltbld', 15:48:45 INFO - 'LANG': 'en_US.UTF-8', 15:48:45 INFO - 'LANGUAGE': 'en_US:en', 15:48:45 INFO - 'LOGNAME': 'cltbld', 15:48:45 INFO - 'MAIL': '/var/mail/cltbld', 15:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:45 INFO - 'MOZ_NO_REMOTE': '1', 15:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:45 INFO - 'NO_EM_RESTART': '1', 15:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:45 INFO - 'PWD': '/builds/slave/test', 15:48:45 INFO - 'SHELL': '/bin/bash', 15:48:45 INFO - 'SHLVL': '1', 15:48:45 INFO - 'TERM': 'linux', 15:48:45 INFO - 'TMOUT': '86400', 15:48:45 INFO - 'USER': 'cltbld', 15:48:45 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 15:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:45 INFO - '_': '/tools/buildbot/bin/python'} 15:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:45 INFO - Running setup.py (path:/tmp/pip-KLaH_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:45 INFO - Running setup.py (path:/tmp/pip-GOy9_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:45 INFO - Running setup.py (path:/tmp/pip-O_5qPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:45 INFO - Running setup.py (path:/tmp/pip-hpHlzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:45 INFO - Running setup.py (path:/tmp/pip-rGhaMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:45 INFO - Running setup.py (path:/tmp/pip-lZzW8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:45 INFO - Running setup.py (path:/tmp/pip-mte8g3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:46 INFO - Running setup.py (path:/tmp/pip-1rZs1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:46 INFO - Running setup.py (path:/tmp/pip-HoaOGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:46 INFO - Running setup.py (path:/tmp/pip-znRjqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:46 INFO - Running setup.py (path:/tmp/pip-Ux5EBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:46 INFO - Running setup.py (path:/tmp/pip-9DnCGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:46 INFO - Running setup.py (path:/tmp/pip-hGMve9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:46 INFO - Running setup.py (path:/tmp/pip-2y0JZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:46 INFO - Running setup.py (path:/tmp/pip-n2YMzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:46 INFO - Running setup.py (path:/tmp/pip-p1EHUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:46 INFO - Running setup.py (path:/tmp/pip-Z1VCLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:48:46 INFO - Running setup.py install for manifestparser 15:48:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:48:46 INFO - Running setup.py install for mozcrash 15:48:46 INFO - Running setup.py install for mozdebug 15:48:47 INFO - Running setup.py install for mozdevice 15:48:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:48:47 INFO - Running setup.py install for mozfile 15:48:47 INFO - Running setup.py install for mozhttpd 15:48:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:48:47 INFO - Running setup.py install for mozinfo 15:48:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:48:47 INFO - Running setup.py install for mozInstall 15:48:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:48:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:48:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:48:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:48:47 INFO - Running setup.py install for mozleak 15:48:47 INFO - Running setup.py install for mozlog 15:48:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:48:47 INFO - Running setup.py install for moznetwork 15:48:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:48:47 INFO - Running setup.py install for mozprocess 15:48:47 INFO - Running setup.py install for mozprofile 15:48:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:48:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:48:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:48:48 INFO - Running setup.py install for mozrunner 15:48:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:48:48 INFO - Running setup.py install for mozscreenshot 15:48:48 INFO - Running setup.py install for moztest 15:48:48 INFO - Running setup.py install for mozversion 15:48:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:48:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:48:48 INFO - Cleaning up... 15:48:48 INFO - Return code: 0 15:48:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:48 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 0xe891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f9090>, '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 0x11f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, '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': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:48 INFO - Using env: {'DISPLAY': ':0', 15:48:48 INFO - 'HOME': '/home/cltbld', 15:48:48 INFO - 'LANG': 'en_US.UTF-8', 15:48:48 INFO - 'LANGUAGE': 'en_US:en', 15:48:48 INFO - 'LOGNAME': 'cltbld', 15:48:48 INFO - 'MAIL': '/var/mail/cltbld', 15:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:48 INFO - 'MOZ_NO_REMOTE': '1', 15:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:48 INFO - 'NO_EM_RESTART': '1', 15:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:48 INFO - 'PWD': '/builds/slave/test', 15:48:48 INFO - 'SHELL': '/bin/bash', 15:48:48 INFO - 'SHLVL': '1', 15:48:48 INFO - 'TERM': 'linux', 15:48:48 INFO - 'TMOUT': '86400', 15:48:48 INFO - 'USER': 'cltbld', 15:48:48 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 15:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:48 INFO - '_': '/tools/buildbot/bin/python'} 15:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:48 INFO - Running setup.py (path:/tmp/pip-52K2QD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:48 INFO - Running setup.py (path:/tmp/pip-OmCGsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:48 INFO - Running setup.py (path:/tmp/pip-m7_Su8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:48 INFO - Running setup.py (path:/tmp/pip-b2MzZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:49 INFO - Running setup.py (path:/tmp/pip-0oHPTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:49 INFO - Running setup.py (path:/tmp/pip-__utVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:49 INFO - Running setup.py (path:/tmp/pip-YCkNBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:49 INFO - Running setup.py (path:/tmp/pip-7zrcGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:49 INFO - Running setup.py (path:/tmp/pip-yTtaAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:49 INFO - Running setup.py (path:/tmp/pip-302Gvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:49 INFO - Running setup.py (path:/tmp/pip-8TQ8L0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:49 INFO - Running setup.py (path:/tmp/pip-Dera2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:49 INFO - Running setup.py (path:/tmp/pip-PfbLtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:49 INFO - Running setup.py (path:/tmp/pip-PH5HZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:49 INFO - Running setup.py (path:/tmp/pip-wSnRmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:49 INFO - Running setup.py (path:/tmp/pip-ueR0WN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:49 INFO - Running setup.py (path:/tmp/pip-dzM7Pi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:48:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:51 INFO - Downloading blessings-1.6.tar.gz 15:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:48:51 INFO - Installing collected packages: blessings 15:48:51 INFO - Running setup.py install for blessings 15:48:51 INFO - Successfully installed blessings 15:48:51 INFO - Cleaning up... 15:48:51 INFO - Return code: 0 15:48:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:48:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:51 INFO - Reading from file tmpfile_stdout 15:48:51 INFO - Current package versions: 15:48:51 INFO - argparse == 1.2.1 15:48:51 INFO - blessings == 1.6 15:48:51 INFO - blobuploader == 1.2.4 15:48:51 INFO - docopt == 0.6.1 15:48:51 INFO - functools32 == 3.2.3-2 15:48:51 INFO - jsonschema == 2.5.1 15:48:51 INFO - manifestparser == 1.1 15:48:51 INFO - mozInstall == 1.13 15:48:51 INFO - mozcrash == 1.0 15:48:51 INFO - mozdebug == 0.1 15:48:51 INFO - mozdevice == 0.51 15:48:51 INFO - mozfile == 1.2 15:48:51 INFO - mozhttpd == 0.7 15:48:51 INFO - mozinfo == 0.10 15:48:51 INFO - mozleak == 0.1 15:48:51 INFO - mozlog == 3.5 15:48:51 INFO - moznetwork == 0.27 15:48:51 INFO - mozprocess == 0.25 15:48:51 INFO - mozprofile == 0.28 15:48:51 INFO - mozrunner == 6.13 15:48:51 INFO - mozscreenshot == 0.1 15:48:51 INFO - mozsystemmonitor == 0.3 15:48:51 INFO - moztest == 0.8 15:48:51 INFO - mozversion == 1.4 15:48:51 INFO - psutil == 3.1.1 15:48:51 INFO - requests == 1.2.3 15:48:51 INFO - wsgiref == 0.1.2 15:48:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:51 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 0xe891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f9090>, '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 0x11f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, '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': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:51 INFO - Using env: {'DISPLAY': ':0', 15:48:51 INFO - 'HOME': '/home/cltbld', 15:48:51 INFO - 'LANG': 'en_US.UTF-8', 15:48:51 INFO - 'LANGUAGE': 'en_US:en', 15:48:51 INFO - 'LOGNAME': 'cltbld', 15:48:51 INFO - 'MAIL': '/var/mail/cltbld', 15:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:51 INFO - 'MOZ_NO_REMOTE': '1', 15:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:51 INFO - 'NO_EM_RESTART': '1', 15:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:51 INFO - 'PWD': '/builds/slave/test', 15:48:51 INFO - 'SHELL': '/bin/bash', 15:48:51 INFO - 'SHLVL': '1', 15:48:51 INFO - 'TERM': 'linux', 15:48:51 INFO - 'TMOUT': '86400', 15:48:51 INFO - 'USER': 'cltbld', 15:48:51 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 15:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:51 INFO - '_': '/tools/buildbot/bin/python'} 15:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:48:51 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:48:52 INFO - Installing collected packages: simplejson 15:48:52 INFO - Running setup.py install for simplejson 15:48:52 INFO - building 'simplejson._speedups' extension 15:48:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:48:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:48:53 INFO - Successfully installed simplejson 15:48:53 INFO - Cleaning up... 15:48:53 INFO - Return code: 0 15:48:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f9090>, '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 0x11f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, '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': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:48:53 INFO - Using env: {'DISPLAY': ':0', 15:48:53 INFO - 'HOME': '/home/cltbld', 15:48:53 INFO - 'LANG': 'en_US.UTF-8', 15:48:53 INFO - 'LANGUAGE': 'en_US:en', 15:48:53 INFO - 'LOGNAME': 'cltbld', 15:48:53 INFO - 'MAIL': '/var/mail/cltbld', 15:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:53 INFO - 'MOZ_NO_REMOTE': '1', 15:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:53 INFO - 'NO_EM_RESTART': '1', 15:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:53 INFO - 'PWD': '/builds/slave/test', 15:48:53 INFO - 'SHELL': '/bin/bash', 15:48:53 INFO - 'SHLVL': '1', 15:48:53 INFO - 'TERM': 'linux', 15:48:53 INFO - 'TMOUT': '86400', 15:48:53 INFO - 'USER': 'cltbld', 15:48:53 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 15:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:53 INFO - '_': '/tools/buildbot/bin/python'} 15:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:48:54 INFO - Cleaning up... 15:48:54 INFO - Return code: 0 15:48:54 INFO - Running post-action listener: _resource_record_post_action 15:48:54 INFO - Running post-action listener: _start_resource_monitoring 15:48:54 INFO - Starting resource monitoring. 15:48:54 INFO - [mozharness: 2017-09-13 22:48:54.157133Z] Finished create-virtualenv step (success) 15:48:54 INFO - [mozharness: 2017-09-13 22:48:54.157714Z] Running install step. 15:48:54 INFO - Running pre-action listener: _resource_record_pre_action 15:48:54 INFO - Running main action method: install 15:48:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:54 INFO - Reading from file tmpfile_stdout 15:48:54 INFO - Detecting whether we're running mozinstall >=1.0... 15:48:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:48:54 INFO - Reading from file tmpfile_stdout 15:48:54 INFO - Output received: 15:48:54 INFO - Usage: mozinstall [options] installer 15:48:54 INFO - Options: 15:48:54 INFO - -h, --help show this help message and exit 15:48:54 INFO - -d DEST, --destination=DEST 15:48:54 INFO - Directory to install application into. [default: 15:48:54 INFO - "/builds/slave/test"] 15:48:54 INFO - --app=APP Application being installed. [default: firefox] 15:48:54 INFO - mkdir: /builds/slave/test/build/application 15:48:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:49:12 INFO - Reading from file tmpfile_stdout 15:49:12 INFO - Output received: 15:49:12 INFO - /builds/slave/test/build/application/firefox/firefox 15:49:12 INFO - Running post-action listener: _resource_record_post_action 15:49:12 INFO - [mozharness: 2017-09-13 22:49:12.263258Z] Finished install step (success) 15:49:12 INFO - [mozharness: 2017-09-13 22:49:12.263508Z] Running setup-mitmproxy step. 15:49:12 INFO - Running pre-action listener: _resource_record_pre_action 15:49:12 INFO - Running main action method: setup_mitmproxy 15:49:12 INFO - Skipping: mitmproxy is not required 15:49:12 INFO - Running post-action listener: _resource_record_post_action 15:49:12 INFO - [mozharness: 2017-09-13 22:49:12.264637Z] Finished setup-mitmproxy step (success) 15:49:12 INFO - [mozharness: 2017-09-13 22:49:12.264857Z] Running run-tests step. 15:49:12 INFO - Running pre-action listener: _resource_record_pre_action 15:49:12 INFO - Running pre-action listener: _set_gcov_prefix 15:49:12 INFO - Running main action method: run_tests 15:49:12 WARNING - Try message not found. 15:49:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:49:12 INFO - Python 2.7.3 15:49:12 INFO - Return code: 0 15:49:12 INFO - grabbing minidump binary from tooltool 15:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:12 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 0x11f9090>, '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 0x11f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:49:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:49:12 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:49:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:49:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:49:12 INFO - Return code: 0 15:49:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:49:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:49:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:49:12 INFO - ENV: RUST_BACKTRACE is now full 15:49:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:49:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:49:12 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/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 15:49:12 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/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 15:49:12 INFO - Using env: {'DISPLAY': ':0', 15:49:12 INFO - 'HOME': '/home/cltbld', 15:49:12 INFO - 'LANG': 'en_US.UTF-8', 15:49:12 INFO - 'LANGUAGE': 'en_US:en', 15:49:12 INFO - 'LOGNAME': 'cltbld', 15:49:12 INFO - 'MAIL': '/var/mail/cltbld', 15:49:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:49:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:12 INFO - 'MOZ_NO_REMOTE': '1', 15:49:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:12 INFO - 'NO_EM_RESTART': '1', 15:49:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:12 INFO - 'PWD': '/builds/slave/test', 15:49:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:49:12 INFO - 'RUST_BACKTRACE': 'full', 15:49:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:49:12 INFO - 'SHELL': '/bin/bash', 15:49:12 INFO - 'SHLVL': '1', 15:49:12 INFO - 'TERM': 'linux', 15:49:12 INFO - 'TMOUT': '86400', 15:49:12 INFO - 'USER': 'cltbld', 15:49:12 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 15:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:12 INFO - '_': '/tools/buildbot/bin/python'} 15:49:12 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/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 15:49:12 INFO - mozversion application_buildid: 20170913215701 15:49:12 INFO - mozversion application_changeset: 0b3646aa9cbf3f77ee574a553ade9685e9229ab5 15:49:12 INFO - mozversion application_display_name: Nightly 15:49:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:49:12 INFO - mozversion application_name: Firefox 15:49:12 INFO - mozversion application_remotingname: firefox 15:49:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:49:12 INFO - mozversion application_vendor: Mozilla 15:49:12 INFO - mozversion application_version: 57.0a1 15:49:12 INFO - mozversion platform_buildid: 20170913215701 15:49:12 INFO - mozversion platform_changeset: 0b3646aa9cbf3f77ee574a553ade9685e9229ab5 15:49:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:49:12 INFO - mozversion platform_version: 57.0a1 15:49:12 INFO - using testdate: 1505342952 15:49:12 INFO - actual date: 1505342952 15:49:12 INFO - starting webserver on 'localhost:38316' 15:49:12 INFO - SUITE-START | Running 2 tests 15:49:12 INFO - TEST-START | dromaeo_css 15:49:12 INFO - Initialising browser for dromaeo_css test... 15:49:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38316/getInfo.html -profile /tmp/tmpYC1rQa/profile 15:49:12 INFO - TEST-INFO | started process 27053 (/builds/slave/test/build/application/firefox/firefox http://localhost:38316/getInfo.html) 15:49:18 INFO - TEST-INFO | 27053: exit 0 15:49:19 INFO - Browser initialized. 15:49:19 INFO - Running cycle 1/1 for dromaeo_css test... 15:49:19 INFO - Using env: {'DISPLAY': ':0', 15:49:19 INFO - 'HOME': '/home/cltbld', 15:49:19 INFO - 'JSGC_DISABLE_POISONING': '1', 15:49:19 INFO - 'LANG': 'en_US.UTF-8', 15:49:19 INFO - 'LANGUAGE': 'en_US:en', 15:49:19 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:49:19 INFO - 'LOGNAME': 'cltbld', 15:49:19 INFO - 'MAIL': '/var/mail/cltbld', 15:49:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:49:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:49:19 INFO - 'MOZ_CRASHREPORTER': '1', 15:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:19 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:49:19 INFO - 'MOZ_NO_REMOTE': '1', 15:49:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:49:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:19 INFO - 'NO_EM_RESTART': '1', 15:49:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:19 INFO - 'PWD': '/builds/slave/test', 15:49:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:49:19 INFO - 'RUST_BACKTRACE': 'full', 15:49:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:49:19 INFO - 'SHELL': '/bin/bash', 15:49:19 INFO - 'SHLVL': '1', 15:49:19 INFO - 'STYLO_FORCE_DISABLED': '1', 15:49:19 INFO - 'TERM': 'linux', 15:49:19 INFO - 'TMOUT': '86400', 15:49:19 INFO - 'USER': 'cltbld', 15:49:19 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 15:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:19 INFO - '_': '/tools/buildbot/bin/python'} 15:49:19 INFO - TEST-INFO | started process 27281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYC1rQa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:49:19 INFO - PID 27281 | 15:49:19 INFO - PID 27281 | (/builds/slave/test/build/application/firefox/firefox:27332): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:49:19 INFO - PID 27281 | 15:49:30 INFO - PID 27281 | RSS: Main: 173395968 15:49:30 INFO - PID 27281 | 15:52:27 INFO - PID 27281 | Cycle 1(1): loaded http://localhost:38316/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38316/tests/dromaeo/cssquery-ext.html) 15:52:29 INFO - PID 27281 | RSS: Main: 176406528 15:52:29 INFO - PID 27281 | 15:55:30 INFO - PID 27281 | Cycle 1(1): loaded http://localhost:38316/tests/dromaeo/cssquery-ext.html (next: http://localhost:38316/tests/dromaeo/cssquery-jquery.html) 15:55:31 INFO - PID 27281 | RSS: Main: 171470848 15:55:31 INFO - PID 27281 | 15:58:33 INFO - PID 27281 | Cycle 1(1): loaded http://localhost:38316/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38316/tests/dromaeo/cssquery-mootools.html) 15:58:33 INFO - PID 27281 | RSS: Main: 174964736 15:58:33 INFO - PID 27281 | 16:01:35 INFO - PID 27281 | Cycle 1(1): loaded http://localhost:38316/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38316/tests/dromaeo/cssquery-prototype.html) 16:01:36 INFO - PID 27281 | RSS: Main: 173387776 16:01:36 INFO - PID 27281 | 16:04:39 INFO - PID 27281 | Cycle 1(1): loaded http://localhost:38316/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38316/tests/dromaeo/cssquery-yui.html) 16:04:40 INFO - PID 27281 | RSS: Main: 175038464 16:04:40 INFO - PID 27281 | 16:07:41 INFO - PID 27281 | Cycle 1(1): loaded http://localhost:38316/tests/dromaeo/cssquery-yui.html (next: http://localhost:38316/tests/dromaeo/cssquery-dojo.html) 16:07:41 INFO - PID 27281 | RSS: Main: 175796224 16:07:41 INFO - PID 27281 | 16:07:41 INFO - PID 27281 | __start_tp_report 16:07:41 INFO - PID 27281 | _x_x_mozilla_page_load 16:07:41 INFO - PID 27281 | _x_x_mozilla_page_load_details 16:07:41 INFO - PID 27281 | |i|pagename|runs| 16:07:41 INFO - PID 27281 | |0;dojo.html;3130.671279515651;3144.261098641818;3150.9054728358155;3158.478850989585;3166.4300425923325;6129.908051379233;6135.110408990694;6241.781537646183;6271.498280137589;6351.745930162788;6222.688865556726;6308.873822523558;6351.9682401587925;6409.967950160254;6419.358064193579;1239.0900148404235;5478.972605136969;5805.274340707411;5863.1205319202145;5909.290885093773;5665.801696940587;5751.338596061465;5754.223179870727;5781.306243250816;5854.09261564456;5702.942970570282;5824;5842.591018628719;5854.531637469035;5859.648421094706;5773.884522309572;5786.450287222707;5873.706314684248;5874.530037596982;5888.234529511136;5665.291838520185;5758.280214973129;5770.913436298459;5833.212516310286;5844.386339434383;6215.937840621581;6280.497560195174;6304.747810087591;6312.936870631281;6363.7772677956045;6753.122094127781;6755.966220168917;6831.69257383419;6835.863282734367;6848.7260509579555;6738.35985581369;6812.863742725167;6818.624975626339;6864.897026544606;6892.069570607954;6309.179806625109;6327.209098862642;6328.272248691414;6331.33520980295;6382.776602818925;7014.789556313319;7019.964900175466;7095;7099.112610923635;7124.145102587722;6447.548671592944;6578.868422631521;6644.202695676453;6663.5002374821115;6757.290484499155;6712.899306510406;6724.260331363546;6729.192496900403;6738.629375384303;6740.056392105109;6664.1336626239245;6667.899981500184;6667.933320666828;6672.399484046362;6780.084688567079;6756.324367563303;6774.83062923421;6793.966030169818;6835.897461538081;6864.519483636197;5244.659097158673;5337.19942008694;5386.946130538645;5414.729263536808;5418.078926582491;4595.4025976622825;4646.767661616906;4702.36518070063;4740.597049250852;4745.95254047462;5778.6532808030815;5794.21778059965;5852.912206316909;5876.9118463223085;5887.322957859816;6656.900146497806;6746.730130794811;6756.425703815133;6788.49086318528;6789.321067893171;5730.541556675456;5752.13717942312;5753.223314852525;5754.74103665336;5754.827355179351;5796.565257605696;5887.322957859901;5892.6759028253;5906.468417842415;5912.113183022495;6551.050097735897;6568.277489476154;6613.2394774601535;6652.634105124264;6655.600663960081;6725.730970761115;6773;6779.389854913082;6781.593104413751;6887.20797108339;6540.444062254572;6561.179852518435;6585.440237579668;6627.105340778933;6643.202815662152;6674.16572928384;6682.231543372574;6772.93227067723;6784.05023296729;6785.1518560179975;6792.626405547545;6804.183497980274;6866.553674011173;6891.104156459628;6909.205441374306;6396.456301214449;6494.577852439576;6562.868742625216;6648.401643852077;6656.467482601477;5784.913226301693;6567.802965911031;6576.243731970884;6606.10817539626;6616.172978377703;6491.156149700509;6497.02544618311;6503.772367967098;6567.44176744982;6592.43964263043;6544.509161812788;6589.604623722592;6660.333966603301;6686.632235226914;6688.431483323972;6239.688015599293;6347.841303967438;6354;6409.2949775525585;6494.383033611799 16:07:41 INFO - PID 27281 | |1;ext.html;845.374422927034;865.645085514939;868.4832524647833;868.7871471489486;875.2472873328936;38625.61374386255;42320.576794232045;42406.787966060205;42493.7875310623;42570.57429425709;37494;37723.245535089285;37807.243855122884;37848.24303513928;37897.431538526944;7082.433405327562;7791.766247012599;7972.641231144584;7984.760457186265;7985.441019128663;7855.567943763091;7929.484583502082;7962.203779622049;7967.123616402191;7967.482113662622;7926.8810967835525;7939.087004994413;7960.164182760814;7997.840043199132;8001.519908805491;7902.565358905258;7938.24586664266;7950.443468957175;7955.164707705723;7958.045034595885;7867.763967080997;7920.960395198044;7922.683092676286;7935.9206407936335;7956.5226086435;37958.62041379578;38149.427758583646;38149.80925095385;38173.80913095417;38245.42631860524;3588.5334906462253;3633.727470439701;3636.054625797312;3638.945415818765;3640.799756013418;31267.06198814039;31330.843345783127;31400.37199256002;31439.52840707391;31491.212719681964;5082.3138876251605;5217.58259339252;5218.895622087575;5254.238135470374;5280.287161233223;181828;182582;183202;183229;183527;41859.581404186174;42774.78612606917;48259.276110858365;48458;48526;51479.22781158286;51515;51584.74207629013;51585;51587.22619160716;15568.377264909277;15705.450309239122;15709.842901571066;15721.68556628861;15734.842651573566;12709.237445753099;12722.491100355883;12733.490660373482;12734.490620375082;12836.935815320863;13994.230317332442;14011.71976560463;14017.229052402012;14149;14223.573292801233;5702.7718891243885;5745;5856.765729370863;5859;5967.79112731061;1010.3281317923645;1019.37308555238;1031.747221930632;1036.7563622548696;1039.9896001040045;22465.32604021882;22759;22797.88601057017;23069.19257825968;23403.53192936166;1118.4463690473267;1119.339589642115;1120.1263014848432;1138.5445821671399;1141.4064686363045;11938;12238.81641775374;12247.755044899051;12277.20198187115;12344.62966111018;225731;226659;227014;227329;227620;52781.7360913193;52803.20795188075;52910;53092.46907530953;53160.73419632877;1459.7883306920437;1461.729580027677;1464.9707005859823;1467.486379767073;1468.530070377469;22295.331140065824;22412.551748965256;22655.320340389815;22859.77140228643;23118.76881231166;36681;36801.81599091987;36859.07852303714;36868.26263474662;36914.8154259227;193419;193609;193949;194565;195154;30413.84793076109;31166.688333117287;33254;33380;33513.664863351056;42897.35653965131;42996.78501607472;43135.784321078194;43202.567974321115;43500;31758.36483270368;31770.841145794122;31948.52077218797;32109.678903210668;32627.34745305033;31323;31348.059558213292;31721.20696982594;31808.68191318057;32656.183595409355;35557.64442355543;35736.28527429385;35963;36087.819560902026;36124.638753612126;30206.395872081997;30237;30403.695963040085;30903.69096309098;31335.84332078325;23146.76853231446;23169.652455213523;23311.533769324178;23817.880910596028;23964.88017559901 16:07:41 INFO - PID 27281 | |2;jquery.html;554.8834744703614;557.9358373787014;558.6620094842617;566.9149627555867;578.6123297390749;21951;22784.430389240235;22787.31638050861;22813.771862281374;22821.31536053919;23967.842894139525;24254.151104711338;24592.87703561484;24629.50740985179;24687.382815429624;6362.1093046973465;6620.6358650274215;6624.56940298879;6630.668466576676;6634.402903738663;6307.369263073701;6610.834729131762;6713.2951040140815;6718.126643536358;6720.294369091248;6597.373249541286;6601.867962640745;6629.535932484728;6632.204135503746;6632.469402447817;6324.525660575429;6612.669366531678;6613.140291762088;6624.503162262801;6625.60246385216;6113;6114.908276375858;6134;6141.170941922828;6144.754209831646;29313.120606381843;29738.107856764116;30045.248868778235;30064.398712025635;30104.698953010407;2052.1688716070016;2074.802893725109;2077.366403247009;2083.073032500538;2084.6351888419467;19392.80607193924;19573.80426195734;19889.60220795576;20221.595568088556;20262;2441.4994926040117;2445.4131008557997;2489.8630575318352;2495.1017633652054;2497.2882728422314;123267.383663082;130226.348868256;137163;141978.29010854982;143296.2835185828;14130.434782608787;14367.712645747026;14577.125372477685;14587.863802913302;14677.368602438582;22419.439514011952;22479.438014049778;22497.100115995177;22497.662535061987;22554.436139096324;9623.374480658735;9890.258230632731;9957.701268961942;10115.342502737298;10179.18566514677;9221.95389023064;9308.534573271445;9311.953440232755;9341.486218257925;9368.814603035002;8869.379143460024;8904.465732056098;9012.504312262758;9157.084291570924;9259.583318750672;2620.5414052540727;2646.6691663542056;2757.9724202757716;2816.1554182010814;2846.316883947879;953.77109493721;961.3654987708219;971.9368241064308;973.3186769261404;986.3736527305213;19379.709304360447;19408.80591194098;19641.31255406054;19710.802891971183;19781.60436791256;998.2164001258977;1029.2126523209752;1036.362636978253;1040.47976011994;1043.1811028342715;10655.725415919169;10854.565817367375;11033.393163376091;11147.777044459228;11217.775644487065;421959;428601;428998;434923;437450;102667;102891;106284.46857765662;107009.4649526763;109453.45273273582;1046.424466543398;1090.373035504588;1134.7957367673898;1158.9304641721524;1213.9210951288314;20576.176952921716;20701.58596828085;20867.269645562334;21092.578148436638;21172.364829055154;54191.72904135454;54628.453715463926;54879;54904.72547637236;55010;67696;67983;68168;68310.65844670944;68601;14149.36327865228;14264.928675356558;14363;14440.277986100864;14540.127592344494;22286.554268914206;22399.664005039613;22519.211827585958;22624.434389140402;23005.309840704806;16364.181790910645;16498.917505412875;16587.502374928772;16675.416360427327;18347.08264586792;14791.778123327944;15267.618309542351;15527.146006969726;15648.217589120271;16065;17155.571110722332;17368.39210627622;17526.298948042444;17549.912250438665;17555.82444175542;13350.465981361025;13361.53234636783;13370.598882033555;13434.126781759154;13468.865311347154;16293.348266069224;16358.34566617322;16430;16498.092604906844;16538.834611654212 16:07:41 INFO - PID 27281 | |3;mootools.html;1347.1714895339367;1407.5917983784702;1407.859214078592;1414.8726614604684;1419.2194293138778;14897.627559311022;15612.531624051282;15612.687746245068;15612.843871561281;15623.21883905803;15239.085654860688;15309.387624495006;15347.462838800644;15373.077615343087;15380.923095384536;2595.974040259592;2713.592961055838;2715.891364345424;2727.7135900730436;2728.931776705588;2626.4090579619624;2678.504476671822;2704.5267078261227;2705.3236690827293;2706.8375897446117;2696.137236084454;2725.713800050996;2731.549294366437;2735.685396179445;2739.013954976207;2553.9911734864622;2616.8037397195285;2638.300850274679;2647.7352264773367;2650.1651979626454;2578.8065895057944;2604.882780274892;2607.282997175773;2609.3998380372623;2610.5040042392075;15230.543083707507;15409.691806163926;15413.306401211972;15422.922885385502;15426.228688565527;7609.6956121755065;7894.80262993424;7902;7905.051393832719;7909.485883417559;5207.739613019372;5255.343082114736;5360.061989151883;5414.485623865727;5414.891702165974;1763.1536862306036;1779.3950056980689;1796.97304540432;1813.9909300453546;1834.0462959261242;26272;26410;26467.73532264672;26497.60253596178;26568.734312657012;6360.872782544323;6393.936060639334;6416.550841441054;6671.566348187353;6699.229588597276;17306.307747689953;17356.305747769948;17360.13199340028;17404.129793510274;17423.303067877398;7677.193894641094;7680.039995000625;7690.923090769133;7693.115291741409;7693.538387696756;7148.92851071493;7181.533200341961;7200.603966781878;7201.92798072023;7246.202917679051;5008.6744361616375;5096.51583099605;5106.285120083191;5138.845834624967;5290.391604965402;1407.9507217247346;1411.9576412707636;1427.5075099090798;1432.4699861051477;1436.7485690004207;924.2098006204599;926.9397489163183;928.9303302252358;940.1444685336311;941.0589410589411;7863.764087077397;7891.644875980594;7926;7934.087579928267;8083.555404452694;688.6625553478759;700.1912790726719;702.6240961085795;713.6110819603329;753.8153152477678;4703.0593881223895;4822.324874517571;5279.52484276417;5326.094563924142;5362.785488580491;21478.570428591654;21920.561588768134;22510.212142574932;22514.099436022705;22543.549129017654;19230.903845480963;21430.57138857214;21813.78186218149;21949.122035118417;22144.446388840086;10884.891151088546;11214.215004949576;11251.943740281245;11253.437328133725;11273.54905803775;8545.401821872658;8712.303015758598;8786.209241168326;9223.308251881002;9286.767830804014;18718.344857929907;18734.34429795005;18783.812161878206;19022.334218302294;19065;17938.19278132461;19064.618707625494;19318.227270909007;19659.311924082587;19666.410007699793;12092.818607721067;12225.877741222474;12256.87743122593;12277.631671049883;12290.877091228973;13591.86408135906;13713.931430342784;13716.519921803088;13719.725605488034;13729.931350343184;10726.678199654023;10780.191485638452;10833.133349332193;10882.45587720595;11076.833847492133;10740.892591073989;10774.084202842847;10828.675139745821;10976;11124.777504450027;9869.457179855177;9985.301028928196;9985.750356241153;10007.749806254902;10022.849657255001;7058;7186.568805871664;7235.312645298688;7258.528195667264;7263.164736055422;7105.502614816914;7187.389071928945;7207.387372073433;7262.74580389705;7273 16:07:41 INFO - PID 27281 | |4;prototype.html;493.078868257317;502.2040066494605;519.8986197691447;523.4111624422525;525.7712894890723;6227.508996401441;6268.4671802896755;6343.904841427371;6365.140706004694;6435.967820160899;6222.222222222223;6223.315435302113;6270.749170033205;6309.4321511064;6310.526710496708;5226.660267082637;5246.501582349671;5289.100852855024;5314.202869569576;5353.518183363496;4953.752312384367;5117.385913690362;5271.736413179345;5302.072137375963;5310.6017048721305;5071.366079240095;5083.339165908426;5100.234964755279;5109.182530795074;5109.923351149736;5022.372203474548;5035.546800787946;5053.317802096743;5068.974655126719;5075.314832497603;4520;4548.408706868086;4560.771961401917;4569.2689169732685;4573.428321459817;6290.710404367093;6327.715252813588;6349.1428657131155;6363.109164716943;6364.745410183587;5798.449147330997;5803.709814509258;5809.331926828384;5835.124731290341;5854;6697.129373181504;6720.697568609425;6737.461003119739;6750;6774.627395493246;4932.618866717325;4972.254161875748;4973.52751488608;4977.850664480072;4990.30135780991;7069.8939515907305;7079.079719636415;7105.5026148169645;7120.145582530129;7129.429645628337;5002.499750024968;5038.395392552917;5076.847694569169;5094.363204599425;5097.796088156432;5102.311187989574;5103.770330335144;5144.408393034774;5164;5165.896682066413;5768.653880767168;5776.480116789509;5830.970845145832;5831.62094463867;5838.38696936824;6713.630750308682;6748.628825414551;6753.45972322213;6779.389854912983;6838.829029274308;1663.5508412728495;1668.5244705258942;1713.9716170297722;1750.492357216393;1772.59230377014;1189.649053529211;1198.1133960868895;1227.1410012990764;1229.6864299603544;1233.8827811357908;5643.633163844419;5680.573956953245;5695.943040569541;5795.82612521625;5803.984302747087;6557.5081868860025;6682.699278532477;6706.295838936841;6711.697973591103;6845.931540684629;5666.575006874501;5742.54059675225;5791.82624521265;5797.913031304533;5860.208871802252;3610.765300255475;3627.2564124354444;3660.7803531788177;3671.9082022949106;3679;6563.573367731177;6634.336566343423;6638.419490551504;6667.533272670964;6667.733290668416;6950.721971121199;6975.930240697629;6994.93005069953;7020.859582808315;7023.438124949992;6523.706433210422;6537.215534135934;6561.245456772533;6603.867922641521;6633.3035031321015;6674.666266686743;6807.974942176111;6829.2487826338065;6896.5172637785845;6908.647552042382;6808.897866531907;6881.65591720422;6897.965510172417;6910.203347129883;6918.688659010458;6435.549511534147;6450.741970321134;6538.574992625464;6551.672416379257;6578.80263592093;4951.876203094807;4967.60259179272;5010.69935803853;5011.824586139468;5019.623528235324;6545.410913017851;6737.966310168418;6742.190937087581;6764.695588698422;6774.96612516954;6223.906641400473;6567.540272180901;6591.604503729792;6602.491053399677;6634.336566343327;6508.153939987771;6532;6554.377334153248;6584.50616203777;6615.338466153346;6225.252969643671;6418.229812422539;6529.575577587441;6588.242352129375;6594.175728033996;6553.344665533408;6584.275729669636;6616.378987147987;6621.470282377494;6779.220389655055;6413.839654008687;6414.871702565829;6429.260635026844;6482.092507049111;6514.719848053143 16:07:41 INFO - PID 27281 | |5;yui.html;893.7095443980708;918.1231923513044;927.2303987690218;936.3679516326478;955.4697143085587;16653.583660408494;17126.571835704115;17148.399806006793;17158.571035724082;17159.22783474742;18477.907610461927;18715.53211169718;18826.529336766587;18880.622387552274;18921;942.1144124522943;957.459035644862;960.4573416019962;961.8412961861285;962.2686758063852;959.592173326337;980.882294124706;980.9901900981006;983.4492684096892;987.3976874106789;1037.5849660135968;1039.397149653203;1040.432964034599;1040.5889673578931;1047.1518070362993;1035.8394448860438;1037.2065369991963;1038.4496217004998;1041.807265655856;1052.610534102383;714.6569646569624;715.1596873673413;733.4719002318323;733.9376153026999;733.9889901651479;18021.909890450464;18044.368447104418;18058.277668893228;18075.54811129719;18079.548011299692;20917.686234706493;21322.680159797615;21458.892705536528;21814.563708725895;21865.12539498418;16893.40873069449;17176.742348864776;17314.740278895828;17333.7399939001;17448.738268925976;3821.0829400943853;3838.9826695925603;3843.0392401899526;3844.231153769257;3847.615238476158;130169;131243;132860;133188;136841.31579342138;16171.919140404458;16212;16282.185890705417;16471.094089824936;16792.412265570892;30798;31090.22274443157;31329.216769580486;31334;31344.21639458986;8004.399670024772;8068.556229407322;8129.227723366271;8135.1051384347675;8145.959270203611;3986.681065514752;4071.6539094176733;4082.387641853686;4085.1216988347646;4091.4476545665952;5162.3030890830005;5175.741212939338;5178.223266509978;5207.2449494823795;5243.9213411798855;911.1981456318398;919.6137622198693;944.7921457279525;945.8770359853175;946.0208684012152;653.2422390027546;682.6109117802904;685.9451243900476;687.621808005595;695.1553862057624;10922.672319830417;11527.827082593767;11896.762064758655;12026.4588093536;12515.311657858905;684.5276759036249;689.941354984832;693.5041445366486;708.125465050662;711.7402148215967;4953.876153096129;4978.850634480971;5014.07239660664;5024.648274620741;5079.9840031993745;127405;129165.35417323041;129819.35090324677;130904.345478272;134988.3250583741;108905;110817;110889.44555277172;112789;117419;95251.52374238223;96708.51645741727;97665;98822.50588747155;100423.49788251158;9232.122948319899;9324.300677449082;9337.579808908751;9430.528473576156;9578.952105239428;39774.60225397709;41158.1768364625;41572.79213603913;41573.58426415697;43350.13299733924;56250.718746406004;58422.83154336805;59287;59355.10967335407;60124.39875601188;14295.499657511937;14418.783718244025;14482;14649.340779664728;14651.706965860836;15976.121313327878;16179.676406472041;16218.351265949701;16358.672826543165;16379.508614741577;13268.469261229442;13465;13522.12106213093;13561.321933903462;13564.72870542564;13559.728805424034;13701.520446784314;13740.381682824096;13898.444062237397;13900.37448314808;13370.197788132744;13381.39783709716;13616.455341786217;13633;13669.043166978216;11384.203105782515;11408.790935126386;11560.248583842023;11583.42082895835;11665.766684666429;11333.093352531612;11346.659600212008;11504.079673626256;11582.247153934968;11596.94201528987 16:07:41 INFO - PID 27281 | __end_tp_report 16:07:41 INFO - PID 27281 | __start_cc_report 16:07:41 INFO - PID 27281 | _x_x_mozilla_cycle_collect,366 16:07:41 INFO - PID 27281 | __end_cc_report 16:07:41 INFO - PID 27281 | __startTimestamp1505344061785__endTimestamp 16:07:41 INFO - PID 27281 | 16:07:41 INFO - PID 27281 | ------- Summary: start ------- 16:07:41 INFO - PID 27281 | Number of tests: 6 16:07:41 INFO - PID 27281 | 16:07:41 INFO - PID 27281 | [#0] dojo.html Cycles:165 Average:6190.97 Median:6491.16 stddev:846.31 (13.0%) stddev-sans-first:814.14 16:07:41 INFO - PID 27281 | Values: 3130.7 3144.3 3150.9 3158.5 3166.4 6129.9 6135.1 6241.8 6271.5 6351.7 6222.7 6308.9 6352.0 6410.0 6419.4 1239.1 5479.0 5805.3 5863.1 5909.3 5665.8 5751.3 5754.2 5781.3 5854.1 5702.9 5824.0 5842.6 5854.5 5859.6 5773.9 5786.5 5873.7 5874.5 5888.2 5665.3 5758.3 5770.9 5833.2 5844.4 6215.9 6280.5 6304.7 6312.9 6363.8 6753.1 6756.0 6831.7 6835.9 6848.7 6738.4 6812.9 6818.6 6864.9 6892.1 6309.2 6327.2 6328.3 6331.3 6382.8 7014.8 7020.0 7095.0 7099.1 7124.1 6447.5 6578.9 6644.2 6663.5 6757.3 6712.9 6724.3 6729.2 6738.6 6740.1 6664.1 6667.9 6667.9 6672.4 6780.1 6756.3 6774.8 6794.0 6835.9 6864.5 5244.7 5337.2 5386.9 5414.7 5418.1 4595.4 4646.8 4702.4 4740.6 4746.0 5778.7 5794.2 5852.9 5876.9 5887.3 6656.9 6746.7 6756.4 6788.5 6789.3 5730.5 5752.1 5753.2 5754.7 5754.8 5796.6 5887.3 5892.7 5906.5 5912.1 6551.1 6568.3 6613.2 6652.6 6655.6 6725.7 6773.0 6779.4 6781.6 6887.2 6540.4 6561.2 6585.4 6627.1 6643.2 6674.2 6682.2 6772.9 6784.1 6785.2 6792.6 6804.2 6866.6 6891.1 6909.2 6396.5 6494.6 6562.9 6648.4 6656.5 5784.9 6567.8 6576.2 6606.1 6616.2 6491.2 6497.0 6503.8 6567.4 6592.4 6544.5 6589.6 6660.3 6686.6 6688.4 6239.7 6347.8 6354.0 6409.3 6494.4 16:07:41 INFO - PID 27281 | 16:07:41 INFO - PID 27281 | [#1] ext.html Cycles:180 Average:36900.25 Median:35646.96 stddev:52331.22 (146.8%) stddev-sans-first:52407.99 16:07:41 INFO - PID 27281 | Values: 845.4 865.6 868.5 868.8 875.2 38625.6 42320.6 42406.8 42493.8 42570.6 37494.0 37723.2 37807.2 37848.2 37897.4 7082.4 7791.8 7972.6 7984.8 7985.4 7855.6 7929.5 7962.2 7967.1 7967.5 7926.9 7939.1 7960.2 7997.8 8001.5 7902.6 7938.2 7950.4 7955.2 7958.0 7867.8 7921.0 7922.7 7935.9 7956.5 37958.6 38149.4 38149.8 38173.8 38245.4 3588.5 3633.7 3636.1 3638.9 3640.8 31267.1 31330.8 31400.4 31439.5 31491.2 5082.3 5217.6 5218.9 5254.2 5280.3 181828.0 182582.0 183202.0 183229.0 183527.0 41859.6 42774.8 48259.3 48458.0 48526.0 51479.2 51515.0 51584.7 51585.0 51587.2 15568.4 15705.5 15709.8 15721.7 15734.8 12709.2 12722.5 12733.5 12734.5 12836.9 13994.2 14011.7 14017.2 14149.0 14223.6 5702.8 5745.0 5856.8 5859.0 5967.8 1010.3 1019.4 1031.7 1036.8 1040.0 22465.3 22759.0 22797.9 23069.2 23403.5 1118.4 1119.3 1120.1 1138.5 1141.4 11938.0 12238.8 12247.8 12277.2 12344.6 225731.0 226659.0 227014.0 227329.0 227620.0 52781.7 52803.2 52910.0 53092.5 53160.7 1459.8 1461.7 1465.0 1467.5 1468.5 22295.3 22412.6 22655.3 22859.8 23118.8 36681.0 36801.8 36859.1 36868.3 36914.8 193419.0 193609.0 193949.0 194565.0 195154.0 30413.8 31166.7 33254.0 33380.0 33513.7 42897.4 42996.8 43135.8 43202.6 43500.0 31758.4 31770.8 31948.5 32109.7 32627.3 31323.0 31348.1 31721.2 31808.7 32656.2 35557.6 35736.3 35963.0 36087.8 36124.6 30206.4 30237.0 30403.7 30903.7 31335.8 23146.8 23169.7 23311.5 23817.9 23964.9 16:07:41 INFO - PID 27281 | 16:07:41 INFO - PID 27281 | [#2] jquery.html Cycles:180 Average:32433.23 Median:22704.43 stddev:73057.63 (321.8%) stddev-sans-first:73223.37 16:07:41 INFO - PID 27281 | Values: 554.9 557.9 558.7 566.9 578.6 21951.0 22784.4 22787.3 22813.8 22821.3 23967.8 24254.2 24592.9 24629.5 24687.4 6362.1 6620.6 6624.6 6630.7 6634.4 6307.4 6610.8 6713.3 6718.1 6720.3 6597.4 6601.9 6629.5 6632.2 6632.5 6324.5 6612.7 6613.1 6624.5 6625.6 6113.0 6114.9 6134.0 6141.2 6144.8 29313.1 29738.1 30045.2 30064.4 30104.7 2052.2 2074.8 2077.4 2083.1 2084.6 19392.8 19573.8 19889.6 20221.6 20262.0 2441.5 2445.4 2489.9 2495.1 2497.3 123267.4 130226.3 137163.0 141978.3 143296.3 14130.4 14367.7 14577.1 14587.9 14677.4 22419.4 22479.4 22497.1 22497.7 22554.4 9623.4 9890.3 9957.7 10115.3 10179.2 9222.0 9308.5 9312.0 9341.5 9368.8 8869.4 8904.5 9012.5 9157.1 9259.6 2620.5 2646.7 2758.0 2816.2 2846.3 953.8 961.4 971.9 973.3 986.4 19379.7 19408.8 19641.3 19710.8 19781.6 998.2 1029.2 1036.4 1040.5 1043.2 10655.7 10854.6 11033.4 11147.8 11217.8 421959.0 428601.0 428998.0 434923.0 437450.0 102667.0 102891.0 106284.5 107009.5 109453.5 1046.4 1090.4 1134.8 1158.9 1213.9 20576.2 20701.6 20867.3 21092.6 21172.4 54191.7 54628.5 54879.0 54904.7 55010.0 67696.0 67983.0 68168.0 68310.7 68601.0 14149.4 14264.9 14363.0 14440.3 14540.1 22286.6 22399.7 22519.2 22624.4 23005.3 16364.2 16498.9 16587.5 16675.4 18347.1 14791.8 15267.6 15527.1 15648.2 16065.0 17155.6 17368.4 17526.3 17549.9 17555.8 13350.5 13361.5 13370.6 13434.1 13468.9 16293.3 16358.3 16430.0 16498.1 16538.8 16:07:41 INFO - PID 27281 | 16:07:41 INFO - PID 27281 | [#3] mootools.html Cycles:180 Average:9332.33 Median:14449.20 stddev:6750.09 (46.7%) stddev-sans-first:6742.36 16:07:41 INFO - PID 27281 | Values: 1347.2 1407.6 1407.9 1414.9 1419.2 14897.6 15612.5 15612.7 15612.8 15623.2 15239.1 15309.4 15347.5 15373.1 15380.9 2596.0 2713.6 2715.9 2727.7 2728.9 2626.4 2678.5 2704.5 2705.3 2706.8 2696.1 2725.7 2731.5 2735.7 2739.0 2554.0 2616.8 2638.3 2647.7 2650.2 2578.8 2604.9 2607.3 2609.4 2610.5 15230.5 15409.7 15413.3 15422.9 15426.2 7609.7 7894.8 7902.0 7905.1 7909.5 5207.7 5255.3 5360.1 5414.5 5414.9 1763.2 1779.4 1797.0 1814.0 1834.0 26272.0 26410.0 26467.7 26497.6 26568.7 6360.9 6393.9 6416.6 6671.6 6699.2 17306.3 17356.3 17360.1 17404.1 17423.3 7677.2 7680.0 7690.9 7693.1 7693.5 7148.9 7181.5 7200.6 7201.9 7246.2 5008.7 5096.5 5106.3 5138.8 5290.4 1408.0 1412.0 1427.5 1432.5 1436.7 924.2 926.9 928.9 940.1 941.1 7863.8 7891.6 7926.0 7934.1 8083.6 688.7 700.2 702.6 713.6 753.8 4703.1 4822.3 5279.5 5326.1 5362.8 21478.6 21920.6 22510.2 22514.1 22543.5 19230.9 21430.6 21813.8 21949.1 22144.4 10884.9 11214.2 11251.9 11253.4 11273.5 8545.4 8712.3 8786.2 9223.3 9286.8 18718.3 18734.3 18783.8 19022.3 19065.0 17938.2 19064.6 19318.2 19659.3 19666.4 12092.8 12225.9 12256.9 12277.6 12290.9 13591.9 13713.9 13716.5 13719.7 13729.9 10726.7 10780.2 10833.1 10882.5 11076.8 10740.9 10774.1 10828.7 10976.0 11124.8 9869.5 9985.3 9985.8 10007.7 10022.8 7058.0 7186.6 7235.3 7258.5 7263.2 7105.5 7187.4 7207.4 7262.7 7273.0 16:07:41 INFO - PID 27281 | 16:07:41 INFO - PID 27281 | [#4] prototype.html Cycles:180 Average:5598.88 Median:6269.61 stddev:1573.05 (25.1%) stddev-sans-first:1530.07 16:07:41 INFO - PID 27281 | Values: 493.1 502.2 519.9 523.4 525.8 6227.5 6268.5 6343.9 6365.1 6436.0 6222.2 6223.3 6270.7 6309.4 6310.5 5226.7 5246.5 5289.1 5314.2 5353.5 4953.8 5117.4 5271.7 5302.1 5310.6 5071.4 5083.3 5100.2 5109.2 5109.9 5022.4 5035.5 5053.3 5069.0 5075.3 4520.0 4548.4 4560.8 4569.3 4573.4 6290.7 6327.7 6349.1 6363.1 6364.7 5798.4 5803.7 5809.3 5835.1 5854.0 6697.1 6720.7 6737.5 6750.0 6774.6 4932.6 4972.3 4973.5 4977.9 4990.3 7069.9 7079.1 7105.5 7120.1 7129.4 5002.5 5038.4 5076.8 5094.4 5097.8 5102.3 5103.8 5144.4 5164.0 5165.9 5768.7 5776.5 5831.0 5831.6 5838.4 6713.6 6748.6 6753.5 6779.4 6838.8 1663.6 1668.5 1714.0 1750.5 1772.6 1189.6 1198.1 1227.1 1229.7 1233.9 5643.6 5680.6 5695.9 5795.8 5804.0 6557.5 6682.7 6706.3 6711.7 6845.9 5666.6 5742.5 5791.8 5797.9 5860.2 3610.8 3627.3 3660.8 3671.9 3679.0 6563.6 6634.3 6638.4 6667.5 6667.7 6950.7 6975.9 6994.9 7020.9 7023.4 6523.7 6537.2 6561.2 6603.9 6633.3 6674.7 6808.0 6829.2 6896.5 6908.6 6808.9 6881.7 6898.0 6910.2 6918.7 6435.5 6450.7 6538.6 6551.7 6578.8 4951.9 4967.6 5010.7 5011.8 5019.6 6545.4 6738.0 6742.2 6764.7 6775.0 6223.9 6567.5 6591.6 6602.5 6634.3 6508.2 6532.0 6554.4 6584.5 6615.3 6225.3 6418.2 6529.6 6588.2 6594.2 6553.3 6584.3 6616.4 6621.5 6779.2 6413.8 6414.9 6429.3 6482.1 6514.7 16:07:41 INFO - PID 27281 | 16:07:41 INFO - PID 27281 | [#5] yui.html Cycles:180 Average:23983.37 Median:19919.34 stddev:35821.81 (179.8%) stddev-sans-first:35880.35 16:07:41 INFO - PID 27281 | Values: 893.7 918.1 927.2 936.4 955.5 16653.6 17126.6 17148.4 17158.6 17159.2 18477.9 18715.5 18826.5 18880.6 18921.0 942.1 957.5 960.5 961.8 962.3 959.6 980.9 981.0 983.4 987.4 1037.6 1039.4 1040.4 1040.6 1047.2 1035.8 1037.2 1038.4 1041.8 1052.6 714.7 715.2 733.5 733.9 734.0 18021.9 18044.4 18058.3 18075.5 18079.5 20917.7 21322.7 21458.9 21814.6 21865.1 16893.4 17176.7 17314.7 17333.7 17448.7 3821.1 3839.0 3843.0 3844.2 3847.6 130169.0 131243.0 132860.0 133188.0 136841.3 16171.9 16212.0 16282.2 16471.1 16792.4 30798.0 31090.2 31329.2 31334.0 31344.2 8004.4 8068.6 8129.2 8135.1 8146.0 3986.7 4071.7 4082.4 4085.1 4091.4 5162.3 5175.7 5178.2 5207.2 5243.9 911.2 919.6 944.8 945.9 946.0 653.2 682.6 685.9 687.6 695.2 10922.7 11527.8 11896.8 12026.5 12515.3 684.5 689.9 693.5 708.1 711.7 4953.9 4978.9 5014.1 5024.6 5080.0 127405.0 129165.4 129819.4 130904.3 134988.3 108905.0 110817.0 110889.4 112789.0 117419.0 95251.5 96708.5 97665.0 98822.5 100423.5 9232.1 9324.3 9337.6 9430.5 9579.0 39774.6 41158.2 41572.8 41573.6 43350.1 56250.7 58422.8 59287.0 59355.1 60124.4 14295.5 14418.8 14482.0 14649.3 14651.7 15976.1 16179.7 16218.4 16358.7 16379.5 13268.5 13465.0 13522.1 13561.3 13564.7 13559.7 13701.5 13740.4 13898.4 13900.4 13370.2 13381.4 13616.5 13633.0 13669.0 11384.2 11408.8 11560.2 11583.4 11665.8 11333.1 11346.7 11504.1 11582.2 11596.9 16:07:41 INFO - PID 27281 | -------- Summary: end -------- 16:07:41 INFO - PID 27281 | 16:07:41 INFO - PID 27281 | 16:07:41 INFO - PID 27281 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 16:07:41 INFO - PID 27281 | 16:07:42 INFO - TEST-INFO | 27281: exit 0 16:07:42 INFO - TEST-OK | dromaeo_css | took 1109941ms 16:07:42 INFO - TEST-START | kraken 16:07:42 INFO - Initialising browser for kraken test... 16:07:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38316/getInfo.html -profile /tmp/tmpRrUXcD/profile 16:07:42 INFO - TEST-INFO | started process 27649 (/builds/slave/test/build/application/firefox/firefox http://localhost:38316/getInfo.html) 16:07:48 INFO - TEST-INFO | 27649: exit 0 16:07:48 INFO - Browser initialized. 16:07:48 INFO - Running cycle 1/1 for kraken test... 16:07:48 INFO - Using env: {'DISPLAY': ':0', 16:07:48 INFO - 'HOME': '/home/cltbld', 16:07:48 INFO - 'JSGC_DISABLE_POISONING': '1', 16:07:48 INFO - 'LANG': 'en_US.UTF-8', 16:07:48 INFO - 'LANGUAGE': 'en_US:en', 16:07:48 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:07:48 INFO - 'LOGNAME': 'cltbld', 16:07:48 INFO - 'MAIL': '/var/mail/cltbld', 16:07:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:07:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:07:48 INFO - 'MOZ_CRASHREPORTER': '1', 16:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:48 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:07:48 INFO - 'MOZ_NO_REMOTE': '1', 16:07:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:48 INFO - 'NO_EM_RESTART': '1', 16:07:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:48 INFO - 'PWD': '/builds/slave/test', 16:07:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:07:48 INFO - 'RUST_BACKTRACE': 'full', 16:07:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:07:48 INFO - 'SHELL': '/bin/bash', 16:07:48 INFO - 'SHLVL': '1', 16:07:48 INFO - 'STYLO_FORCE_DISABLED': '1', 16:07:48 INFO - 'TERM': 'linux', 16:07:48 INFO - 'TMOUT': '86400', 16:07:48 INFO - 'USER': 'cltbld', 16:07:48 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104', 16:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:48 INFO - '_': '/tools/buildbot/bin/python'} 16:07:48 INFO - TEST-INFO | started process 27880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRrUXcD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:49 INFO - PID 27880 | 16:07:49 INFO - PID 27880 | (/builds/slave/test/build/application/firefox/firefox:27929): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:07:49 INFO - PID 27880 | 16:07:59 INFO - PID 27880 | RSS: Main: 173129728 16:07:59 INFO - PID 27880 | 16:08:02 INFO - PID 27880 | Cycle 1(1): loaded http://localhost:38316/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38316/tests/kraken/driver.html?testName=audio-beat-detection) 16:08:03 INFO - PID 27880 | RSS: Main: 179732480 16:08:03 INFO - PID 27880 | 16:08:05 INFO - PID 27880 | Cycle 1(1): loaded http://localhost:38316/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38316/tests/kraken/driver.html?testName=audio-dft) 16:08:06 INFO - PID 27880 | RSS: Main: 180006912 16:08:06 INFO - PID 27880 | 16:08:09 INFO - PID 27880 | Cycle 1(1): loaded http://localhost:38316/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38316/tests/kraken/driver.html?testName=audio-fft) 16:08:10 INFO - PID 27880 | RSS: Main: 174333952 16:08:10 INFO - PID 27880 | 16:08:12 INFO - PID 27880 | Cycle 1(1): loaded http://localhost:38316/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38316/tests/kraken/driver.html?testName=audio-oscillator) 16:08:12 INFO - PID 27880 | RSS: Main: 175316992 16:08:12 INFO - PID 27880 | 16:08:14 INFO - PID 27880 | Cycle 1(1): loaded http://localhost:38316/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38316/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:08:15 INFO - PID 27880 | RSS: Main: 175374336 16:08:15 INFO - PID 27880 | 16:08:18 INFO - PID 27880 | Cycle 1(1): loaded http://localhost:38316/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38316/tests/kraken/driver.html?testName=imaging-darkroom) 16:08:19 INFO - PID 27880 | RSS: Main: 177778688 16:08:19 INFO - PID 27880 | 16:08:22 INFO - PID 27880 | Cycle 1(1): loaded http://localhost:38316/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38316/tests/kraken/driver.html?testName=imaging-desaturate) 16:08:23 INFO - PID 27880 | RSS: Main: 177799168 16:08:23 INFO - PID 27880 | 16:08:26 INFO - PID 27880 | Cycle 1(1): loaded http://localhost:38316/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38316/tests/kraken/driver.html?testName=json-parse-financial) 16:08:27 INFO - PID 27880 | RSS: Main: 178036736 16:08:27 INFO - PID 27880 | 16:08:28 INFO - PID 27880 | Cycle 1(1): loaded http://localhost:38316/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38316/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:08:29 INFO - PID 27880 | RSS: Main: 178462720 16:08:29 INFO - PID 27880 | 16:08:31 INFO - PID 27880 | Cycle 1(1): loaded http://localhost:38316/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38316/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:08:31 INFO - PID 27880 | RSS: Main: 177876992 16:08:31 INFO - PID 27880 | 16:08:33 INFO - PID 27880 | Cycle 1(1): loaded http://localhost:38316/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38316/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:08:34 INFO - PID 27880 | RSS: Main: 174546944 16:08:34 INFO - PID 27880 | 16:08:37 INFO - PID 27880 | Cycle 1(1): loaded http://localhost:38316/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:08:37 INFO - PID 27880 | RSS: Main: 174813184 16:08:37 INFO - PID 27880 | 16:08:40 INFO - PID 27880 | Cycle 1(1): loaded http://localhost:38316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:08:41 INFO - PID 27880 | RSS: Main: 174993408 16:08:41 INFO - PID 27880 | 16:08:42 INFO - PID 27880 | Cycle 1(1): loaded http://localhost:38316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38316/tests/kraken/driver.html?testName=ai-astar) 16:08:43 INFO - PID 27880 | RSS: Main: 176201728 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | __start_tp_report 16:08:43 INFO - PID 27880 | _x_x_mozilla_page_load 16:08:43 INFO - PID 27880 | _x_x_mozilla_page_load_details 16:08:43 INFO - PID 27880 | |i|pagename|runs| 16:08:43 INFO - PID 27880 | |0;ai-astar;107;107;107;107;108;112;109;111;109;113 16:08:43 INFO - PID 27880 | |1;audio-beat-detection;120;115;114;116;115;145;120;119;120;146 16:08:43 INFO - PID 27880 | |2;audio-dft;164;165;164;162;161;161;163;167;176;165 16:08:43 INFO - PID 27880 | |3;audio-fft;74;73;74;73;73;74;73;74;74;74 16:08:43 INFO - PID 27880 | |4;audio-oscillator;79;79;78;79;79;79;135;79;86;78 16:08:43 INFO - PID 27880 | |5;imaging-gaussian-blur;113;113;115;113;113;114;113;114;113;114 16:08:43 INFO - PID 27880 | |6;imaging-darkroom;147;147;148;147;147;147;147;147;148;153 16:08:43 INFO - PID 27880 | |7;imaging-desaturate;93;94;93;94;93;94;93;94;93;93 16:08:43 INFO - PID 27880 | |8;json-parse-financial;52;53;52;52;50;51;50;51;54;52 16:08:43 INFO - PID 27880 | |9;json-stringify-tinderbox;37;38;38;37;37;38;38;38;38;39 16:08:43 INFO - PID 27880 | |10;stanford-crypto-aes;77;73;75;74;74;84;75;79;74;75 16:08:43 INFO - PID 27880 | |11;stanford-crypto-ccm;117;111;111;120;116;116;113;110;112;117 16:08:43 INFO - PID 27880 | |12;stanford-crypto-pbkdf2;172;168;170;172;168;171;181;167;172;168 16:08:43 INFO - PID 27880 | |13;stanford-crypto-sha256-iterative;64;64;63;65;64;68;69;64;63;64 16:08:43 INFO - PID 27880 | __end_tp_report 16:08:43 INFO - PID 27880 | __start_cc_report 16:08:43 INFO - PID 27880 | _x_x_mozilla_cycle_collect,945 16:08:43 INFO - PID 27880 | __end_cc_report 16:08:43 INFO - PID 27880 | __startTimestamp1505344123201__endTimestamp 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | ------- Summary: start ------- 16:08:43 INFO - PID 27880 | Number of tests: 14 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.00 stddev:2.26 (2.1%) stddev-sans-first:2.28 16:08:43 INFO - PID 27880 | Values: 107.0 107.0 107.0 107.0 108.0 112.0 109.0 111.0 109.0 113.0 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | [#1] audio-beat-detection Cycles:10 Average:123.00 Median:120.00 stddev:12.08 (10.1%) stddev-sans-first:12.77 16:08:43 INFO - PID 27880 | Values: 120.0 115.0 114.0 116.0 115.0 145.0 120.0 119.0 120.0 146.0 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:4.37 (2.7%) stddev-sans-first:4.62 16:08:43 INFO - PID 27880 | Values: 164.0 165.0 164.0 162.0 161.0 161.0 163.0 167.0 176.0 165.0 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | [#3] audio-fft Cycles:10 Average:73.60 Median:74.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 16:08:43 INFO - PID 27880 | Values: 74.0 73.0 74.0 73.0 73.0 74.0 73.0 74.0 74.0 74.0 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | [#4] audio-oscillator Cycles:10 Average:85.10 Median:79.00 stddev:17.69 (22.4%) stddev-sans-first:18.62 16:08:43 INFO - PID 27880 | Values: 79.0 79.0 78.0 79.0 79.0 79.0 135.0 79.0 86.0 78.0 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:113.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 16:08:43 INFO - PID 27880 | Values: 113.0 113.0 115.0 113.0 113.0 114.0 113.0 114.0 113.0 114.0 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.00 stddev:1.87 (1.3%) stddev-sans-first:1.96 16:08:43 INFO - PID 27880 | Values: 147.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 148.0 153.0 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | [#7] imaging-desaturate Cycles:10 Average:93.40 Median:93.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 16:08:43 INFO - PID 27880 | Values: 93.0 94.0 93.0 94.0 93.0 94.0 93.0 94.0 93.0 93.0 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:1.25 (2.4%) stddev-sans-first:1.32 16:08:43 INFO - PID 27880 | Values: 52.0 53.0 52.0 52.0 50.0 51.0 50.0 51.0 54.0 52.0 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:38.00 stddev:0.63 (1.7%) stddev-sans-first:0.60 16:08:43 INFO - PID 27880 | Values: 37.0 38.0 38.0 37.0 37.0 38.0 38.0 38.0 38.0 39.0 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:75.00 stddev:3.30 (4.4%) stddev-sans-first:3.48 16:08:43 INFO - PID 27880 | Values: 77.0 73.0 75.0 74.0 74.0 84.0 75.0 79.0 74.0 75.0 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | [#11] stanford-crypto-ccm Cycles:10 Average:114.30 Median:116.00 stddev:3.33 (2.9%) stddev-sans-first:3.39 16:08:43 INFO - PID 27880 | Values: 117.0 111.0 111.0 120.0 116.0 116.0 113.0 110.0 112.0 117.0 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:171.50 stddev:4.04 (2.4%) stddev-sans-first:4.27 16:08:43 INFO - PID 27880 | Values: 172.0 168.0 170.0 172.0 168.0 171.0 181.0 167.0 172.0 168.0 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:64.00 stddev:2.04 (3.2%) stddev-sans-first:2.15 16:08:43 INFO - PID 27880 | Values: 64.0 64.0 63.0 65.0 64.0 68.0 69.0 64.0 63.0 64.0 16:08:43 INFO - PID 27880 | -------- Summary: end -------- 16:08:43 INFO - PID 27880 | 16:08:43 INFO - PID 27880 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:08:43 INFO - TEST-INFO | 27880: exit 0 16:08:43 INFO - TEST-OK | kraken | took 61389ms 16:08:43 INFO - SUITE-END | took 1171s 16:08:44 INFO - Completed test suite (00:19:31) 16:08:44 INFO - javascript benchmark 16:08:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8420.175081143934, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.671279515651, 3144.261098641818, 3150.9054728358155, 3158.478850989585, 3166.4300425923325, 6129.908051379233, 6135.110408990694, 6241.781537646183, 6271.498280137589, 6351.745930162788, 6222.688865556726, 6308.873822523558, 6351.9682401587925, 6409.967950160254, 6419.358064193579, 1239.0900148404235, 5478.972605136969, 5805.274340707411, 5863.1205319202145, 5909.290885093773, 5665.801696940587, 5751.338596061465, 5754.223179870727, 5781.306243250816, 5854.09261564456, 5702.942970570282, 5824.0, 5842.591018628719, 5854.531637469035, 5859.648421094706, 5773.884522309572, 5786.450287222707, 5873.706314684248, 5874.530037596982, 5888.234529511136, 5665.291838520185, 5758.280214973129, 5770.913436298459, 5833.212516310286, 5844.386339434383, 6215.937840621581, 6280.497560195174, 6304.747810087591, 6312.936870631281, 6363.7772677956045, 6753.122094127781, 6755.966220168917, 6831.69257383419, 6835.863282734367, 6848.7260509579555, 6738.35985581369, 6812.863742725167, 6818.624975626339, 6864.897026544606, 6892.069570607954, 6309.179806625109, 6327.209098862642, 6328.272248691414, 6331.33520980295, 6382.776602818925, 7014.789556313319, 7019.964900175466, 7095.0, 7099.112610923635, 7124.145102587722, 6447.548671592944, 6578.868422631521, 6644.202695676453, 6663.5002374821115, 6757.290484499155, 6712.899306510406, 6724.260331363546, 6729.192496900403, 6738.629375384303, 6740.056392105109, 6664.1336626239245, 6667.899981500184, 6667.933320666828, 6672.399484046362, 6780.084688567079, 6756.324367563303, 6774.83062923421, 6793.966030169818, 6835.897461538081, 6864.519483636197, 5244.659097158673, 5337.19942008694, 5386.946130538645, 5414.729263536808, 5418.078926582491, 4595.4025976622825, 4646.767661616906, 4702.36518070063, 4740.597049250852, 4745.95254047462, 5778.6532808030815, 5794.21778059965, 5852.912206316909, 5876.9118463223085, 5887.322957859816, 6656.900146497806, 6746.730130794811, 6756.425703815133, 6788.49086318528, 6789.321067893171, 5730.541556675456, 5752.13717942312, 5753.223314852525, 5754.74103665336, 5754.827355179351, 5796.565257605696, 5887.322957859901, 5892.6759028253, 5906.468417842415, 5912.113183022495, 6551.050097735897, 6568.277489476154, 6613.2394774601535, 6652.634105124264, 6655.600663960081, 6725.730970761115, 6773.0, 6779.389854913082, 6781.593104413751, 6887.20797108339, 6540.444062254572, 6561.179852518435, 6585.440237579668, 6627.105340778933, 6643.202815662152, 6674.16572928384, 6682.231543372574, 6772.93227067723, 6784.05023296729, 6785.1518560179975, 6792.626405547545, 6804.183497980274, 6866.553674011173, 6891.104156459628, 6909.205441374306, 6396.456301214449, 6494.577852439576, 6562.868742625216, 6648.401643852077, 6656.467482601477, 5784.913226301693, 6567.802965911031, 6576.243731970884, 6606.10817539626, 6616.172978377703, 6491.156149700509, 6497.02544618311, 6503.772367967098, 6567.44176744982, 6592.43964263043, 6544.509161812788, 6589.604623722592, 6660.333966603301, 6686.632235226914, 6688.431483323972, 6239.688015599293, 6347.841303967438, 6354.0, 6409.2949775525585, 6494.383033611799], "value": 6128.979141017324, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.374422927034, 865.645085514939, 868.4832524647833, 868.7871471489486, 875.2472873328936, 38625.61374386255, 42320.576794232045, 42406.787966060205, 42493.7875310623, 42570.57429425709, 37494.0, 37723.245535089285, 37807.243855122884, 37848.24303513928, 37897.431538526944, 7082.433405327562, 7791.766247012599, 7972.641231144584, 7984.760457186265, 7985.441019128663, 7855.567943763091, 7929.484583502082, 7962.203779622049, 7967.123616402191, 7967.482113662622, 7926.8810967835525, 7939.087004994413, 7960.164182760814, 7997.840043199132, 8001.519908805491, 7902.565358905258, 7938.24586664266, 7950.443468957175, 7955.164707705723, 7958.045034595885, 7867.763967080997, 7920.960395198044, 7922.683092676286, 7935.9206407936335, 7956.5226086435, 37958.62041379578, 38149.427758583646, 38149.80925095385, 38173.80913095417, 38245.42631860524, 3588.5334906462253, 3633.727470439701, 3636.054625797312, 3638.945415818765, 3640.799756013418, 31267.06198814039, 31330.843345783127, 31400.37199256002, 31439.52840707391, 31491.212719681964, 5082.3138876251605, 5217.58259339252, 5218.895622087575, 5254.238135470374, 5280.287161233223, 181828.0, 182582.0, 183202.0, 183229.0, 183527.0, 41859.581404186174, 42774.78612606917, 48259.276110858365, 48458.0, 48526.0, 51479.22781158286, 51515.0, 51584.74207629013, 51585.0, 51587.22619160716, 15568.377264909277, 15705.450309239122, 15709.842901571066, 15721.68556628861, 15734.842651573566, 12709.237445753099, 12722.491100355883, 12733.490660373482, 12734.490620375082, 12836.935815320863, 13994.230317332442, 14011.71976560463, 14017.229052402012, 14149.0, 14223.573292801233, 5702.7718891243885, 5745.0, 5856.765729370863, 5859.0, 5967.79112731061, 1010.3281317923645, 1019.37308555238, 1031.747221930632, 1036.7563622548696, 1039.9896001040045, 22465.32604021882, 22759.0, 22797.88601057017, 23069.19257825968, 23403.53192936166, 1118.4463690473267, 1119.339589642115, 1120.1263014848432, 1138.5445821671399, 1141.4064686363045, 11938.0, 12238.81641775374, 12247.755044899051, 12277.20198187115, 12344.62966111018, 225731.0, 226659.0, 227014.0, 227329.0, 227620.0, 52781.7360913193, 52803.20795188075, 52910.0, 53092.46907530953, 53160.73419632877, 1459.7883306920437, 1461.729580027677, 1464.9707005859823, 1467.486379767073, 1468.530070377469, 22295.331140065824, 22412.551748965256, 22655.320340389815, 22859.77140228643, 23118.76881231166, 36681.0, 36801.81599091987, 36859.07852303714, 36868.26263474662, 36914.8154259227, 193419.0, 193609.0, 193949.0, 194565.0, 195154.0, 30413.84793076109, 31166.688333117287, 33254.0, 33380.0, 33513.664863351056, 42897.35653965131, 42996.78501607472, 43135.784321078194, 43202.567974321115, 43500.0, 31758.36483270368, 31770.841145794122, 31948.52077218797, 32109.678903210668, 32627.34745305033, 31323.0, 31348.059558213292, 31721.20696982594, 31808.68191318057, 32656.183595409355, 35557.64442355543, 35736.28527429385, 35963.0, 36087.819560902026, 36124.638753612126, 30206.395872081997, 30237.0, 30403.695963040085, 30903.69096309098, 31335.84332078325, 23146.76853231446, 23169.652455213523, 23311.533769324178, 23817.880910596028, 23964.88017559901], "value": 17070.74263271758, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.8834744703614, 557.9358373787014, 558.6620094842617, 566.9149627555867, 578.6123297390749, 21951.0, 22784.430389240235, 22787.31638050861, 22813.771862281374, 22821.31536053919, 23967.842894139525, 24254.151104711338, 24592.87703561484, 24629.50740985179, 24687.382815429624, 6362.1093046973465, 6620.6358650274215, 6624.56940298879, 6630.668466576676, 6634.402903738663, 6307.369263073701, 6610.834729131762, 6713.2951040140815, 6718.126643536358, 6720.294369091248, 6597.373249541286, 6601.867962640745, 6629.535932484728, 6632.204135503746, 6632.469402447817, 6324.525660575429, 6612.669366531678, 6613.140291762088, 6624.503162262801, 6625.60246385216, 6113.0, 6114.908276375858, 6134.0, 6141.170941922828, 6144.754209831646, 29313.120606381843, 29738.107856764116, 30045.248868778235, 30064.398712025635, 30104.698953010407, 2052.1688716070016, 2074.802893725109, 2077.366403247009, 2083.073032500538, 2084.6351888419467, 19392.80607193924, 19573.80426195734, 19889.60220795576, 20221.595568088556, 20262.0, 2441.4994926040117, 2445.4131008557997, 2489.8630575318352, 2495.1017633652054, 2497.2882728422314, 123267.383663082, 130226.348868256, 137163.0, 141978.29010854982, 143296.2835185828, 14130.434782608787, 14367.712645747026, 14577.125372477685, 14587.863802913302, 14677.368602438582, 22419.439514011952, 22479.438014049778, 22497.100115995177, 22497.662535061987, 22554.436139096324, 9623.374480658735, 9890.258230632731, 9957.701268961942, 10115.342502737298, 10179.18566514677, 9221.95389023064, 9308.534573271445, 9311.953440232755, 9341.486218257925, 9368.814603035002, 8869.379143460024, 8904.465732056098, 9012.504312262758, 9157.084291570924, 9259.583318750672, 2620.5414052540727, 2646.6691663542056, 2757.9724202757716, 2816.1554182010814, 2846.316883947879, 953.77109493721, 961.3654987708219, 971.9368241064308, 973.3186769261404, 986.3736527305213, 19379.709304360447, 19408.80591194098, 19641.31255406054, 19710.802891971183, 19781.60436791256, 998.2164001258977, 1029.2126523209752, 1036.362636978253, 1040.47976011994, 1043.1811028342715, 10655.725415919169, 10854.565817367375, 11033.393163376091, 11147.777044459228, 11217.775644487065, 421959.0, 428601.0, 428998.0, 434923.0, 437450.0, 102667.0, 102891.0, 106284.46857765662, 107009.4649526763, 109453.45273273582, 1046.424466543398, 1090.373035504588, 1134.7957367673898, 1158.9304641721524, 1213.9210951288314, 20576.176952921716, 20701.58596828085, 20867.269645562334, 21092.578148436638, 21172.364829055154, 54191.72904135454, 54628.453715463926, 54879.0, 54904.72547637236, 55010.0, 67696.0, 67983.0, 68168.0, 68310.65844670944, 68601.0, 14149.36327865228, 14264.928675356558, 14363.0, 14440.277986100864, 14540.127592344494, 22286.554268914206, 22399.664005039613, 22519.211827585958, 22624.434389140402, 23005.309840704806, 16364.181790910645, 16498.917505412875, 16587.502374928772, 16675.416360427327, 18347.08264586792, 14791.778123327944, 15267.618309542351, 15527.146006969726, 15648.217589120271, 16065.0, 17155.571110722332, 17368.39210627622, 17526.298948042444, 17549.912250438665, 17555.82444175542, 13350.465981361025, 13361.53234636783, 13370.598882033555, 13434.126781759154, 13468.865311347154, 16293.348266069224, 16358.34566617322, 16430.0, 16498.092604906844, 16538.834611654212], "value": 11727.089872659593, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.1714895339367, 1407.5917983784702, 1407.859214078592, 1414.8726614604684, 1419.2194293138778, 14897.627559311022, 15612.531624051282, 15612.687746245068, 15612.843871561281, 15623.21883905803, 15239.085654860688, 15309.387624495006, 15347.462838800644, 15373.077615343087, 15380.923095384536, 2595.974040259592, 2713.592961055838, 2715.891364345424, 2727.7135900730436, 2728.931776705588, 2626.4090579619624, 2678.504476671822, 2704.5267078261227, 2705.3236690827293, 2706.8375897446117, 2696.137236084454, 2725.713800050996, 2731.549294366437, 2735.685396179445, 2739.013954976207, 2553.9911734864622, 2616.8037397195285, 2638.300850274679, 2647.7352264773367, 2650.1651979626454, 2578.8065895057944, 2604.882780274892, 2607.282997175773, 2609.3998380372623, 2610.5040042392075, 15230.543083707507, 15409.691806163926, 15413.306401211972, 15422.922885385502, 15426.228688565527, 7609.6956121755065, 7894.80262993424, 7902.0, 7905.051393832719, 7909.485883417559, 5207.739613019372, 5255.343082114736, 5360.061989151883, 5414.485623865727, 5414.891702165974, 1763.1536862306036, 1779.3950056980689, 1796.97304540432, 1813.9909300453546, 1834.0462959261242, 26272.0, 26410.0, 26467.73532264672, 26497.60253596178, 26568.734312657012, 6360.872782544323, 6393.936060639334, 6416.550841441054, 6671.566348187353, 6699.229588597276, 17306.307747689953, 17356.305747769948, 17360.13199340028, 17404.129793510274, 17423.303067877398, 7677.193894641094, 7680.039995000625, 7690.923090769133, 7693.115291741409, 7693.538387696756, 7148.92851071493, 7181.533200341961, 7200.603966781878, 7201.92798072023, 7246.202917679051, 5008.6744361616375, 5096.51583099605, 5106.285120083191, 5138.845834624967, 5290.391604965402, 1407.9507217247346, 1411.9576412707636, 1427.5075099090798, 1432.4699861051477, 1436.7485690004207, 924.2098006204599, 926.9397489163183, 928.9303302252358, 940.1444685336311, 941.0589410589411, 7863.764087077397, 7891.644875980594, 7926.0, 7934.087579928267, 8083.555404452694, 688.6625553478759, 700.1912790726719, 702.6240961085795, 713.6110819603329, 753.8153152477678, 4703.0593881223895, 4822.324874517571, 5279.52484276417, 5326.094563924142, 5362.785488580491, 21478.570428591654, 21920.561588768134, 22510.212142574932, 22514.099436022705, 22543.549129017654, 19230.903845480963, 21430.57138857214, 21813.78186218149, 21949.122035118417, 22144.446388840086, 10884.891151088546, 11214.215004949576, 11251.943740281245, 11253.437328133725, 11273.54905803775, 8545.401821872658, 8712.303015758598, 8786.209241168326, 9223.308251881002, 9286.767830804014, 18718.344857929907, 18734.34429795005, 18783.812161878206, 19022.334218302294, 19065.0, 17938.19278132461, 19064.618707625494, 19318.227270909007, 19659.311924082587, 19666.410007699793, 12092.818607721067, 12225.877741222474, 12256.87743122593, 12277.631671049883, 12290.877091228973, 13591.86408135906, 13713.931430342784, 13716.519921803088, 13719.725605488034, 13729.931350343184, 10726.678199654023, 10780.191485638452, 10833.133349332193, 10882.45587720595, 11076.833847492133, 10740.892591073989, 10774.084202842847, 10828.675139745821, 10976.0, 11124.777504450027, 9869.457179855177, 9985.301028928196, 9985.750356241153, 10007.749806254902, 10022.849657255001, 7058.0, 7186.568805871664, 7235.312645298688, 7258.528195667264, 7263.164736055422, 7105.502614816914, 7187.389071928945, 7207.387372073433, 7262.74580389705, 7273.0], "value": 6584.346344442491, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.078868257317, 502.2040066494605, 519.8986197691447, 523.4111624422525, 525.7712894890723, 6227.508996401441, 6268.4671802896755, 6343.904841427371, 6365.140706004694, 6435.967820160899, 6222.222222222223, 6223.315435302113, 6270.749170033205, 6309.4321511064, 6310.526710496708, 5226.660267082637, 5246.501582349671, 5289.100852855024, 5314.202869569576, 5353.518183363496, 4953.752312384367, 5117.385913690362, 5271.736413179345, 5302.072137375963, 5310.6017048721305, 5071.366079240095, 5083.339165908426, 5100.234964755279, 5109.182530795074, 5109.923351149736, 5022.372203474548, 5035.546800787946, 5053.317802096743, 5068.974655126719, 5075.314832497603, 4520.0, 4548.408706868086, 4560.771961401917, 4569.2689169732685, 4573.428321459817, 6290.710404367093, 6327.715252813588, 6349.1428657131155, 6363.109164716943, 6364.745410183587, 5798.449147330997, 5803.709814509258, 5809.331926828384, 5835.124731290341, 5854.0, 6697.129373181504, 6720.697568609425, 6737.461003119739, 6750.0, 6774.627395493246, 4932.618866717325, 4972.254161875748, 4973.52751488608, 4977.850664480072, 4990.30135780991, 7069.8939515907305, 7079.079719636415, 7105.5026148169645, 7120.145582530129, 7129.429645628337, 5002.499750024968, 5038.395392552917, 5076.847694569169, 5094.363204599425, 5097.796088156432, 5102.311187989574, 5103.770330335144, 5144.408393034774, 5164.0, 5165.896682066413, 5768.653880767168, 5776.480116789509, 5830.970845145832, 5831.62094463867, 5838.38696936824, 6713.630750308682, 6748.628825414551, 6753.45972322213, 6779.389854912983, 6838.829029274308, 1663.5508412728495, 1668.5244705258942, 1713.9716170297722, 1750.492357216393, 1772.59230377014, 1189.649053529211, 1198.1133960868895, 1227.1410012990764, 1229.6864299603544, 1233.8827811357908, 5643.633163844419, 5680.573956953245, 5695.943040569541, 5795.82612521625, 5803.984302747087, 6557.5081868860025, 6682.699278532477, 6706.295838936841, 6711.697973591103, 6845.931540684629, 5666.575006874501, 5742.54059675225, 5791.82624521265, 5797.913031304533, 5860.208871802252, 3610.765300255475, 3627.2564124354444, 3660.7803531788177, 3671.9082022949106, 3679.0, 6563.573367731177, 6634.336566343423, 6638.419490551504, 6667.533272670964, 6667.733290668416, 6950.721971121199, 6975.930240697629, 6994.93005069953, 7020.859582808315, 7023.438124949992, 6523.706433210422, 6537.215534135934, 6561.245456772533, 6603.867922641521, 6633.3035031321015, 6674.666266686743, 6807.974942176111, 6829.2487826338065, 6896.5172637785845, 6908.647552042382, 6808.897866531907, 6881.65591720422, 6897.965510172417, 6910.203347129883, 6918.688659010458, 6435.549511534147, 6450.741970321134, 6538.574992625464, 6551.672416379257, 6578.80263592093, 4951.876203094807, 4967.60259179272, 5010.69935803853, 5011.824586139468, 5019.623528235324, 6545.410913017851, 6737.966310168418, 6742.190937087581, 6764.695588698422, 6774.96612516954, 6223.906641400473, 6567.540272180901, 6591.604503729792, 6602.491053399677, 6634.336566343327, 6508.153939987771, 6532.0, 6554.377334153248, 6584.50616203777, 6615.338466153346, 6225.252969643671, 6418.229812422539, 6529.575577587441, 6588.242352129375, 6594.175728033996, 6553.344665533408, 6584.275729669636, 6616.378987147987, 6621.470282377494, 6779.220389655055, 6413.839654008687, 6414.871702565829, 6429.260635026844, 6482.092507049111, 6514.719848053143], "value": 5129.7764186642235, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [893.7095443980708, 918.1231923513044, 927.2303987690218, 936.3679516326478, 955.4697143085587, 16653.583660408494, 17126.571835704115, 17148.399806006793, 17158.571035724082, 17159.22783474742, 18477.907610461927, 18715.53211169718, 18826.529336766587, 18880.622387552274, 18921.0, 942.1144124522943, 957.459035644862, 960.4573416019962, 961.8412961861285, 962.2686758063852, 959.592173326337, 980.882294124706, 980.9901900981006, 983.4492684096892, 987.3976874106789, 1037.5849660135968, 1039.397149653203, 1040.432964034599, 1040.5889673578931, 1047.1518070362993, 1035.8394448860438, 1037.2065369991963, 1038.4496217004998, 1041.807265655856, 1052.610534102383, 714.6569646569624, 715.1596873673413, 733.4719002318323, 733.9376153026999, 733.9889901651479, 18021.909890450464, 18044.368447104418, 18058.277668893228, 18075.54811129719, 18079.548011299692, 20917.686234706493, 21322.680159797615, 21458.892705536528, 21814.563708725895, 21865.12539498418, 16893.40873069449, 17176.742348864776, 17314.740278895828, 17333.7399939001, 17448.738268925976, 3821.0829400943853, 3838.9826695925603, 3843.0392401899526, 3844.231153769257, 3847.615238476158, 130169.0, 131243.0, 132860.0, 133188.0, 136841.31579342138, 16171.919140404458, 16212.0, 16282.185890705417, 16471.094089824936, 16792.412265570892, 30798.0, 31090.22274443157, 31329.216769580486, 31334.0, 31344.21639458986, 8004.399670024772, 8068.556229407322, 8129.227723366271, 8135.1051384347675, 8145.959270203611, 3986.681065514752, 4071.6539094176733, 4082.387641853686, 4085.1216988347646, 4091.4476545665952, 5162.3030890830005, 5175.741212939338, 5178.223266509978, 5207.2449494823795, 5243.9213411798855, 911.1981456318398, 919.6137622198693, 944.7921457279525, 945.8770359853175, 946.0208684012152, 653.2422390027546, 682.6109117802904, 685.9451243900476, 687.621808005595, 695.1553862057624, 10922.672319830417, 11527.827082593767, 11896.762064758655, 12026.4588093536, 12515.311657858905, 684.5276759036249, 689.941354984832, 693.5041445366486, 708.125465050662, 711.7402148215967, 4953.876153096129, 4978.850634480971, 5014.07239660664, 5024.648274620741, 5079.9840031993745, 127405.0, 129165.35417323041, 129819.35090324677, 130904.345478272, 134988.3250583741, 108905.0, 110817.0, 110889.44555277172, 112789.0, 117419.0, 95251.52374238223, 96708.51645741727, 97665.0, 98822.50588747155, 100423.49788251158, 9232.122948319899, 9324.300677449082, 9337.579808908751, 9430.528473576156, 9578.952105239428, 39774.60225397709, 41158.1768364625, 41572.79213603913, 41573.58426415697, 43350.13299733924, 56250.718746406004, 58422.83154336805, 59287.0, 59355.10967335407, 60124.39875601188, 14295.499657511937, 14418.783718244025, 14482.0, 14649.340779664728, 14651.706965860836, 15976.121313327878, 16179.676406472041, 16218.351265949701, 16358.672826543165, 16379.508614741577, 13268.469261229442, 13465.0, 13522.12106213093, 13561.321933903462, 13564.72870542564, 13559.728805424034, 13701.520446784314, 13740.381682824096, 13898.444062237397, 13900.37448314808, 13370.197788132744, 13381.39783709716, 13616.455341786217, 13633.0, 13669.043166978216, 11384.203105782515, 11408.790935126386, 11560.248583842023, 11583.42082895835, 11665.766684666429, 11333.093352531612, 11346.659600212008, 11504.079673626256, 11582.247153934968, 11596.94201528987], "value": 8599.23527543098, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1425.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 107.0, 107.0, 108.0, 112.0, 109.0, 111.0, 109.0, 113.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 115.0, 114.0, 116.0, 115.0, 145.0, 120.0, 119.0, 120.0, 146.0], "value": 123.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 162.0, 161.0, 161.0, 163.0, 167.0, 176.0, 165.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 73.0, 73.0, 74.0, 73.0, 74.0, 74.0, 74.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 79.0, 79.0, 79.0, 135.0, 79.0, 86.0, 78.0], "value": 85.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 115.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 153.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 94.0, 93.0, 94.0, 93.0, 94.0, 93.0, 93.0], "value": 93.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 52.0, 50.0, 51.0, 50.0, 51.0, 54.0, 52.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 37.0, 37.0, 38.0, 38.0, 38.0, 38.0, 39.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 75.0, 74.0, 74.0, 84.0, 75.0, 79.0, 74.0, 75.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 111.0, 120.0, 116.0, 116.0, 113.0, 110.0, 112.0, 117.0], "value": 114.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 170.0, 172.0, 168.0, 171.0, 181.0, 167.0, 172.0, 168.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 65.0, 64.0, 68.0, 69.0, 64.0, 63.0, 64.0], "value": 64.8, "unit": "score"}]}]} 16:08:44 INFO - Return code: 0 16:08:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:08:44 INFO - # TBPL SUCCESS # 16:08:44 INFO - Running post-action listener: _package_coverage_data 16:08:44 INFO - Running post-action listener: _resource_record_post_action 16:08:44 INFO - [mozharness: 2017-09-13 23:08:44.499636Z] Finished run-tests step (success) 16:08:44 INFO - Running post-run listener: _resource_record_post_run 16:08:44 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 340623360; Read time: 28; Write time: 282068 16:08:44 INFO - TinderboxPrint: CPU usage
13.1% 16:08:44 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 16:08:44 INFO - TinderboxPrint: I/O write bytes / time
340,623,360 / 282,068 16:08:44 INFO - TinderboxPrint: CPU idle
8,243.1 (86.9%) 16:08:44 INFO - TinderboxPrint: CPU user
1,193.8 (12.6%) 16:08:44 INFO - TinderboxPrint: Swap in / out
0 / 0 16:08:44 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10039296; Read time: 0; Write time: 1680 16:08:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:08:44 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 330584064; Read time: 16; Write time: 280388 16:08:45 INFO - Running post-run listener: _upload_blobber_files 16:08:45 INFO - Blob upload gear active. 16:08:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:08:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:08:45 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'] 16:08:45 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 16:08:45 INFO - (blobuploader) - INFO - Open directory for files ... 16:08:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:08:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:08:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:46 INFO - (blobuploader) - INFO - Done attempting. 16:08:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:08:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:08:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:47 INFO - (blobuploader) - INFO - Done attempting. 16:08:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:08:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:08:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:54 INFO - (blobuploader) - INFO - Done attempting. 16:08:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:08:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:08:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:55 INFO - (blobuploader) - INFO - Done attempting. 16:08:55 INFO - (blobuploader) - INFO - Iteration through files over. 16:08:55 INFO - Return code: 0 16:08:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:08:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:08:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9516f3d808f87c4e87cac4f6d7874f6a5ed99e8826fc2fba1c504689ddd21757a6ef5d8af2ade18d193ccd521ac7dd48a6ff567cbbc6fd259f25e2f766a5d47e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ca7480e6675c9b6ff848921ff0cc5839202d1e3413a146c0a787e5735caf722d125262cb25df5a28533dacdf7da86d75186f72bf0b479148e72091cc9bf43ff", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/675cb89a70afb383a6cba4dacf6027b67fb243518545f1484f853fadd239d76ae028aece10f693ff7589395e359dd6a446f60e701451271bdb40d207a1b395c8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e9d50ae37bda2fc6085e6feb76b000915cbb4b5a2f663723f54369dd6f8937a7c793963afa87377a831f7482faa46d23c1a561ddd1546aec2ff166c4ebb1929"} 16:08:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:08:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:08:55 INFO - Contents: 16:08:55 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9516f3d808f87c4e87cac4f6d7874f6a5ed99e8826fc2fba1c504689ddd21757a6ef5d8af2ade18d193ccd521ac7dd48a6ff567cbbc6fd259f25e2f766a5d47e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ca7480e6675c9b6ff848921ff0cc5839202d1e3413a146c0a787e5735caf722d125262cb25df5a28533dacdf7da86d75186f72bf0b479148e72091cc9bf43ff", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/675cb89a70afb383a6cba4dacf6027b67fb243518545f1484f853fadd239d76ae028aece10f693ff7589395e359dd6a446f60e701451271bdb40d207a1b395c8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e9d50ae37bda2fc6085e6feb76b000915cbb4b5a2f663723f54369dd6f8937a7c793963afa87377a831f7482faa46d23c1a561ddd1546aec2ff166c4ebb1929"} 16:08:55 INFO - Running post-run listener: copy_logs_to_upload_dir 16:08:55 INFO - Copying logs to upload dir... 16:08:55 INFO - mkdir: /builds/slave/test/build/upload/logs 16:08:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.799542 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-13 16:08:55.509370) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 16:08:55.525522) ========= 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=1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104 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/9516f3d808f87c4e87cac4f6d7874f6a5ed99e8826fc2fba1c504689ddd21757a6ef5d8af2ade18d193ccd521ac7dd48a6ff567cbbc6fd259f25e2f766a5d47e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ca7480e6675c9b6ff848921ff0cc5839202d1e3413a146c0a787e5735caf722d125262cb25df5a28533dacdf7da86d75186f72bf0b479148e72091cc9bf43ff", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/675cb89a70afb383a6cba4dacf6027b67fb243518545f1484f853fadd239d76ae028aece10f693ff7589395e359dd6a446f60e701451271bdb40d207a1b395c8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e9d50ae37bda2fc6085e6feb76b000915cbb4b5a2f663723f54369dd6f8937a7c793963afa87377a831f7482faa46d23c1a561ddd1546aec2ff166c4ebb1929"} build_url:https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/JQ2c2hz0RGOZPHj6Jy9JKA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9516f3d808f87c4e87cac4f6d7874f6a5ed99e8826fc2fba1c504689ddd21757a6ef5d8af2ade18d193ccd521ac7dd48a6ff567cbbc6fd259f25e2f766a5d47e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ca7480e6675c9b6ff848921ff0cc5839202d1e3413a146c0a787e5735caf722d125262cb25df5a28533dacdf7da86d75186f72bf0b479148e72091cc9bf43ff", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/675cb89a70afb383a6cba4dacf6027b67fb243518545f1484f853fadd239d76ae028aece10f693ff7589395e359dd6a446f60e701451271bdb40d207a1b395c8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e9d50ae37bda2fc6085e6feb76b000915cbb4b5a2f663723f54369dd6f8937a7c793963afa87377a831f7482faa46d23c1a561ddd1546aec2ff166c4ebb1929"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 16:08:55.557237) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 16:08:55.557604) ========= 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=1258088b6da462a47ba2cd90000001a2-1505342894.1653-383819104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 16:08:55.639701) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 16:08:55.640060) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 16:08:55.640483) ========= ========= Total master_lag: 0.20 =========