builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-052 starttime: 1506510564.92 results: success (0) revision: 5563e7da39b265ed1ba7796ec058bdbcf6f792f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 04:09:24.917859) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 04:09:24.922288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 04:09:24.922641) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 04:09:24.980865) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:09:24.981194) ========= 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=826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 04:09:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 85.4M=0s 2017-09-27 04:09:25 (85.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122458 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:09:25.125283) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:09:25.125597) ========= 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=826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019283 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:09:25.183951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:09:25.184274) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5563e7da39b265ed1ba7796ec058bdbcf6f792f6 --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 5563e7da39b265ed1ba7796ec058bdbcf6f792f6 --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=826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 04:09:25,252 truncating revision to first 12 chars 2017-09-27 04:09:25,252 Setting DEBUG logging. 2017-09-27 04:09:25,252 attempt 1/10 2017-09-27 04:09:25,252 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5563e7da39b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 04:09:25,758 unpacking tar archive at: mozilla-central-5563e7da39b2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.921711 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:09:26.142751) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 04:09:26.145834) ========= script_repo_revision: 5563e7da39b265ed1ba7796ec058bdbcf6f792f6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 04:09:26.146275) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 04:09:26.146537) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 04:09:26.168270) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-27 04:09:26.168600) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:09:26 INFO - MultiFileLogger online at 20170927 04:09:26 in /builds/slave/test 04:09:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:09:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:09:26 INFO - {'append_to_log': False, 04:09:26 INFO - 'base_work_dir': '/builds/slave/test', 04:09:26 INFO - 'blob_upload_branch': 'Firefox', 04:09:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:09:26 INFO - 'branch': 'Firefox', 04:09:26 INFO - 'buildbot_json_path': 'buildprops.json', 04:09:26 INFO - 'code_coverage': False, 04:09:26 INFO - 'config_files': ('talos/linux_config.py',), 04:09:26 INFO - 'default_actions': ('clobber', 04:09:26 INFO - 'read-buildbot-config', 04:09:26 INFO - 'download-and-extract', 04:09:26 INFO - 'populate-webroot', 04:09:26 INFO - 'create-virtualenv', 04:09:26 INFO - 'install', 04:09:26 INFO - 'setup-mitmproxy', 04:09:26 INFO - 'run-tests'), 04:09:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:09:26 INFO - 'disable_ccov_upload': False, 04:09:26 INFO - 'disable_stylo': False, 04:09:26 INFO - 'download_minidump_stackwalk': True, 04:09:26 INFO - 'download_symbols': 'ondemand', 04:09:26 INFO - 'enable_stylo': False, 04:09:26 INFO - 'enable_webrender': False, 04:09:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:09:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:09:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:09:26 INFO - 'gecko_profile': False, 04:09:26 INFO - 'gecko_profile_interval': 0, 04:09:26 INFO - 'installer_path': 'installer.exe', 04:09:26 INFO - 'log_level': 'info', 04:09:26 INFO - 'log_name': 'talos', 04:09:26 INFO - 'log_to_console': True, 04:09:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:09:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:09:26 INFO - 'opt_config_files': (), 04:09:26 INFO - 'pip_index': False, 04:09:26 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 04:09:26 INFO - 'system_bits': '32', 04:09:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:09:26 INFO - 'title': 'talos-linux64-ix-052', 04:09:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:09:26 INFO - 'use_talos_json': True, 04:09:26 INFO - 'verify': 'False', 04:09:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:09:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:09:26 INFO - 'work_dir': 'build'} 04:09:26 INFO - [mozharness: 2017-09-27 11:09:26.369122Z] Running clobber step. 04:09:26 INFO - Running pre-action listener: _resource_record_pre_action 04:09:26 INFO - Running main action method: clobber 04:09:26 INFO - rmtree: /builds/slave/test/build 04:09:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:09:27 INFO - Running post-action listener: _resource_record_post_action 04:09:27 INFO - [mozharness: 2017-09-27 11:09:27.880618Z] Finished clobber step (success) 04:09:27 INFO - [mozharness: 2017-09-27 11:09:27.880715Z] Running read-buildbot-config step. 04:09:27 INFO - Running pre-action listener: _resource_record_pre_action 04:09:27 INFO - Running main action method: read_buildbot_config 04:09:27 INFO - Using buildbot properties: 04:09:27 INFO - { 04:09:27 INFO - "project": "", 04:09:27 INFO - "product": "firefox", 04:09:27 INFO - "who": "archaeopteryx@coole-files.de", 04:09:27 INFO - "installer_path": "public/build/target.tar.bz2", 04:09:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 04:09:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:09:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 04:09:27 INFO - "stage_platform": "linux64-pgo", 04:09:27 INFO - "basedir": "/builds/slave/test", 04:09:27 INFO - "buildnumber": 65, 04:09:27 INFO - "platform": "ubuntu64_hw", 04:09:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:09:27 INFO - "slavebuilddir": "test", 04:09:27 INFO - "taskId": "YKhrIc_mStOfIcbmZVLvmg", 04:09:27 INFO - "branch": "mozilla-central", 04:09:27 INFO - "script_repo_revision": "production", 04:09:27 INFO - "revision": "5563e7da39b265ed1ba7796ec058bdbcf6f792f6", 04:09:27 INFO - "slavename": "talos-linux64-ix-052", 04:09:27 INFO - "repo_path": "mozilla-central" 04:09:27 INFO - } 04:09:27 INFO - Finding installer, test and symbols from parent task. 04:09:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YKhrIc_mStOfIcbmZVLvmg'}, attempt #1 04:09:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YKhrIc_mStOfIcbmZVLvmg'}, attempt #1 04:09:28 INFO - Task dependencies: Ar8OP6SQTLyEO3BLSuuQ1Q 04:09:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q'}, attempt #1 04:09:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.tar.bz2 04:09:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.test_packages.json 04:09:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.crashreporter-symbols.zip 04:09:29 INFO - Running post-action listener: _resource_record_post_action 04:09:29 INFO - [mozharness: 2017-09-27 11:09:29.302343Z] Finished read-buildbot-config step (success) 04:09:29 INFO - [mozharness: 2017-09-27 11:09:29.302561Z] Running download-and-extract step. 04:09:29 INFO - Running pre-action listener: _resource_record_pre_action 04:09:29 INFO - Running main action method: download_and_extract 04:09:29 INFO - mkdir: /builds/slave/test/build/tests 04:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:29 INFO - trying https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.test_packages.json 04:09:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:09:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:09:29 INFO - Downloaded 989 bytes. 04:09:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:09:29 INFO - Using the following test package requirements: 04:09:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:09:29 INFO - u'common': [u'target.common.tests.zip'], 04:09:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:09:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:09:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:09:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:09:29 INFO - u'mozbase': [u'target.common.tests.zip'], 04:09:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:09:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:09:29 INFO - u'web-platform': [u'target.common.tests.zip', 04:09:29 INFO - u'target.web-platform.tests.tar.gz'], 04:09:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:09:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:09:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.common.tests.zip 04:09:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:09:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.common.tests.zip into memory 04:09:31 INFO - Content-Length response header: 55348607 04:09:31 INFO - Bytes received: 55348607 04:09:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.talos.tests.zip 04:09:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:09:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.talos.tests.zip into memory 04:09:44 INFO - Content-Length response header: 14513823 04:09:44 INFO - Bytes received: 14513823 04:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:44 INFO - trying https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.tar.bz2 04:09:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:09:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:09:47 INFO - Downloaded 62405265 bytes. 04:09:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.tar.bz2 04:09:47 INFO - mkdir: /builds/slave/test/properties 04:09:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:09:47 INFO - Writing to file /builds/slave/test/properties/build_url 04:09:47 INFO - Contents: 04:09:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.tar.bz2 04:09:47 INFO - Running post-action listener: _resource_record_post_action 04:09:47 INFO - Running post-action listener: find_tests_for_verification 04:09:47 INFO - Running post-action listener: set_extra_try_arguments 04:09:47 INFO - [mozharness: 2017-09-27 11:09:47.296681Z] Finished download-and-extract step (success) 04:09:47 INFO - [mozharness: 2017-09-27 11:09:47.296839Z] Running populate-webroot step. 04:09:47 INFO - Running pre-action listener: _resource_record_pre_action 04:09:47 INFO - Running main action method: populate_webroot 04:09:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:09:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:09:47 INFO - 'tests': ['tresize', 04:09:47 INFO - 'tcanvasmark']}, 04:09:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:09:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:09:47 INFO - 'tests': ['dromaeo_css', 04:09:47 INFO - 'kraken']}, 04:09:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:09:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:09:47 INFO - 'talos_options': ['--disable-stylo'], 04:09:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:09:47 INFO - 'tests': ['damp', 'tps']}, 04:09:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:09:47 INFO - 'talos_options': ['--disable-stylo'], 04:09:47 INFO - 'tests': ['damp', 'tps']}, 04:09:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:09:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:09:47 INFO - 'tests': ['dromaeo_dom']}, 04:09:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:09:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:09:47 INFO - 'tests': ['basic_compositor_video', 04:09:47 INFO - 'glvideo']}, 04:09:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:09:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:09:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:09:47 INFO - 'talos_options': ['--disable-stylo'], 04:09:47 INFO - 'tests': ['ts_paint_webext', 04:09:47 INFO - 'tp5o_webext']}, 04:09:47 INFO - 'other-e10s': {'tests': ['a11yr', 04:09:47 INFO - 'ts_paint', 04:09:47 INFO - 'tpaint', 04:09:47 INFO - 'sessionrestore', 04:09:47 INFO - 'sessionrestore_many_windows', 04:09:47 INFO - 'sessionrestore_no_auto_restore', 04:09:47 INFO - 'tabpaint']}, 04:09:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:09:47 INFO - 'tests': ['a11yr', 04:09:47 INFO - 'ts_paint', 04:09:47 INFO - 'tpaint', 04:09:47 INFO - 'sessionrestore', 04:09:47 INFO - 'sessionrestore_many_windows', 04:09:47 INFO - 'sessionrestore_no_auto_restore', 04:09:47 INFO - 'tabpaint']}, 04:09:47 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 04:09:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:09:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:09:47 INFO - 'tests': ['perf_reftest_singletons']}, 04:09:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:09:47 INFO - 'tests': ['perf_reftest']}, 04:09:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:09:47 INFO - 'tsvgr_opacity', 04:09:47 INFO - 'tart', 04:09:47 INFO - 'tscrollx', 04:09:47 INFO - 'tsvg_static']}, 04:09:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:09:47 INFO - 'tests': ['tsvgx', 04:09:47 INFO - 'tsvgr_opacity', 04:09:47 INFO - 'tart', 04:09:47 INFO - 'tscrollx', 04:09:47 INFO - 'tsvg_static']}, 04:09:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:09:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:09:47 INFO - 'talos_options': ['--disable-stylo'], 04:09:47 INFO - 'tests': ['tp5o']}, 04:09:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:09:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:09:47 INFO - 'talos_options': ['--mitmproxy', 04:09:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:09:47 INFO - '--firstNonBlankPaint'], 04:09:47 INFO - 'tests': ['tp6_google', 04:09:47 INFO - 'tp6_youtube', 04:09:47 INFO - 'tp6_amazon', 04:09:47 INFO - 'tp6_facebook']}, 04:09:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:09:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:09:47 INFO - 'talos_options': ['--disable-stylo', 04:09:47 INFO - '--mitmproxy', 04:09:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:09:47 INFO - '--firstNonBlankPaint'], 04:09:47 INFO - 'tests': ['tp6_google', 04:09:47 INFO - 'tp6_youtube', 04:09:47 INFO - 'tp6_amazon', 04:09:47 INFO - 'tp6_facebook']}, 04:09:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:09:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:09:47 INFO - 'talos_options': ['--stylo-threads=1', 04:09:47 INFO - '--mitmproxy', 04:09:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:09:47 INFO - '--firstNonBlankPaint'], 04:09:47 INFO - 'tests': ['tp6_google', 04:09:47 INFO - 'tp6_youtube', 04:09:47 INFO - 'tp6_amazon', 04:09:47 INFO - 'tp6_facebook']}, 04:09:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:09:47 INFO - 'talos_options': ['--xperf_path', 04:09:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:47 INFO - 'tests': ['tp5n']}, 04:09:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:09:47 INFO - 'talos_options': ['--disable-stylo', 04:09:47 INFO - '--xperf_path', 04:09:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:47 INFO - 'tests': ['tp5n']}}} 04:09:47 INFO - Running post-action listener: _resource_record_post_action 04:09:47 INFO - [mozharness: 2017-09-27 11:09:47.320039Z] Finished populate-webroot step (success) 04:09:47 INFO - [mozharness: 2017-09-27 11:09:47.320129Z] Running create-virtualenv step. 04:09:47 INFO - Running pre-action listener: _resource_record_pre_action 04:09:47 INFO - Running main action method: create_virtualenv 04:09:47 INFO - Creating virtualenv /builds/slave/test/build/venv 04:09:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:09:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:09:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:09:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:09:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:09:47 INFO - Installing distribute.............................................................................................................................................................................................done. 04:09:48 INFO - Installing pip...............done. 04:09:48 INFO - Return code: 0 04:09:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:09:48 INFO - Reading from file tmpfile_stdout 04:09:48 INFO - Output received: 04:09:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:09:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09: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')]} 04:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:48 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 0xd111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd60>, '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 0x107ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cef0>, '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': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', '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 04:09:48 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 04:09:48 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 04:09:48 INFO - Using env: {'DISPLAY': ':0', 04:09:48 INFO - 'HOME': '/home/cltbld', 04:09:48 INFO - 'LANG': 'en_US.UTF-8', 04:09:48 INFO - 'LANGUAGE': 'en_US:en', 04:09:48 INFO - 'LOGNAME': 'cltbld', 04:09:48 INFO - 'MAIL': '/var/mail/cltbld', 04:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:48 INFO - 'MOZ_NO_REMOTE': '1', 04:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:48 INFO - 'NO_EM_RESTART': '1', 04:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:48 INFO - 'PWD': '/builds/slave/test', 04:09:48 INFO - 'SHELL': '/bin/bash', 04:09:48 INFO - 'SHLVL': '1', 04:09:48 INFO - 'TERM': 'linux', 04:09:48 INFO - 'TMOUT': '86400', 04:09:48 INFO - 'USER': 'cltbld', 04:09:48 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', 04:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:48 INFO - '_': '/tools/buildbot/bin/python'} 04:09:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:09:49 INFO - Downloading/unpacking pip>=1.5 04:09:49 INFO - Running setup.py egg_info for package pip 04:09:49 INFO - warning: no files found matching 'pip/cacert.pem' 04:09:49 INFO - warning: no files found matching '*.html' under directory 'docs' 04:09:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:09:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:09:49 INFO - Installing collected packages: pip 04:09:49 INFO - Found existing installation: pip 1.1 04:09:49 INFO - Uninstalling pip: 04:09:49 INFO - Successfully uninstalled pip 04:09:49 INFO - Running setup.py install for pip 04:09:49 INFO - warning: no files found matching 'pip/cacert.pem' 04:09:49 INFO - warning: no files found matching '*.html' under directory 'docs' 04:09:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:09:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:09:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:09:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:09:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:09:49 INFO - Successfully installed pip 04:09:49 INFO - Cleaning up... 04:09:49 INFO - Return code: 0 04:09:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd60>, '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 0x107ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cef0>, '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': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', '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 04:09:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:09:49 INFO - Using env: {'DISPLAY': ':0', 04:09:49 INFO - 'HOME': '/home/cltbld', 04:09:49 INFO - 'LANG': 'en_US.UTF-8', 04:09:49 INFO - 'LANGUAGE': 'en_US:en', 04:09:49 INFO - 'LOGNAME': 'cltbld', 04:09:49 INFO - 'MAIL': '/var/mail/cltbld', 04:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:49 INFO - 'MOZ_NO_REMOTE': '1', 04:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:49 INFO - 'NO_EM_RESTART': '1', 04:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:49 INFO - 'PWD': '/builds/slave/test', 04:09:49 INFO - 'SHELL': '/bin/bash', 04:09:49 INFO - 'SHLVL': '1', 04:09:49 INFO - 'TERM': 'linux', 04:09:49 INFO - 'TMOUT': '86400', 04:09:49 INFO - 'USER': 'cltbld', 04:09:49 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', 04:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:49 INFO - '_': '/tools/buildbot/bin/python'} 04:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:49 INFO - Downloading/unpacking psutil>=3.1.1 04:09: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 04:09: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 04:09: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 04:09: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 04:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:09:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:50 INFO - Installing collected packages: psutil 04:09:50 INFO - Running setup.py install for psutil 04:09:51 INFO - building 'psutil._psutil_linux' extension 04:09:51 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 04:09:51 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 04:09:51 INFO - building 'psutil._psutil_posix' extension 04:09:51 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 04:09:51 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 04:09:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:51 INFO - Successfully installed psutil 04:09:51 INFO - Cleaning up... 04:09:51 INFO - Return code: 0 04:09:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09: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')]} 04:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd60>, '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 0x107ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cef0>, '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': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', '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 04:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:09:51 INFO - Using env: {'DISPLAY': ':0', 04:09:51 INFO - 'HOME': '/home/cltbld', 04:09:51 INFO - 'LANG': 'en_US.UTF-8', 04:09:51 INFO - 'LANGUAGE': 'en_US:en', 04:09:51 INFO - 'LOGNAME': 'cltbld', 04:09:51 INFO - 'MAIL': '/var/mail/cltbld', 04:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:51 INFO - 'MOZ_NO_REMOTE': '1', 04:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:51 INFO - 'NO_EM_RESTART': '1', 04:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:51 INFO - 'PWD': '/builds/slave/test', 04:09:51 INFO - 'SHELL': '/bin/bash', 04:09:51 INFO - 'SHLVL': '1', 04:09:51 INFO - 'TERM': 'linux', 04:09:51 INFO - 'TMOUT': '86400', 04:09:51 INFO - 'USER': 'cltbld', 04:09:51 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', 04:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:51 INFO - '_': '/tools/buildbot/bin/python'} 04:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:09: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 04:09: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 04:09: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 04:09: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 04:09:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:09:52 INFO - Installing collected packages: mozsystemmonitor 04:09:52 INFO - Running setup.py install for mozsystemmonitor 04:09:53 INFO - Successfully installed mozsystemmonitor 04:09:53 INFO - Cleaning up... 04:09:53 INFO - Return code: 0 04:09:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09: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')]} 04:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd60>, '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 0x107ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cef0>, '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': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', '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 04:09: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==2.5.1'] in /builds/slave/test/build 04:09: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==2.5.1 04:09:53 INFO - Using env: {'DISPLAY': ':0', 04:09:53 INFO - 'HOME': '/home/cltbld', 04:09:53 INFO - 'LANG': 'en_US.UTF-8', 04:09:53 INFO - 'LANGUAGE': 'en_US:en', 04:09:53 INFO - 'LOGNAME': 'cltbld', 04:09:53 INFO - 'MAIL': '/var/mail/cltbld', 04:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:53 INFO - 'MOZ_NO_REMOTE': '1', 04:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:53 INFO - 'NO_EM_RESTART': '1', 04:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:53 INFO - 'PWD': '/builds/slave/test', 04:09:53 INFO - 'SHELL': '/bin/bash', 04:09:53 INFO - 'SHLVL': '1', 04:09:53 INFO - 'TERM': 'linux', 04:09:53 INFO - 'TMOUT': '86400', 04:09:53 INFO - 'USER': 'cltbld', 04:09:53 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', 04:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:53 INFO - '_': '/tools/buildbot/bin/python'} 04:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:53 INFO - Downloading/unpacking jsonschema==2.5.1 04:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:09:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:55 INFO - Downloading functools32-3.2.3-2.tar.gz 04:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:09:55 INFO - warning: no files found matching '*.txt' 04:09:55 INFO - no previously-included directories found matching 'build' 04:09:55 INFO - no previously-included directories found matching 'dist' 04:09:55 INFO - no previously-included directories found matching '.git*' 04:09:55 INFO - Installing collected packages: jsonschema, functools32 04:09:56 INFO - Running setup.py install for functools32 04:09:56 INFO - warning: no files found matching '*.txt' 04:09:56 INFO - no previously-included directories found matching 'build' 04:09:56 INFO - no previously-included directories found matching 'dist' 04:09:56 INFO - no previously-included directories found matching '.git*' 04:09:56 INFO - Successfully installed jsonschema functools32 04:09:56 INFO - Cleaning up... 04:09:56 INFO - Return code: 0 04:09:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:56 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 0xd111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd60>, '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 0x107ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cef0>, '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': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', '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 04:09:56 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 04:09:56 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 04:09:56 INFO - Using env: {'DISPLAY': ':0', 04:09:56 INFO - 'HOME': '/home/cltbld', 04:09:56 INFO - 'LANG': 'en_US.UTF-8', 04:09:56 INFO - 'LANGUAGE': 'en_US:en', 04:09:56 INFO - 'LOGNAME': 'cltbld', 04:09:56 INFO - 'MAIL': '/var/mail/cltbld', 04:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:56 INFO - 'MOZ_NO_REMOTE': '1', 04:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:56 INFO - 'NO_EM_RESTART': '1', 04:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:56 INFO - 'PWD': '/builds/slave/test', 04:09:56 INFO - 'SHELL': '/bin/bash', 04:09:56 INFO - 'SHLVL': '1', 04:09:56 INFO - 'TERM': 'linux', 04:09:56 INFO - 'TMOUT': '86400', 04:09:56 INFO - 'USER': 'cltbld', 04:09:56 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', 04:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:56 INFO - '_': '/tools/buildbot/bin/python'} 04:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:09:56 INFO - Cleaning up... 04:09:56 INFO - Return code: 0 04:09:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:56 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 0xd111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd60>, '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 0x107ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cef0>, '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': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', '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 04:09:56 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 04:09:56 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 04:09:56 INFO - Using env: {'DISPLAY': ':0', 04:09:56 INFO - 'HOME': '/home/cltbld', 04:09:56 INFO - 'LANG': 'en_US.UTF-8', 04:09:56 INFO - 'LANGUAGE': 'en_US:en', 04:09:56 INFO - 'LOGNAME': 'cltbld', 04:09:56 INFO - 'MAIL': '/var/mail/cltbld', 04:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:56 INFO - 'MOZ_NO_REMOTE': '1', 04:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:56 INFO - 'NO_EM_RESTART': '1', 04:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:56 INFO - 'PWD': '/builds/slave/test', 04:09:56 INFO - 'SHELL': '/bin/bash', 04:09:56 INFO - 'SHLVL': '1', 04:09:56 INFO - 'TERM': 'linux', 04:09:56 INFO - 'TMOUT': '86400', 04:09:56 INFO - 'USER': 'cltbld', 04:09:56 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', 04:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:56 INFO - '_': '/tools/buildbot/bin/python'} 04:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:56 INFO - Downloading/unpacking blobuploader==1.2.4 04:09:56 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 04:09:56 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 04:09:56 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 04:09:56 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 04:09:57 INFO - Downloading blobuploader-1.2.4.tar.gz 04:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:09:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:09:57 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 04:09:57 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 04:09:57 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 04:09:57 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 04:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:09:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:09:58 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 04:09:58 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 04:09:58 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 04:09:58 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 04:09:58 INFO - Downloading docopt-0.6.1.tar.gz 04:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:09:58 INFO - Installing collected packages: blobuploader, requests, docopt 04:09:58 INFO - Running setup.py install for blobuploader 04:09:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:09:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:09:58 INFO - Running setup.py install for requests 04:09:58 INFO - Running setup.py install for docopt 04:09:59 INFO - Successfully installed blobuploader requests docopt 04:09:59 INFO - Cleaning up... 04:09:59 INFO - Return code: 0 04:09:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:59 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 0xd111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd60>, '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 0x107ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cef0>, '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': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', '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 04:09:59 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 04:09:59 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 04:09:59 INFO - Using env: {'DISPLAY': ':0', 04:09:59 INFO - 'HOME': '/home/cltbld', 04:09:59 INFO - 'LANG': 'en_US.UTF-8', 04:09:59 INFO - 'LANGUAGE': 'en_US:en', 04:09:59 INFO - 'LOGNAME': 'cltbld', 04:09:59 INFO - 'MAIL': '/var/mail/cltbld', 04:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:59 INFO - 'MOZ_NO_REMOTE': '1', 04:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:59 INFO - 'NO_EM_RESTART': '1', 04:09:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:59 INFO - 'PWD': '/builds/slave/test', 04:09:59 INFO - 'SHELL': '/bin/bash', 04:09:59 INFO - 'SHLVL': '1', 04:09:59 INFO - 'TERM': 'linux', 04:09:59 INFO - 'TMOUT': '86400', 04:09:59 INFO - 'USER': 'cltbld', 04:09:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', 04:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:59 INFO - '_': '/tools/buildbot/bin/python'} 04:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:59 INFO - Running setup.py (path:/tmp/pip-lPjK_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:59 INFO - Running setup.py (path:/tmp/pip-MhvQxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:59 INFO - Running setup.py (path:/tmp/pip-bIP2Sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:59 INFO - Running setup.py (path:/tmp/pip-0OmiWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:59 INFO - Running setup.py (path:/tmp/pip-9aswPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:59 INFO - Running setup.py (path:/tmp/pip-s3itUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:59 INFO - Running setup.py (path:/tmp/pip-536Rm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:59 INFO - Running setup.py (path:/tmp/pip-P3Ug0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:59 INFO - Running setup.py (path:/tmp/pip-QFcFI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:59 INFO - Running setup.py (path:/tmp/pip-TTlsZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:59 INFO - Running setup.py (path:/tmp/pip-SVYMYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:10:00 INFO - Running setup.py (path:/tmp/pip-E_ceLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:10:00 INFO - Running setup.py (path:/tmp/pip-nQGPQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:10:00 INFO - Running setup.py (path:/tmp/pip-aUV3wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:00 INFO - Running setup.py (path:/tmp/pip-vEJJOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:10:00 INFO - Running setup.py (path:/tmp/pip-yQL3xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:10:00 INFO - Running setup.py (path:/tmp/pip-C8wBkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:10:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:10:00 INFO - Running setup.py install for manifestparser 04:10:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:10:00 INFO - Running setup.py install for mozcrash 04:10:00 INFO - Running setup.py install for mozdebug 04:10:00 INFO - Running setup.py install for mozdevice 04:10:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:10:00 INFO - Running setup.py install for mozfile 04:10:00 INFO - Running setup.py install for mozhttpd 04:10:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:10:01 INFO - Running setup.py install for mozinfo 04:10:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:10:01 INFO - Running setup.py install for mozInstall 04:10:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:10:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:10:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:10:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:10:01 INFO - Running setup.py install for mozleak 04:10:01 INFO - Running setup.py install for mozlog 04:10:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:10:01 INFO - Running setup.py install for moznetwork 04:10:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:10:01 INFO - Running setup.py install for mozprocess 04:10:01 INFO - Running setup.py install for mozprofile 04:10:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:10:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:10:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:10:01 INFO - Running setup.py install for mozrunner 04:10:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:10:01 INFO - Running setup.py install for mozscreenshot 04:10:01 INFO - Running setup.py install for moztest 04:10:02 INFO - Running setup.py install for mozversion 04:10:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:10:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:10:02 INFO - Cleaning up... 04:10:02 INFO - Return code: 0 04:10:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:02 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 0xd111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd60>, '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 0x107ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cef0>, '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': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', '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 04:10:02 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 04:10:02 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 04:10:02 INFO - Using env: {'DISPLAY': ':0', 04:10:02 INFO - 'HOME': '/home/cltbld', 04:10:02 INFO - 'LANG': 'en_US.UTF-8', 04:10:02 INFO - 'LANGUAGE': 'en_US:en', 04:10:02 INFO - 'LOGNAME': 'cltbld', 04:10:02 INFO - 'MAIL': '/var/mail/cltbld', 04:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:02 INFO - 'MOZ_NO_REMOTE': '1', 04:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:02 INFO - 'NO_EM_RESTART': '1', 04:10:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:02 INFO - 'PWD': '/builds/slave/test', 04:10:02 INFO - 'SHELL': '/bin/bash', 04:10:02 INFO - 'SHLVL': '1', 04:10:02 INFO - 'TERM': 'linux', 04:10:02 INFO - 'TMOUT': '86400', 04:10:02 INFO - 'USER': 'cltbld', 04:10:02 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', 04:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:02 INFO - '_': '/tools/buildbot/bin/python'} 04:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:10:02 INFO - Running setup.py (path:/tmp/pip-lEmVO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:10:02 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)) 04:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:10:02 INFO - Running setup.py (path:/tmp/pip-M9LRij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:10:02 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)) 04:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:10:02 INFO - Running setup.py (path:/tmp/pip-2tBM83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:10:02 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)) 04:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:10:02 INFO - Running setup.py (path:/tmp/pip-EWTXyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:10:02 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)) 04:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:10:02 INFO - Running setup.py (path:/tmp/pip-QgcZMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:10:02 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)) 04:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:10:02 INFO - Running setup.py (path:/tmp/pip-_VKWia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:10:02 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)) 04:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:10:02 INFO - Running setup.py (path:/tmp/pip-k3URPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:10:02 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)) 04:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:10:02 INFO - Running setup.py (path:/tmp/pip-Czu3rP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:10:03 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)) 04:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:10:03 INFO - Running setup.py (path:/tmp/pip-Lzf3pA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:10:03 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)) 04:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:10:03 INFO - Running setup.py (path:/tmp/pip-AB4jA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:10:03 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)) 04:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:10:03 INFO - Running setup.py (path:/tmp/pip-AHURM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:10:03 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)) 04:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:10:03 INFO - Running setup.py (path:/tmp/pip-YaKcJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:10:03 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)) 04:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:10:03 INFO - Running setup.py (path:/tmp/pip-tHSBya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:10:03 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)) 04:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:10:03 INFO - Running setup.py (path:/tmp/pip-sm4oAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:10:03 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)) 04:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:03 INFO - Running setup.py (path:/tmp/pip-Cj687K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:03 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)) 04:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:10:03 INFO - Running setup.py (path:/tmp/pip-6eFPIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:10:03 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)) 04:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:10:03 INFO - Running setup.py (path:/tmp/pip-_i85o5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:10:03 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)) 04:10:03 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)) 04:10:03 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)) 04:10:03 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)) 04:10:03 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)) 04:10:03 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)) 04:10:03 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)) 04:10:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:04 INFO - Downloading blessings-1.6.tar.gz 04:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:10:04 INFO - Installing collected packages: blessings 04:10:04 INFO - Running setup.py install for blessings 04:10:04 INFO - Successfully installed blessings 04:10:04 INFO - Cleaning up... 04:10:05 INFO - Return code: 0 04:10:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:10:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:10:05 INFO - Reading from file tmpfile_stdout 04:10:05 INFO - Current package versions: 04:10:05 INFO - argparse == 1.2.1 04:10:05 INFO - blessings == 1.6 04:10:05 INFO - blobuploader == 1.2.4 04:10:05 INFO - docopt == 0.6.1 04:10:05 INFO - functools32 == 3.2.3-2 04:10:05 INFO - jsonschema == 2.5.1 04:10:05 INFO - manifestparser == 1.1 04:10:05 INFO - mozInstall == 1.13 04:10:05 INFO - mozcrash == 1.0 04:10:05 INFO - mozdebug == 0.1 04:10:05 INFO - mozdevice == 0.51 04:10:05 INFO - mozfile == 1.2 04:10:05 INFO - mozhttpd == 0.7 04:10:05 INFO - mozinfo == 0.10 04:10:05 INFO - mozleak == 0.1 04:10:05 INFO - mozlog == 3.5 04:10:05 INFO - moznetwork == 0.27 04:10:05 INFO - mozprocess == 0.25 04:10:05 INFO - mozprofile == 0.28 04:10:05 INFO - mozrunner == 6.13 04:10:05 INFO - mozscreenshot == 0.1 04:10:05 INFO - mozsystemmonitor == 0.3 04:10:05 INFO - moztest == 0.8 04:10:05 INFO - mozversion == 1.4 04:10:05 INFO - psutil == 3.1.1 04:10:05 INFO - requests == 1.2.3 04:10:05 INFO - wsgiref == 0.1.2 04:10:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:05 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 0xd111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd60>, '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 0x107ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cef0>, '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': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', '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 04:10:05 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 04:10:05 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 04:10:05 INFO - Using env: {'DISPLAY': ':0', 04:10:05 INFO - 'HOME': '/home/cltbld', 04:10:05 INFO - 'LANG': 'en_US.UTF-8', 04:10:05 INFO - 'LANGUAGE': 'en_US:en', 04:10:05 INFO - 'LOGNAME': 'cltbld', 04:10:05 INFO - 'MAIL': '/var/mail/cltbld', 04:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:05 INFO - 'MOZ_NO_REMOTE': '1', 04:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:05 INFO - 'NO_EM_RESTART': '1', 04:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:05 INFO - 'PWD': '/builds/slave/test', 04:10:05 INFO - 'SHELL': '/bin/bash', 04:10:05 INFO - 'SHLVL': '1', 04:10:05 INFO - 'TERM': 'linux', 04:10:05 INFO - 'TMOUT': '86400', 04:10:05 INFO - 'USER': 'cltbld', 04:10:05 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', 04:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:05 INFO - '_': '/tools/buildbot/bin/python'} 04:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:05 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)) 04:10:05 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)) 04:10:05 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)) 04:10:05 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)) 04:10:05 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)) 04:10:05 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)) 04:10:05 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)) 04:10:05 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)) 04:10:05 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)) 04:10:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:10:05 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 04:10:05 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 04:10:05 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 04:10:05 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 04:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:10:06 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)) 04:10:06 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)) 04:10:06 INFO - Installing collected packages: simplejson 04:10:06 INFO - Running setup.py install for simplejson 04:10:06 INFO - building 'simplejson._speedups' extension 04:10:06 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 04:10:07 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 04:10:07 INFO - Successfully installed simplejson 04:10:07 INFO - Cleaning up... 04:10:07 INFO - Return code: 0 04:10:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:07 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 0xd111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd60>, '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 0x107ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cef0>, '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': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', '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 04:10:07 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 04:10:07 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 04:10:07 INFO - Using env: {'DISPLAY': ':0', 04:10:07 INFO - 'HOME': '/home/cltbld', 04:10:07 INFO - 'LANG': 'en_US.UTF-8', 04:10:07 INFO - 'LANGUAGE': 'en_US:en', 04:10:07 INFO - 'LOGNAME': 'cltbld', 04:10:07 INFO - 'MAIL': '/var/mail/cltbld', 04:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:07 INFO - 'MOZ_NO_REMOTE': '1', 04:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:07 INFO - 'NO_EM_RESTART': '1', 04:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:07 INFO - 'PWD': '/builds/slave/test', 04:10:07 INFO - 'SHELL': '/bin/bash', 04:10:07 INFO - 'SHLVL': '1', 04:10:07 INFO - 'TERM': 'linux', 04:10:07 INFO - 'TMOUT': '86400', 04:10:07 INFO - 'USER': 'cltbld', 04:10:07 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', 04:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:07 INFO - '_': '/tools/buildbot/bin/python'} 04:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:10:07 INFO - Cleaning up... 04:10:07 INFO - Return code: 0 04:10:07 INFO - Running post-action listener: _resource_record_post_action 04:10:07 INFO - Running post-action listener: _start_resource_monitoring 04:10:07 INFO - Starting resource monitoring. 04:10:07 INFO - [mozharness: 2017-09-27 11:10:07.954433Z] Finished create-virtualenv step (success) 04:10:07 INFO - [mozharness: 2017-09-27 11:10:07.954960Z] Running install step. 04:10:07 INFO - Running pre-action listener: _resource_record_pre_action 04:10:07 INFO - Running main action method: install 04:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:10:08 INFO - Reading from file tmpfile_stdout 04:10:08 INFO - Detecting whether we're running mozinstall >=1.0... 04:10:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:10:08 INFO - Reading from file tmpfile_stdout 04:10:08 INFO - Output received: 04:10:08 INFO - Usage: mozinstall [options] installer 04:10:08 INFO - Options: 04:10:08 INFO - -h, --help show this help message and exit 04:10:08 INFO - -d DEST, --destination=DEST 04:10:08 INFO - Directory to install application into. [default: 04:10:08 INFO - "/builds/slave/test"] 04:10:08 INFO - --app=APP Application being installed. [default: firefox] 04:10:08 INFO - mkdir: /builds/slave/test/build/application 04:10:08 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'] 04:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:10:25 INFO - Reading from file tmpfile_stdout 04:10:25 INFO - Output received: 04:10:25 INFO - /builds/slave/test/build/application/firefox/firefox 04:10:25 INFO - Running post-action listener: _resource_record_post_action 04:10:25 INFO - [mozharness: 2017-09-27 11:10:25.959777Z] Finished install step (success) 04:10:25 INFO - [mozharness: 2017-09-27 11:10:25.960030Z] Running setup-mitmproxy step. 04:10:25 INFO - Running pre-action listener: _resource_record_pre_action 04:10:25 INFO - Running main action method: setup_mitmproxy 04:10:25 INFO - Skipping: mitmproxy is not required 04:10:25 INFO - Running post-action listener: _resource_record_post_action 04:10:25 INFO - [mozharness: 2017-09-27 11:10:25.961171Z] Finished setup-mitmproxy step (success) 04:10:25 INFO - [mozharness: 2017-09-27 11:10:25.961392Z] Running run-tests step. 04:10:25 INFO - Running pre-action listener: _resource_record_pre_action 04:10:25 INFO - Running pre-action listener: _set_gcov_prefix 04:10:25 INFO - Running main action method: run_tests 04:10:25 WARNING - Try message not found. 04:10:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:10:25 INFO - Python 2.7.3 04:10:25 INFO - Return code: 0 04:10:25 INFO - grabbing minidump binary from tooltool 04:10:25 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')]} 04:10:25 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 0x107bd60>, '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 0x107ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:10:25 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 04:10:25 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 04:10:25 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 04:10:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:10:26 INFO - Return code: 0 04:10:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:10:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:10:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:10:26 INFO - ENV: RUST_BACKTRACE is now full 04:10:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:10:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:10:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 04:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 04:10:26 INFO - Using env: {'DISPLAY': ':0', 04:10:26 INFO - 'HOME': '/home/cltbld', 04:10:26 INFO - 'LANG': 'en_US.UTF-8', 04:10:26 INFO - 'LANGUAGE': 'en_US:en', 04:10:26 INFO - 'LOGNAME': 'cltbld', 04:10:26 INFO - 'MAIL': '/var/mail/cltbld', 04:10:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:10:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:26 INFO - 'MOZ_NO_REMOTE': '1', 04:10:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:26 INFO - 'NO_EM_RESTART': '1', 04:10:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:26 INFO - 'PWD': '/builds/slave/test', 04:10:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:10:26 INFO - 'RUST_BACKTRACE': 'full', 04:10:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:10:26 INFO - 'SHELL': '/bin/bash', 04:10:26 INFO - 'SHLVL': '1', 04:10:26 INFO - 'TERM': 'linux', 04:10:26 INFO - 'TMOUT': '86400', 04:10:26 INFO - 'USER': 'cltbld', 04:10:26 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', 04:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:26 INFO - '_': '/tools/buildbot/bin/python'} 04:10:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 04:10:26 INFO - mozversion application_buildid: 20170927094612 04:10:26 INFO - mozversion application_changeset: 5563e7da39b265ed1ba7796ec058bdbcf6f792f6 04:10:26 INFO - mozversion application_display_name: Nightly 04:10:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:10:26 INFO - mozversion application_name: Firefox 04:10:26 INFO - mozversion application_remotingname: firefox 04:10:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:10:26 INFO - mozversion application_vendor: Mozilla 04:10:26 INFO - mozversion application_version: 58.0a1 04:10:26 INFO - mozversion platform_buildid: 20170927094612 04:10:26 INFO - mozversion platform_changeset: 5563e7da39b265ed1ba7796ec058bdbcf6f792f6 04:10:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:10:26 INFO - mozversion platform_version: 58.0a1 04:10:26 INFO - using testdate: 1506510626 04:10:26 INFO - actual date: 1506510626 04:10:26 INFO - starting webserver on 'localhost:37993' 04:10:26 INFO - SUITE-START | Running 2 tests 04:10:26 INFO - TEST-START | dromaeo_css 04:10:26 INFO - Initialising browser for dromaeo_css test... 04:10:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37993/getInfo.html -profile /tmp/tmpZ8dUY4/profile 04:10:26 INFO - TEST-INFO | started process 20044 (/builds/slave/test/build/application/firefox/firefox http://localhost:37993/getInfo.html) 04:10:31 INFO - TEST-INFO | 20044: exit 0 04:10:31 INFO - Browser initialized. 04:10:31 INFO - Running cycle 1/1 for dromaeo_css test... 04:10:31 INFO - Using env: {'DISPLAY': ':0', 04:10:31 INFO - 'HOME': '/home/cltbld', 04:10:31 INFO - 'JSGC_DISABLE_POISONING': '1', 04:10:31 INFO - 'LANG': 'en_US.UTF-8', 04:10:31 INFO - 'LANGUAGE': 'en_US:en', 04:10:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:10:31 INFO - 'LOGNAME': 'cltbld', 04:10:31 INFO - 'MAIL': '/var/mail/cltbld', 04:10:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:10:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:10:31 INFO - 'MOZ_CRASHREPORTER': '1', 04:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:10:31 INFO - 'MOZ_NO_REMOTE': '1', 04:10:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:31 INFO - 'NO_EM_RESTART': '1', 04:10:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:31 INFO - 'PWD': '/builds/slave/test', 04:10:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:10:31 INFO - 'RUST_BACKTRACE': 'full', 04:10:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:10:31 INFO - 'SHELL': '/bin/bash', 04:10:31 INFO - 'SHLVL': '1', 04:10:31 INFO - 'STYLO_FORCE_DISABLED': '1', 04:10:31 INFO - 'TERM': 'linux', 04:10:31 INFO - 'TMOUT': '86400', 04:10:31 INFO - 'USER': 'cltbld', 04:10:31 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', 04:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:31 INFO - '_': '/tools/buildbot/bin/python'} 04:10:31 INFO - TEST-INFO | started process 20282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ8dUY4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:32 INFO - PID 20282 | 04:10:32 INFO - PID 20282 | (/builds/slave/test/build/application/firefox/firefox:20331): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:10:32 INFO - PID 20282 | 04:10:42 INFO - PID 20282 | RSS: Main: 145031168 04:10:42 INFO - PID 20282 | 04:13:40 INFO - PID 20282 | Cycle 1(1): loaded http://localhost:37993/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37993/tests/dromaeo/cssquery-ext.html) 04:13:41 INFO - PID 20282 | RSS: Main: 146403328 04:13:41 INFO - PID 20282 | 04:16:43 INFO - PID 20282 | Cycle 1(1): loaded http://localhost:37993/tests/dromaeo/cssquery-ext.html (next: http://localhost:37993/tests/dromaeo/cssquery-jquery.html) 04:16:44 INFO - PID 20282 | RSS: Main: 146268160 04:16:44 INFO - PID 20282 | 04:19:45 INFO - PID 20282 | Cycle 1(1): loaded http://localhost:37993/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37993/tests/dromaeo/cssquery-mootools.html) 04:19:46 INFO - PID 20282 | RSS: Main: 148508672 04:19:46 INFO - PID 20282 | 04:22:47 INFO - PID 20282 | Cycle 1(1): loaded http://localhost:37993/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37993/tests/dromaeo/cssquery-prototype.html) 04:22:48 INFO - PID 20282 | RSS: Main: 146386944 04:22:48 INFO - PID 20282 | 04:25:51 INFO - PID 20282 | Cycle 1(1): loaded http://localhost:37993/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37993/tests/dromaeo/cssquery-yui.html) 04:25:51 INFO - PID 20282 | RSS: Main: 148168704 04:25:51 INFO - PID 20282 | 04:28:53 INFO - PID 20282 | Cycle 1(1): loaded http://localhost:37993/tests/dromaeo/cssquery-yui.html (next: http://localhost:37993/tests/dromaeo/cssquery-dojo.html) 04:28:53 INFO - PID 20282 | RSS: Main: 150679552 04:28:53 INFO - PID 20282 | 04:28:53 INFO - PID 20282 | __start_tp_report 04:28:53 INFO - PID 20282 | _x_x_mozilla_page_load 04:28:53 INFO - PID 20282 | _x_x_mozilla_page_load_details 04:28:53 INFO - PID 20282 | |i|pagename|runs| 04:28:53 INFO - PID 20282 | |0;dojo.html;3887.9805600972;3888.6889048876087;3892.0853599404118;3896.8441262349525;3917.745346552474;6203.627782333063;6205.131281620571;6248.15649887265;6316.905246421307;6377.7448902043925;6283.340249273829;6298.779542716006;6317.526185536091;6321.52588555859;6345.904811427832;5546.77812887484;5567.860803479925;5621.887562248752;5629.521490673298;5693.345265294482;5650.124230744221;5691.772329106851;5692.345380281258;5724.856878578048;5743.195952566644;5622.8313150605345;5654.6889921054535;5722.742476588543;5724.227229324029;5736.799212027579;5434.91847622286;5576.749046292886;5588.580856435743;5639.3232812062815;5657.20799088128;5571.777128914879;5576.302962129734;5636.323641163087;5638.774449022075;5661.547076233933;6210.192674952227;6211.937880621226;6239.87520249597;6285.088662143963;6285.151504546873;6783.830404239884;6807.897881531781;6817.897731534031;6824.488163387766;6826.726930922807;6799.932000679979;6860.725570977155;6879.5184337096425;6956.5478243913985;6958.095447591781;6245.500359971192;6307.716152773136;6308.116863639094;6406.743730250738;6421.903671444932;6942.06282151903;6972.686229119702;7016.508844380946;7025.262347453444;7044.154701435758;6673.099131617267;6725.125733654593;6799.524033317719;6816.659167041628;6821.522493425413;6734.730610775612;6813.693383797741;6824.351686589766;6837.658117094125;6843.0419741236265;6705.865882682319;6768.323167683192;6799.3200679931615;6805.489588280899;6813.625250611165;6704.932950670431;6864.485163612749;6867.278935711778;6871.759488417882;6879.965600171967;4961.305417241589;4990.775415106329;5013.39839219296;5040.117979353672;5073.061483625541;4444.777761111932;4506.752128632957;4508.211063063951;4528.660350473728;4535.160995215896;6194;6223.657698826518;6252.374762523711;6260.217472815898;6268.655223962726;6783.660816959133;6817.829554261183;6869.278725733726;6876.209235937831;6879.174499060045;6251.437370636664;6260.311365749764;6267.4986001119805;6333.524985626096;6344.302126766052;5465.508104270555;5551.777928882881;5576.776928922797;5580.748866301026;5594.412586678422;7005.614691191931;7015.9298407016295;7019.789406317818;7040;7108.68010939509;6748.392644662004;6814.182298124257;6821.113255276782;6835;6839.042534045138;6998.370146686822;7007.6145811978795;7034.824129396806;7093.32613401726;7107.538010029331;6684.465242780663;6739.494537909774;6775.695093720696;6812.965935170292;6833.282505336868;6855.760048398282;6882.4149947253045;6883.449324053963;6883.586984780929;6886.345797149263;6538.346165383424;6550.082988381726;6600.735970561123;6622.403983641495;6637.435817955527;6539.574927629689;6604.570702904296;6617.702203400762;6625.469962403093;6626.834329141617;6473.287938326875;6483.740650373932;6486.05952136947;6571.572847765071;6580.407763301326;6563.901541476977;6615.536912416084;6659.267480577036;6668.799936001928;6690.69891854858;6364.936350636434;6438.517111216771;6455.225372955088;6545.345465453607;6545.541812073109 04:28:53 INFO - PID 20282 | |1;ext.html;912.3886995712871;971.8687977123088;999.5751805482668;999.7800483893541;1001.514265581193;43697.78151109244;44737.10525789482;44770.776146119264;44783.104337913224;44853.77573112138;42251.15497690052;42256;42466.150676986515;42602.573974260245;42607.14785704284;7513.248675132498;7631.503952243114;7653.502522336058;7675.385969122457;7677.808054798619;7411.221821708724;7511.887321690179;7514.286142816423;7527.322540971311;7549.320561149495;8369.414141010131;8584.656613735475;8593.441426307301;8597.011343695493;8603.698870539532;8466.83066338676;8477.237048665618;8489.95755021221;8515.40392172545;8533.274671652916;8206.630701618442;8428;8430.283425908805;8431.40980131391;8433.451825631375;41255.7937210312;41524.792376038225;41550.79224603888;41561.79219103915;41597.79201104005;3731.160488890005;3764.416515440111;3793.791341476218;3796.8291426885858;3797.696184305249;32822.6717732822;33107;33180.668193318;33228.83385583081;33455.83272083624;5198.454162312978;5258.2638430619745;5269.130593452076;5291.4708529147165;5295.364556253236;210721;212852;212936;212989;213518;46538.53461465342;46692.53307466882;53637;54207.186892196645;54277;57883;57922.7103864478;58088.70955645279;58131.709341453025;58147.70926145342;17322.307107715802;17484.65030699379;17574.912125439292;17583.29666813313;17597.032163231146;14268.714625707427;14456.060356076821;14528.782068268985;14534.709305813825;14540.345684444013;15424.5372638821;15429.845701542841;15500.30248638814;15561.688766224612;15707.842921570638;6041.495932359221;6099.359567245376;6150.7847225346895;6276.403741644536;6299.338569450142;1092.9289596176222;1093.185576745314;1099.6481126039591;1100.4497751124438;1101.3391964821203;25308.873455632605;25555.87222063878;25613.871930640227;25688.229353119437;25759;1196.6888608961733;1210.9455074521668;1212.4362171590253;1217;1225.2158618484177;13364.799528007088;13556.389962451516;13616.38726257301;13721.382537785823;13725.176489410667;279899;280872;280892;280948;281248;58100.12849807256;58108.12837807436;58316.4168358311;58473.70763146242;58494.4150558489;1514.4623658601258;1532.6168457885528;1544.7296723073416;1558.649303906612;1560.9843901561067;24852.502949941263;24895.253142405756;25045.624315635643;25045.87477062603;25149;41903.371449428894;41950.370744438245;42125.99999999877;42168;42257.154856903304;227580;228958;229296;230821;231075;34032.1491962693;34644.82677586596;36681.63318366782;37148;37352.75883447002;46347.53652463432;46675;46750.53249467462;46958;47453;34024.65975340215;34069;34423.655763442046;34653.30693386068;34981;34008.65991340055;34120.317593647495;34287.14282142966;34492.82753586216;34663.653363466045;39771.40342894801;40273.395899062125;40436.59563404446;40471.392929105496;40486.1902761949;32458.513122302713;32491.18772030718;32670.673293267715;32783.34433311368;32925.50611740778;25139.622905656797;25592.23223303304;25876.8706156468;25970.22089337323;26207.344816379744 04:28:53 INFO - PID 20282 | |2;jquery.html;605.9242594675662;608.2725060827249;611.4435863364337;617.876424715057;638.3680156644922;22864.31407057789;23708.288751337444;23713.881430592824;23759;23835.28494145174;24061.39846503834;25548.74451255487;25671.229863104138;25749.74250257497;25787.871060644717;6345.111684364181;6489.545731798776;6508.316626754194;6521.543491955565;6523.641199734013;6303.968480157593;6481.708323125447;6587.275399706028;6608.966955165218;6617.8014659560295;6518.543701940866;6572.44134248587;6579.638119903403;6582.275949645536;6582.835429114262;6346.619202847844;6463.709133088999;6524.184476940382;6564.048213009087;6564.573302735331;6138.662373569452;6160.507159427235;6163.167972323724;6164.87670246597;6175.3515880832765;30054.699453005407;30674.38651226985;30696.84651576728;30698.23254418635;30708.69291307103;2235.7652446493207;2252;2253.6056190166655;2268.1834539565743;2268.65970104484;19913.60172796536;20598.485037874023;20816.16735330585;20959.26642567503;20976.265830696004;2500.1499490173246;2515.371157210697;2534.9239522814346;2559.7056338521124;2569.974300257011;142585;147686;156707;164209;164697;15859.224635688708;16180.919095404448;16371.672566548841;16658;16666.250018749186;25381.365465863502;25471;25471.235862924143;25495.872520637276;25528.23415297544;10747.946260268805;10838;10942.288751231305;11048;11123.833142502868;9837.55730992107;9892.505374731234;9940.055694708992;10099.14157296638;10199.0820826126;9221.219300086932;9573.664921727706;9591.136797688241;9654.565544550513;9859.161971232383;2669.6529451171614;2767.266674331304;2816.1973837456226;2843.9146825595267;2913.592097106407;991.8214721350226;1020.2552136940076;1037.444966942682;1055.646358469921;1059.7032830807386;20404.285849995475;20546.28088016912;20737.58524829525;21409.357719268446;21538;1083.9078678312433;1102.873169585492;1104.089126470665;1104.4312179227543;1105.2594761509808;11397.601083962021;11600.88399115998;11809.468573914195;11873.050155987501;11882.88117118835;601636;615023;616519;642756;647457;134769;136549.3172534131;136648;137162;138410;1201.1248318865387;1206.7707135644375;1224.7734169178552;1232.8767123287778;1232.9445174967148;18747.062646867875;18798.3420580279;18936.621267574847;18984.240630374632;19152.904235478734;63683.681581591794;64983.675081624286;65249.021264682015;65327.673361632886;66300.6684966572;83173.16826831654;83514.58242708747;83889.58055209684;84255.57872210845;84932.57533712292;15254.77117843211;15494.457693980656;15541.766873496681;15555.377784888931;15555.611109722347;23811.166609168595;23811.40471488227;23828;23887.40281492907;24100.276991690276;19129.33047343336;19545.218191272757;19794.90102549478;19843.40469785909;19890;16826.663466730843;17225.74161387555;17362.65274694524;17405.39081132205;17747.645047099242;19678.311259105863;19783.40649780509;19857.106430210388;20063.59872802565;20181.39455816328;15063.54809355721;15148.848511515185;15188.316525756147;15226.543203703906;15323.770143447635;18368.448946531626;19279.614407712048;19436.90281548583;19658.705119423506;19658.8034119657 04:28:53 INFO - PID 20282 | |3;mootools.html;1426.6076828872062;1478.3125846481385;1479.2825479642372;1488.4418343121329;1490.180400779571;16271;17145.657086858257;17157;17186.05476698781;17188.65622687547;16730.83269167308;16811.747823782654;16839.32642694294;16853.241604127812;16853.91573042133;2769.127724766697;2811.030194582876;2812.817166884156;2815.2539577012108;2815.3383954770716;2736.493748656495;2789.3584475570633;2802.9439411211765;2821.252368122439;2821.463921854841;2683.758461738443;2754.380264440505;2766.101017169418;2771.764400026;2774.3480282133683;2544.3511904464426;2605.9348516287055;2609.073778808515;2618.2668852721267;2619.3582572269725;2567.9101231457;2573.0479722502605;2581.832180908235;2593.4942686176205;2595.2862962685413;15626;15895.52313430599;15946.28241729125;15984;15996.280167392495;7914.762557123296;8261.958690206511;8265.876011859827;8277.95861020697;8285.461445006054;5045.84862454127;5119.692818430869;5164.04465173944;5275.762590683428;5542.196381524656;2089.2478707665227;2104.6527322991687;2117.6400011998;2149.9462513437134;2180.324099529151;26463.47073058547;27105.45789084227;30828.2292942676;31396.05811825626;31520.99999999977;7539.283768042027;7544.698212071456;7562.886556701544;7644.6942122315595;7678.500897441649;22709.886450567643;22747.545049098924;22886.08455661755;22895.771042289365;23033.309000730005;8661;8706.303495720327;8710.564471776386;8710.608022638997;8712.303015758724;7604.087509498895;7780.299773020455;7815.179406162385;7827.099883513355;7868.881966770503;6011.579189456696;6195.96902015496;6207.906881396782;6225.408586184305;6251.249850018027;1808.7739032620923;1845.2895635180553;1866.5986812835306;1868.2526989204428;1873.681474149398;946.990530094704;966.087047739879;974.9463779492054;982.9852552211722;985.5417230987625;8283.29591984676;8340.666373345119;8453.788655283544;8460.196281353261;8463.661453541912;794.9960250198712;797.4218691448654;799.8160423102603;802.7431222009018;806.6934564865431;5072.974635126875;5087.186050231945;5122.257272695439;5125.410577783603;5167.121589329823;23163.189288374826;23349.88325058364;24464.633030504556;24642;24836;24033.27900162998;24279.878600606884;24327.51344973126;24369.14707985212;24415.023399064194;11328.71678208035;12504.124711270306;12532.937335313447;12540.122191446693;12621.990240780715;8891.288696904103;9235;9349.392289501433;9362.95318523403;9402.34183607141;19405.958390126132;20526;20588.691169632766;21185.258515951868;21478.892605536872;21339.46651333667;21430.892845535673;21716.34850954474;21846;21854.562908742053;13387.062905596904;13561.932190338985;13576.253306068262;13611.86388136106;13617;15490.457833975757;15528.301226444612;15580.454684086002;15684.215789210266;15717.292721827775;12577.685557861127;12603.621891343275;12654.683632909251;12928.418221179882;12953.676158096123;12247.510099596273;12410.131290809557;12915.289659068465;12919;12995.935020324838;10918;10921.617743378943;10989.340639561333;11090.889091108986;11137.10903127764;8464.140663200764;8517.574121293786;8646.622178900852;8704.390692651454;8756.956215218883;8273.83452330962;8358.247757701836;8377.246047855722;8415.53714545706;8448.83102337962 04:28:53 INFO - PID 20282 | |4;prototype.html;546.9124940009599;576.124291077562;576.6482445708118;585.5549782165552;589.9439553242444;6251.59364641298;6397.744090236391;6401.967990160048;6423.394151462135;6433.903491447621;6248.594066335072;6292.238173311469;6314.589551679138;6316.74733010679;6331.430171284584;5027.170516864731;5085.491450854922;5151.7681704323395;5189.662671926331;5196.532312091911;4946.233333833244;5086.160783470723;5089.549478398657;5098.311727916721;5220.425753167148;5049.4950504949575;5054.292399064134;5057.898842023157;5067.239914012909;5070.923936140961;5014.423341315759;5026;5034.270030845543;5035.169197082477;5039.899202015976;4573;4585.243434833248;4589.609883159902;4591.931121033187;4620.491745907947;6233.87532249357;6298.551333193345;6319.14691516644;6325.683715814191;6327.746890124389;5953.58324917256;5999.520038396918;6009.909851352233;6015.428534289235;6039.969800150971;6781.593104413701;6785.01459357881;6801.163685804854;6813.386795188457;6816.216135144423;5129.820456284012;5135.281060651511;5135.614828887811;5146.356705411824;5173.663711858717;6773.3903948644365;6963.338482844122;6967.79096627102;6981.544135652834;7120.608366539838;5282.867928301746;5289.735513224324;5294.92057619136;5296.629235953446;5303.711698746724;5331.653442526223;5350.6254562180275;5357.7053262070185;5366.248725178478;5383.919241211385;5872.29532456108;5881.3530511643685;5936.575221946701;5942.762289508458;5979.701014949323;6719.496037797185;6753.729850806011;6759.5606285591275;6795.320467953264;6834.897476537856;1824.8905065696101;1831.4432732177809;1846.4028615247714;1847.2980267498265;1855.997761208959;1265.8480982282001;1293.9029572782079;1313.1464548043657;1319.7558451686468;1323.7358322801701;6116.877662446726;6121.846953826101;6126.479249263773;6132.41742034506;6342.270638876588;6630.635315057718;6685.726852870048;6689.230738465041;6825.283345248777;6887.758928437581;6074;6107.144999700045;6166.784162554289;6191.35928978821;6297.559170858088;3496.4405695088662;3520.1375662962228;3546.946795798065;3564.287142571496;3588.569371675416;6940.375366217065;6977.930220697728;7034.788956331318;7045.189803172599;7125.89311160333;6843.58588710279;6909.205441374206;6919.273476285019;7013.509054366247;7070.823229419306;6870.484713646497;6878.759243426456;7004.15950085993;7033.577985321;7071.752488662872;6644.966775166094;6651.235107962452;6657.833554160991;6788.4569234462115;6793.388595026471;6696.111838358123;6715.899261511179;6739.59562426256;6777.45780337562;6833.521653484408;7039.577625342496;7060.54106483077;7061.329173728487;7127.394171495481;7128.750493732695;5253.159494481018;5265.4997775211295;5272.258425618734;5301.761420736153;5325.946740532545;6652.837827706112;6806;6816.454683625398;6853.554518956252;6902.447804175755;6508.674566271762;6544.3782840630065;6699.263081061177;6704.765333213314;6767.1879374475375;6640.369164929517;6651.966740166462;6672;6676.799696009128;6677.631085627532;6470.708818103102;6477.890612505929;6501.472154043701;6547.70535325902;6635.568688035262;6412.743490260337;6659.2008958925235;6713.4488894219885;6729.730810767514;6737.797866064026;6486.643234622141;6531.9020214695865;6533.41199292066;6571.901421478586;6626.90059649096 04:28:53 INFO - PID 20282 | |5;yui.html;955.6129767444186;965.4786415335715;973.3819024919175;991.0782971836189;994.9602015919363;21722.13111475541;25984.090556830513;26026.73973260269;26046;26158.2152535424;19147.904260478677;19265.711014334796;19284.710729339036;19302.227910883583;22322.553548929052;1082.3668154129823;1089.2756317049193;1095.9726006849853;1104.0339702760084;1104.2049724198564;1070.946452677367;1107.141964977145;1110.455876620454;1112.8108221602347;1114.381518257367;1159.0669511043607;1162.1400163878754;1162.4187906046977;1162.6860747598143;1163.331084626339;1148.3339662995484;1156.3813359852438;1157.184185149472;1159.113278342069;1159.4782347943417;841.8105926166625;846.5259454705384;848.7326492155013;851.5827244650138;853.6542700206427;19036.619267614707;19343.226270949144;19361.709574356395;19481.415557533295;20626.27808026712;23430.17994370206;23886;24394.756052439603;24541.87729061361;24564.263072107864;18121.909390453096;18444.907775461037;18604.906975465172;18655.440336789918;18664.533386665305;3774.3960966245268;3826.598207188233;3829.770213787154;3834.9616503835164;3838.9826695925603;157655.99999999886;158467.2076639621;158876.2056189723;162325.18837405738;162558;17729.113544322732;17737.645247094984;17828.286868525374;17952.730709039373;18018.36935707244;35152.82423587866;35627.64372356295;35947;36079.4588081179;36114.27771444556;8459.280961118251;8667.13328667141;8724.69463568772;8750.124987501198;8804;4365.738055716667;4442.222611043055;4449.57729015743;4460.264056430718;4464.330350447459;6016.909746353721;6041.2750469943885;6119.357467465852;6139.508839292846;6141.84645383869;1079.3469950679882;1114.9275297105662;1127.639155470258;1128.8532490776147;1129.4014172488594;703.4688809948456;703.5602748282323;712.7968528969219;725.804032911111;729.0413106764694;12563.874361256454;12788.616341509769;13112.606621801362;14128.43486260538;14155.575332740034;685.9348361905611;686.0772261308532;700;701.137600751079;703.711478293897;5706.065691680688;5752.856178595569;5822.7088645567555;5867.207926929896;5919.4080591940465;147039;149960;151643;155223;158989.205053974;134357.3282133583;136262.31868840792;136904;136947;140879.29560352338;115324;116311.41844290725;116747;117840.41079794546;118226;11238.66284011481;11253.71865703364;11405.201635885409;11531.884681153417;11564.884351156381;53008.469915301896;53108;53374.73312633412;54021.45978540322;54306.45693543014;69203;69275.30724692688;71044.28955710377;71310;72116;16734.916325418297;16745.832541674914;16808.915955420143;16857.241424135696;16935.745963810798;19187.232510699974;19293.614127717086;19362.4191274262;19509.414717558495;19614.117364718335;17106.572335691708;17214.311427542758;17332.39336623212;17343.739843902098;17617.295308187528;16487.917560412123;16666.08336541502;16713.749293760848;16810.075445850594;16844.15779211059;16931;16954.576135596217;16977.74533382025;17110.657786844444;17353.30586776515;12891.41988610496;13205.405756740778;13332.40004199794;13478.79781803254;13557.661058473223;13254.80117798253;13303.135296205715;13389.129706569041;13461;13469.865301346861 04:28:53 INFO - PID 20282 | __end_tp_report 04:28:53 INFO - PID 20282 | __start_cc_report 04:28:53 INFO - PID 20282 | _x_x_mozilla_cycle_collect,266 04:28:53 INFO - PID 20282 | __end_cc_report 04:28:53 INFO - PID 20282 | __startTimestamp1506511733642__endTimestamp 04:28:53 INFO - PID 20282 | 04:28:53 INFO - PID 20282 | ------- Summary: start ------- 04:28:53 INFO - PID 20282 | Number of tests: 6 04:28:53 INFO - PID 20282 | 04:28:53 INFO - PID 20282 | [#0] dojo.html Cycles:165 Average:6272.13 Median:6539.57 stddev:743.45 (11.4%) stddev-sans-first:721.82 04:28:53 INFO - PID 20282 | Values: 3888.0 3888.7 3892.1 3896.8 3917.7 6203.6 6205.1 6248.2 6316.9 6377.7 6283.3 6298.8 6317.5 6321.5 6345.9 5546.8 5567.9 5621.9 5629.5 5693.3 5650.1 5691.8 5692.3 5724.9 5743.2 5622.8 5654.7 5722.7 5724.2 5736.8 5434.9 5576.7 5588.6 5639.3 5657.2 5571.8 5576.3 5636.3 5638.8 5661.5 6210.2 6211.9 6239.9 6285.1 6285.2 6783.8 6807.9 6817.9 6824.5 6826.7 6799.9 6860.7 6879.5 6956.5 6958.1 6245.5 6307.7 6308.1 6406.7 6421.9 6942.1 6972.7 7016.5 7025.3 7044.2 6673.1 6725.1 6799.5 6816.7 6821.5 6734.7 6813.7 6824.4 6837.7 6843.0 6705.9 6768.3 6799.3 6805.5 6813.6 6704.9 6864.5 6867.3 6871.8 6880.0 4961.3 4990.8 5013.4 5040.1 5073.1 4444.8 4506.8 4508.2 4528.7 4535.2 6194.0 6223.7 6252.4 6260.2 6268.7 6783.7 6817.8 6869.3 6876.2 6879.2 6251.4 6260.3 6267.5 6333.5 6344.3 5465.5 5551.8 5576.8 5580.7 5594.4 7005.6 7015.9 7019.8 7040.0 7108.7 6748.4 6814.2 6821.1 6835.0 6839.0 6998.4 7007.6 7034.8 7093.3 7107.5 6684.5 6739.5 6775.7 6813.0 6833.3 6855.8 6882.4 6883.4 6883.6 6886.3 6538.3 6550.1 6600.7 6622.4 6637.4 6539.6 6604.6 6617.7 6625.5 6626.8 6473.3 6483.7 6486.1 6571.6 6580.4 6563.9 6615.5 6659.3 6668.8 6690.7 6364.9 6438.5 6455.2 6545.3 6545.5 04:28:53 INFO - PID 20282 | 04:28:53 INFO - PID 20282 | [#1] ext.html Cycles:180 Average:42128.40 Median:20541.96 stddev:63078.98 (307.1%) stddev-sans-first:63180.01 04:28:53 INFO - PID 20282 | Values: 912.4 971.9 999.6 999.8 1001.5 43697.8 44737.1 44770.8 44783.1 44853.8 42251.2 42256.0 42466.2 42602.6 42607.1 7513.2 7631.5 7653.5 7675.4 7677.8 7411.2 7511.9 7514.3 7527.3 7549.3 8369.4 8584.7 8593.4 8597.0 8603.7 8466.8 8477.2 8490.0 8515.4 8533.3 8206.6 8428.0 8430.3 8431.4 8433.5 41255.8 41524.8 41550.8 41561.8 41597.8 3731.2 3764.4 3793.8 3796.8 3797.7 32822.7 33107.0 33180.7 33228.8 33455.8 5198.5 5258.3 5269.1 5291.5 5295.4 210721.0 212852.0 212936.0 212989.0 213518.0 46538.5 46692.5 53637.0 54207.2 54277.0 57883.0 57922.7 58088.7 58131.7 58147.7 17322.3 17484.7 17574.9 17583.3 17597.0 14268.7 14456.1 14528.8 14534.7 14540.3 15424.5 15429.8 15500.3 15561.7 15707.8 6041.5 6099.4 6150.8 6276.4 6299.3 1092.9 1093.2 1099.6 1100.4 1101.3 25308.9 25555.9 25613.9 25688.2 25759.0 1196.7 1210.9 1212.4 1217.0 1225.2 13364.8 13556.4 13616.4 13721.4 13725.2 279899.0 280872.0 280892.0 280948.0 281248.0 58100.1 58108.1 58316.4 58473.7 58494.4 1514.5 1532.6 1544.7 1558.6 1561.0 24852.5 24895.3 25045.6 25045.9 25149.0 41903.4 41950.4 42126.0 42168.0 42257.2 227580.0 228958.0 229296.0 230821.0 231075.0 34032.1 34644.8 36681.6 37148.0 37352.8 46347.5 46675.0 46750.5 46958.0 47453.0 34024.7 34069.0 34423.7 34653.3 34981.0 34008.7 34120.3 34287.1 34492.8 34663.7 39771.4 40273.4 40436.6 40471.4 40486.2 32458.5 32491.2 32670.7 32783.3 32925.5 25139.6 25592.2 25876.9 25970.2 26207.3 04:28:53 INFO - PID 20282 | 04:28:53 INFO - PID 20282 | [#2] jquery.html Cycles:180 Average:40671.24 Median:12566.49 stddev:104716.35 (833.3%) stddev-sans-first:104966.90 04:28:53 INFO - PID 20282 | Values: 605.9 608.3 611.4 617.9 638.4 22864.3 23708.3 23713.9 23759.0 23835.3 24061.4 25548.7 25671.2 25749.7 25787.9 6345.1 6489.5 6508.3 6521.5 6523.6 6304.0 6481.7 6587.3 6609.0 6617.8 6518.5 6572.4 6579.6 6582.3 6582.8 6346.6 6463.7 6524.2 6564.0 6564.6 6138.7 6160.5 6163.2 6164.9 6175.4 30054.7 30674.4 30696.8 30698.2 30708.7 2235.8 2252.0 2253.6 2268.2 2268.7 19913.6 20598.5 20816.2 20959.3 20976.3 2500.1 2515.4 2534.9 2559.7 2570.0 142585.0 147686.0 156707.0 164209.0 164697.0 15859.2 16180.9 16371.7 16658.0 16666.3 25381.4 25471.0 25471.2 25495.9 25528.2 10747.9 10838.0 10942.3 11048.0 11123.8 9837.6 9892.5 9940.1 10099.1 10199.1 9221.2 9573.7 9591.1 9654.6 9859.2 2669.7 2767.3 2816.2 2843.9 2913.6 991.8 1020.3 1037.4 1055.6 1059.7 20404.3 20546.3 20737.6 21409.4 21538.0 1083.9 1102.9 1104.1 1104.4 1105.3 11397.6 11600.9 11809.5 11873.1 11882.9 601636.0 615023.0 616519.0 642756.0 647457.0 134769.0 136549.3 136648.0 137162.0 138410.0 1201.1 1206.8 1224.8 1232.9 1232.9 18747.1 18798.3 18936.6 18984.2 19152.9 63683.7 64983.7 65249.0 65327.7 66300.7 83173.2 83514.6 83889.6 84255.6 84932.6 15254.8 15494.5 15541.8 15555.4 15555.6 23811.2 23811.4 23828.0 23887.4 24100.3 19129.3 19545.2 19794.9 19843.4 19890.0 16826.7 17225.7 17362.7 17405.4 17747.6 19678.3 19783.4 19857.1 20063.6 20181.4 15063.5 15148.8 15188.3 15226.5 15323.8 18368.4 19279.6 19436.9 19658.7 19658.8 04:28:53 INFO - PID 20282 | 04:28:53 INFO - PID 20282 | [#3] mootools.html Cycles:180 Average:10410.24 Median:2600.61 stddev:7674.84 (295.1%) stddev-sans-first:7666.69 04:28:53 INFO - PID 20282 | Values: 1426.6 1478.3 1479.3 1488.4 1490.2 16271.0 17145.7 17157.0 17186.1 17188.7 16730.8 16811.7 16839.3 16853.2 16853.9 2769.1 2811.0 2812.8 2815.3 2815.3 2736.5 2789.4 2802.9 2821.3 2821.5 2683.8 2754.4 2766.1 2771.8 2774.3 2544.4 2605.9 2609.1 2618.3 2619.4 2567.9 2573.0 2581.8 2593.5 2595.3 15626.0 15895.5 15946.3 15984.0 15996.3 7914.8 8262.0 8265.9 8278.0 8285.5 5045.8 5119.7 5164.0 5275.8 5542.2 2089.2 2104.7 2117.6 2149.9 2180.3 26463.5 27105.5 30828.2 31396.1 31521.0 7539.3 7544.7 7562.9 7644.7 7678.5 22709.9 22747.5 22886.1 22895.8 23033.3 8661.0 8706.3 8710.6 8710.6 8712.3 7604.1 7780.3 7815.2 7827.1 7868.9 6011.6 6196.0 6207.9 6225.4 6251.2 1808.8 1845.3 1866.6 1868.3 1873.7 947.0 966.1 974.9 983.0 985.5 8283.3 8340.7 8453.8 8460.2 8463.7 795.0 797.4 799.8 802.7 806.7 5073.0 5087.2 5122.3 5125.4 5167.1 23163.2 23349.9 24464.6 24642.0 24836.0 24033.3 24279.9 24327.5 24369.1 24415.0 11328.7 12504.1 12532.9 12540.1 12622.0 8891.3 9235.0 9349.4 9363.0 9402.3 19406.0 20526.0 20588.7 21185.3 21478.9 21339.5 21430.9 21716.3 21846.0 21854.6 13387.1 13561.9 13576.3 13611.9 13617.0 15490.5 15528.3 15580.5 15684.2 15717.3 12577.7 12603.6 12654.7 12928.4 12953.7 12247.5 12410.1 12915.3 12919.0 12995.9 10918.0 10921.6 10989.3 11090.9 11137.1 8464.1 8517.6 8646.6 8704.4 8757.0 8273.8 8358.2 8377.2 8415.5 8448.8 04:28:53 INFO - PID 20282 | 04:28:53 INFO - PID 20282 | [#4] prototype.html Cycles:180 Average:5697.17 Median:6317.95 stddev:1585.09 (25.1%) stddev-sans-first:1541.68 04:28:53 INFO - PID 20282 | Values: 546.9 576.1 576.6 585.6 589.9 6251.6 6397.7 6402.0 6423.4 6433.9 6248.6 6292.2 6314.6 6316.7 6331.4 5027.2 5085.5 5151.8 5189.7 5196.5 4946.2 5086.2 5089.5 5098.3 5220.4 5049.5 5054.3 5057.9 5067.2 5070.9 5014.4 5026.0 5034.3 5035.2 5039.9 4573.0 4585.2 4589.6 4591.9 4620.5 6233.9 6298.6 6319.1 6325.7 6327.7 5953.6 5999.5 6009.9 6015.4 6040.0 6781.6 6785.0 6801.2 6813.4 6816.2 5129.8 5135.3 5135.6 5146.4 5173.7 6773.4 6963.3 6967.8 6981.5 7120.6 5282.9 5289.7 5294.9 5296.6 5303.7 5331.7 5350.6 5357.7 5366.2 5383.9 5872.3 5881.4 5936.6 5942.8 5979.7 6719.5 6753.7 6759.6 6795.3 6834.9 1824.9 1831.4 1846.4 1847.3 1856.0 1265.8 1293.9 1313.1 1319.8 1323.7 6116.9 6121.8 6126.5 6132.4 6342.3 6630.6 6685.7 6689.2 6825.3 6887.8 6074.0 6107.1 6166.8 6191.4 6297.6 3496.4 3520.1 3546.9 3564.3 3588.6 6940.4 6977.9 7034.8 7045.2 7125.9 6843.6 6909.2 6919.3 7013.5 7070.8 6870.5 6878.8 7004.2 7033.6 7071.8 6645.0 6651.2 6657.8 6788.5 6793.4 6696.1 6715.9 6739.6 6777.5 6833.5 7039.6 7060.5 7061.3 7127.4 7128.8 5253.2 5265.5 5272.3 5301.8 5325.9 6652.8 6806.0 6816.5 6853.6 6902.4 6508.7 6544.4 6699.3 6704.8 6767.2 6640.4 6652.0 6672.0 6676.8 6677.6 6470.7 6477.9 6501.5 6547.7 6635.6 6412.7 6659.2 6713.4 6729.7 6737.8 6486.6 6531.9 6533.4 6571.9 6626.9 04:28:53 INFO - PID 20282 | 04:28:53 INFO - PID 20282 | [#5] yui.html Cycles:180 Average:28555.91 Median:18283.41 stddev:42992.90 (235.1%) stddev-sans-first:43063.56 04:28:53 INFO - PID 20282 | Values: 955.6 965.5 973.4 991.1 995.0 21722.1 25984.1 26026.7 26046.0 26158.2 19147.9 19265.7 19284.7 19302.2 22322.6 1082.4 1089.3 1096.0 1104.0 1104.2 1070.9 1107.1 1110.5 1112.8 1114.4 1159.1 1162.1 1162.4 1162.7 1163.3 1148.3 1156.4 1157.2 1159.1 1159.5 841.8 846.5 848.7 851.6 853.7 19036.6 19343.2 19361.7 19481.4 20626.3 23430.2 23886.0 24394.8 24541.9 24564.3 18121.9 18444.9 18604.9 18655.4 18664.5 3774.4 3826.6 3829.8 3835.0 3839.0 157656.0 158467.2 158876.2 162325.2 162558.0 17729.1 17737.6 17828.3 17952.7 18018.4 35152.8 35627.6 35947.0 36079.5 36114.3 8459.3 8667.1 8724.7 8750.1 8804.0 4365.7 4442.2 4449.6 4460.3 4464.3 6016.9 6041.3 6119.4 6139.5 6141.8 1079.3 1114.9 1127.6 1128.9 1129.4 703.5 703.6 712.8 725.8 729.0 12563.9 12788.6 13112.6 14128.4 14155.6 685.9 686.1 700.0 701.1 703.7 5706.1 5752.9 5822.7 5867.2 5919.4 147039.0 149960.0 151643.0 155223.0 158989.2 134357.3 136262.3 136904.0 136947.0 140879.3 115324.0 116311.4 116747.0 117840.4 118226.0 11238.7 11253.7 11405.2 11531.9 11564.9 53008.5 53108.0 53374.7 54021.5 54306.5 69203.0 69275.3 71044.3 71310.0 72116.0 16734.9 16745.8 16808.9 16857.2 16935.7 19187.2 19293.6 19362.4 19509.4 19614.1 17106.6 17214.3 17332.4 17343.7 17617.3 16487.9 16666.1 16713.7 16810.1 16844.2 16931.0 16954.6 16977.7 17110.7 17353.3 12891.4 13205.4 13332.4 13478.8 13557.7 13254.8 13303.1 13389.1 13461.0 13469.9 04:28:53 INFO - PID 20282 | -------- Summary: end -------- 04:28:53 INFO - PID 20282 | 04:28:54 INFO - TEST-INFO | 20282: exit 0 04:28:54 INFO - TEST-OK | dromaeo_css | took 1107935ms 04:28:54 INFO - TEST-START | kraken 04:28:54 INFO - Initialising browser for kraken test... 04:28:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37993/getInfo.html -profile /tmp/tmp2v9XI6/profile 04:28:54 INFO - TEST-INFO | started process 20652 (/builds/slave/test/build/application/firefox/firefox http://localhost:37993/getInfo.html) 04:28:59 INFO - TEST-INFO | 20652: exit 0 04:28:59 INFO - Browser initialized. 04:28:59 INFO - Running cycle 1/1 for kraken test... 04:28:59 INFO - Using env: {'DISPLAY': ':0', 04:28:59 INFO - 'HOME': '/home/cltbld', 04:28:59 INFO - 'JSGC_DISABLE_POISONING': '1', 04:28:59 INFO - 'LANG': 'en_US.UTF-8', 04:28:59 INFO - 'LANGUAGE': 'en_US:en', 04:28:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:28:59 INFO - 'LOGNAME': 'cltbld', 04:28:59 INFO - 'MAIL': '/var/mail/cltbld', 04:28:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:28:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:28:59 INFO - 'MOZ_CRASHREPORTER': '1', 04:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:28:59 INFO - 'MOZ_NO_REMOTE': '1', 04:28:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:59 INFO - 'NO_EM_RESTART': '1', 04:28:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:59 INFO - 'PWD': '/builds/slave/test', 04:28:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:28:59 INFO - 'RUST_BACKTRACE': 'full', 04:28:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:28:59 INFO - 'SHELL': '/bin/bash', 04:28:59 INFO - 'SHLVL': '1', 04:28:59 INFO - 'STYLO_FORCE_DISABLED': '1', 04:28:59 INFO - 'TERM': 'linux', 04:28:59 INFO - 'TMOUT': '86400', 04:28:59 INFO - 'USER': 'cltbld', 04:28:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072', 04:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:59 INFO - '_': '/tools/buildbot/bin/python'} 04:28:59 INFO - TEST-INFO | started process 20888 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2v9XI6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:29:00 INFO - PID 20888 | 04:29:00 INFO - PID 20888 | (/builds/slave/test/build/application/firefox/firefox:20938): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:29:00 INFO - PID 20888 | 04:29:10 INFO - PID 20888 | RSS: Main: 145235968 04:29:10 INFO - PID 20888 | 04:29:13 INFO - PID 20888 | Cycle 1(1): loaded http://localhost:37993/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37993/tests/kraken/driver.html?testName=audio-beat-detection) 04:29:13 INFO - PID 20888 | RSS: Main: 152276992 04:29:13 INFO - PID 20888 | 04:29:16 INFO - PID 20888 | Cycle 1(1): loaded http://localhost:37993/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37993/tests/kraken/driver.html?testName=audio-dft) 04:29:16 INFO - PID 20888 | RSS: Main: 152195072 04:29:16 INFO - PID 20888 | 04:29:19 INFO - PID 20888 | Cycle 1(1): loaded http://localhost:37993/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37993/tests/kraken/driver.html?testName=audio-fft) 04:29:20 INFO - PID 20888 | RSS: Main: 147574784 04:29:20 INFO - PID 20888 | 04:29:22 INFO - PID 20888 | Cycle 1(1): loaded http://localhost:37993/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37993/tests/kraken/driver.html?testName=audio-oscillator) 04:29:23 INFO - PID 20888 | RSS: Main: 148807680 04:29:23 INFO - PID 20888 | 04:29:25 INFO - PID 20888 | Cycle 1(1): loaded http://localhost:37993/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37993/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:29:25 INFO - PID 20888 | RSS: Main: 148242432 04:29:25 INFO - PID 20888 | 04:29:28 INFO - PID 20888 | Cycle 1(1): loaded http://localhost:37993/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37993/tests/kraken/driver.html?testName=imaging-darkroom) 04:29:29 INFO - PID 20888 | RSS: Main: 148320256 04:29:29 INFO - PID 20888 | 04:29:33 INFO - PID 20888 | Cycle 1(1): loaded http://localhost:37993/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37993/tests/kraken/driver.html?testName=imaging-desaturate) 04:29:33 INFO - PID 20888 | RSS: Main: 149458944 04:29:33 INFO - PID 20888 | 04:29:36 INFO - PID 20888 | Cycle 1(1): loaded http://localhost:37993/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37993/tests/kraken/driver.html?testName=json-parse-financial) 04:29:37 INFO - PID 20888 | RSS: Main: 151334912 04:29:37 INFO - PID 20888 | 04:29:38 INFO - PID 20888 | Cycle 1(1): loaded http://localhost:37993/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37993/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:29:39 INFO - PID 20888 | RSS: Main: 151515136 04:29:39 INFO - PID 20888 | 04:29:40 INFO - PID 20888 | Cycle 1(1): loaded http://localhost:37993/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37993/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:29:41 INFO - PID 20888 | RSS: Main: 151347200 04:29:41 INFO - PID 20888 | 04:29:43 INFO - PID 20888 | Cycle 1(1): loaded http://localhost:37993/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37993/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:29:44 INFO - PID 20888 | RSS: Main: 148520960 04:29:44 INFO - PID 20888 | 04:29:46 INFO - PID 20888 | Cycle 1(1): loaded http://localhost:37993/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37993/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:29:47 INFO - PID 20888 | RSS: Main: 148471808 04:29:47 INFO - PID 20888 | 04:29:49 INFO - PID 20888 | Cycle 1(1): loaded http://localhost:37993/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37993/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:50 INFO - PID 20888 | RSS: Main: 148754432 04:29:50 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | Cycle 1(1): loaded http://localhost:37993/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37993/tests/kraken/driver.html?testName=ai-astar) 04:29:52 INFO - PID 20888 | RSS: Main: 150454272 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | __start_tp_report 04:29:52 INFO - PID 20888 | _x_x_mozilla_page_load 04:29:52 INFO - PID 20888 | _x_x_mozilla_page_load_details 04:29:52 INFO - PID 20888 | |i|pagename|runs| 04:29:52 INFO - PID 20888 | |0;ai-astar;109;106;105;107;105;106;106;105;105;105 04:29:52 INFO - PID 20888 | |1;audio-beat-detection;113;112;112;109;116;121;113;117;110;111 04:29:52 INFO - PID 20888 | |2;audio-dft;161;164;163;161;163;162;163;162;165;163 04:29:52 INFO - PID 20888 | |3;audio-fft;77;75;74;75;75;73;72;74;73;74 04:29:52 INFO - PID 20888 | |4;audio-oscillator;78;79;78;77;78;79;79;82;79;78 04:29:52 INFO - PID 20888 | |5;imaging-gaussian-blur;111;113;113;114;113;113;112;114;114;110 04:29:52 INFO - PID 20888 | |6;imaging-darkroom;149;149;152;149;149;149;150;149;151;151 04:29:52 INFO - PID 20888 | |7;imaging-desaturate;96;94;93;94;94;94;94;94;94;94 04:29:52 INFO - PID 20888 | |8;json-parse-financial;44;45;45;45;44;45;45;44;44;45 04:29:52 INFO - PID 20888 | |9;json-stringify-tinderbox;36;36;36;36;36;37;38;43;37;37 04:29:52 INFO - PID 20888 | |10;stanford-crypto-aes;72;72;71;71;72;71;70;69;71;73 04:29:52 INFO - PID 20888 | |11;stanford-crypto-ccm;110;111;104;108;110;112;113;103;105;103 04:29:52 INFO - PID 20888 | |12;stanford-crypto-pbkdf2;153;152;150;150;151;162;159;152;149;154 04:29:52 INFO - PID 20888 | |13;stanford-crypto-sha256-iterative;59;60;60;59;62;60;60;58;60;60 04:29:52 INFO - PID 20888 | __end_tp_report 04:29:52 INFO - PID 20888 | __start_cc_report 04:29:52 INFO - PID 20888 | _x_x_mozilla_cycle_collect,670 04:29:52 INFO - PID 20888 | __end_cc_report 04:29:52 INFO - PID 20888 | __startTimestamp1506511792270__endTimestamp 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | ------- Summary: start ------- 04:29:52 INFO - PID 20888 | Number of tests: 14 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | [#0] ai-astar Cycles:10 Average:105.90 Median:106.00 stddev:1.29 (1.2%) stddev-sans-first:0.73 04:29:52 INFO - PID 20888 | Values: 109.0 106.0 105.0 107.0 105.0 106.0 106.0 105.0 105.0 105.0 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | [#1] audio-beat-detection Cycles:10 Average:113.40 Median:113.00 stddev:3.63 (3.2%) stddev-sans-first:3.84 04:29:52 INFO - PID 20888 | Values: 113.0 112.0 112.0 109.0 116.0 121.0 113.0 117.0 110.0 111.0 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.25 (0.8%) stddev-sans-first:1.17 04:29:52 INFO - PID 20888 | Values: 161.0 164.0 163.0 161.0 163.0 162.0 163.0 162.0 165.0 163.0 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | [#3] audio-fft Cycles:10 Average:74.20 Median:74.50 stddev:1.40 (1.9%) stddev-sans-first:1.05 04:29:52 INFO - PID 20888 | Values: 77.0 75.0 74.0 75.0 75.0 73.0 72.0 74.0 73.0 74.0 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | [#4] audio-oscillator Cycles:10 Average:78.70 Median:79.00 stddev:1.34 (1.7%) stddev-sans-first:1.39 04:29:52 INFO - PID 20888 | Values: 78.0 79.0 78.0 77.0 78.0 79.0 79.0 82.0 79.0 78.0 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | [#5] imaging-gaussian-blur Cycles:10 Average:112.70 Median:113.00 stddev:1.34 (1.2%) stddev-sans-first:1.27 04:29:52 INFO - PID 20888 | Values: 111.0 113.0 113.0 114.0 113.0 113.0 112.0 114.0 114.0 110.0 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:149.50 stddev:1.14 (0.8%) stddev-sans-first:1.17 04:29:52 INFO - PID 20888 | Values: 149.0 149.0 152.0 149.0 149.0 149.0 150.0 149.0 151.0 151.0 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.33 04:29:52 INFO - PID 20888 | Values: 96.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | [#8] json-parse-financial Cycles:10 Average:44.60 Median:45.00 stddev:0.52 (1.1%) stddev-sans-first:0.50 04:29:52 INFO - PID 20888 | Values: 44.0 45.0 45.0 45.0 44.0 45.0 45.0 44.0 44.0 45.0 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | [#9] json-stringify-tinderbox Cycles:10 Average:37.20 Median:37.00 stddev:2.15 (5.8%) stddev-sans-first:2.24 04:29:52 INFO - PID 20888 | Values: 36.0 36.0 36.0 36.0 36.0 37.0 38.0 43.0 37.0 37.0 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | [#10] stanford-crypto-aes Cycles:10 Average:71.20 Median:71.50 stddev:1.14 (1.6%) stddev-sans-first:1.17 04:29:52 INFO - PID 20888 | Values: 72.0 72.0 71.0 71.0 72.0 71.0 70.0 69.0 71.0 73.0 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | [#11] stanford-crypto-ccm Cycles:10 Average:107.90 Median:110.00 stddev:3.84 (3.5%) stddev-sans-first:4.00 04:29:52 INFO - PID 20888 | Values: 110.0 111.0 104.0 108.0 110.0 112.0 113.0 103.0 105.0 103.0 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.20 Median:152.50 stddev:4.18 (2.7%) stddev-sans-first:4.44 04:29:52 INFO - PID 20888 | Values: 153.0 152.0 150.0 150.0 151.0 162.0 159.0 152.0 149.0 154.0 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.80 Median:60.00 stddev:1.03 (1.7%) stddev-sans-first:1.05 04:29:52 INFO - PID 20888 | Values: 59.0 60.0 60.0 59.0 62.0 60.0 60.0 58.0 60.0 60.0 04:29:52 INFO - PID 20888 | -------- Summary: end -------- 04:29:52 INFO - PID 20888 | 04:29:52 INFO - PID 20888 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:29:52 INFO - TEST-INFO | 20888: exit 0 04:29:52 INFO - TEST-OK | kraken | took 58651ms 04:29:52 INFO - SUITE-END | took 1166s 04:29:52 INFO - Completed test suite (00:19:26) 04:29:52 INFO - javascript benchmark 04:29:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9067.067180111719, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3887.9805600972, 3888.6889048876087, 3892.0853599404118, 3896.8441262349525, 3917.745346552474, 6203.627782333063, 6205.131281620571, 6248.15649887265, 6316.905246421307, 6377.7448902043925, 6283.340249273829, 6298.779542716006, 6317.526185536091, 6321.52588555859, 6345.904811427832, 5546.77812887484, 5567.860803479925, 5621.887562248752, 5629.521490673298, 5693.345265294482, 5650.124230744221, 5691.772329106851, 5692.345380281258, 5724.856878578048, 5743.195952566644, 5622.8313150605345, 5654.6889921054535, 5722.742476588543, 5724.227229324029, 5736.799212027579, 5434.91847622286, 5576.749046292886, 5588.580856435743, 5639.3232812062815, 5657.20799088128, 5571.777128914879, 5576.302962129734, 5636.323641163087, 5638.774449022075, 5661.547076233933, 6210.192674952227, 6211.937880621226, 6239.87520249597, 6285.088662143963, 6285.151504546873, 6783.830404239884, 6807.897881531781, 6817.897731534031, 6824.488163387766, 6826.726930922807, 6799.932000679979, 6860.725570977155, 6879.5184337096425, 6956.5478243913985, 6958.095447591781, 6245.500359971192, 6307.716152773136, 6308.116863639094, 6406.743730250738, 6421.903671444932, 6942.06282151903, 6972.686229119702, 7016.508844380946, 7025.262347453444, 7044.154701435758, 6673.099131617267, 6725.125733654593, 6799.524033317719, 6816.659167041628, 6821.522493425413, 6734.730610775612, 6813.693383797741, 6824.351686589766, 6837.658117094125, 6843.0419741236265, 6705.865882682319, 6768.323167683192, 6799.3200679931615, 6805.489588280899, 6813.625250611165, 6704.932950670431, 6864.485163612749, 6867.278935711778, 6871.759488417882, 6879.965600171967, 4961.305417241589, 4990.775415106329, 5013.39839219296, 5040.117979353672, 5073.061483625541, 4444.777761111932, 4506.752128632957, 4508.211063063951, 4528.660350473728, 4535.160995215896, 6194.0, 6223.657698826518, 6252.374762523711, 6260.217472815898, 6268.655223962726, 6783.660816959133, 6817.829554261183, 6869.278725733726, 6876.209235937831, 6879.174499060045, 6251.437370636664, 6260.311365749764, 6267.4986001119805, 6333.524985626096, 6344.302126766052, 5465.508104270555, 5551.777928882881, 5576.776928922797, 5580.748866301026, 5594.412586678422, 7005.614691191931, 7015.9298407016295, 7019.789406317818, 7040.0, 7108.68010939509, 6748.392644662004, 6814.182298124257, 6821.113255276782, 6835.0, 6839.042534045138, 6998.370146686822, 7007.6145811978795, 7034.824129396806, 7093.32613401726, 7107.538010029331, 6684.465242780663, 6739.494537909774, 6775.695093720696, 6812.965935170292, 6833.282505336868, 6855.760048398282, 6882.4149947253045, 6883.449324053963, 6883.586984780929, 6886.345797149263, 6538.346165383424, 6550.082988381726, 6600.735970561123, 6622.403983641495, 6637.435817955527, 6539.574927629689, 6604.570702904296, 6617.702203400762, 6625.469962403093, 6626.834329141617, 6473.287938326875, 6483.740650373932, 6486.05952136947, 6571.572847765071, 6580.407763301326, 6563.901541476977, 6615.536912416084, 6659.267480577036, 6668.799936001928, 6690.69891854858, 6364.936350636434, 6438.517111216771, 6455.225372955088, 6545.345465453607, 6545.541812073109], "value": 6221.737034809496, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [912.3886995712871, 971.8687977123088, 999.5751805482668, 999.7800483893541, 1001.514265581193, 43697.78151109244, 44737.10525789482, 44770.776146119264, 44783.104337913224, 44853.77573112138, 42251.15497690052, 42256.0, 42466.150676986515, 42602.573974260245, 42607.14785704284, 7513.248675132498, 7631.503952243114, 7653.502522336058, 7675.385969122457, 7677.808054798619, 7411.221821708724, 7511.887321690179, 7514.286142816423, 7527.322540971311, 7549.320561149495, 8369.414141010131, 8584.656613735475, 8593.441426307301, 8597.011343695493, 8603.698870539532, 8466.83066338676, 8477.237048665618, 8489.95755021221, 8515.40392172545, 8533.274671652916, 8206.630701618442, 8428.0, 8430.283425908805, 8431.40980131391, 8433.451825631375, 41255.7937210312, 41524.792376038225, 41550.79224603888, 41561.79219103915, 41597.79201104005, 3731.160488890005, 3764.416515440111, 3793.791341476218, 3796.8291426885858, 3797.696184305249, 32822.6717732822, 33107.0, 33180.668193318, 33228.83385583081, 33455.83272083624, 5198.454162312978, 5258.2638430619745, 5269.130593452076, 5291.4708529147165, 5295.364556253236, 210721.0, 212852.0, 212936.0, 212989.0, 213518.0, 46538.53461465342, 46692.53307466882, 53637.0, 54207.186892196645, 54277.0, 57883.0, 57922.7103864478, 58088.70955645279, 58131.709341453025, 58147.70926145342, 17322.307107715802, 17484.65030699379, 17574.912125439292, 17583.29666813313, 17597.032163231146, 14268.714625707427, 14456.060356076821, 14528.782068268985, 14534.709305813825, 14540.345684444013, 15424.5372638821, 15429.845701542841, 15500.30248638814, 15561.688766224612, 15707.842921570638, 6041.495932359221, 6099.359567245376, 6150.7847225346895, 6276.403741644536, 6299.338569450142, 1092.9289596176222, 1093.185576745314, 1099.6481126039591, 1100.4497751124438, 1101.3391964821203, 25308.873455632605, 25555.87222063878, 25613.871930640227, 25688.229353119437, 25759.0, 1196.6888608961733, 1210.9455074521668, 1212.4362171590253, 1217.0, 1225.2158618484177, 13364.799528007088, 13556.389962451516, 13616.38726257301, 13721.382537785823, 13725.176489410667, 279899.0, 280872.0, 280892.0, 280948.0, 281248.0, 58100.12849807256, 58108.12837807436, 58316.4168358311, 58473.70763146242, 58494.4150558489, 1514.4623658601258, 1532.6168457885528, 1544.7296723073416, 1558.649303906612, 1560.9843901561067, 24852.502949941263, 24895.253142405756, 25045.624315635643, 25045.87477062603, 25149.0, 41903.371449428894, 41950.370744438245, 42125.99999999877, 42168.0, 42257.154856903304, 227580.0, 228958.0, 229296.0, 230821.0, 231075.0, 34032.1491962693, 34644.82677586596, 36681.63318366782, 37148.0, 37352.75883447002, 46347.53652463432, 46675.0, 46750.53249467462, 46958.0, 47453.0, 34024.65975340215, 34069.0, 34423.655763442046, 34653.30693386068, 34981.0, 34008.65991340055, 34120.317593647495, 34287.14282142966, 34492.82753586216, 34663.653363466045, 39771.40342894801, 40273.395899062125, 40436.59563404446, 40471.392929105496, 40486.1902761949, 32458.513122302713, 32491.18772030718, 32670.673293267715, 32783.34433311368, 32925.50611740778, 25139.622905656797, 25592.23223303304, 25876.8706156468, 25970.22089337323, 26207.344816379744], "value": 18611.304354399846, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.9242594675662, 608.2725060827249, 611.4435863364337, 617.876424715057, 638.3680156644922, 22864.31407057789, 23708.288751337444, 23713.881430592824, 23759.0, 23835.28494145174, 24061.39846503834, 25548.74451255487, 25671.229863104138, 25749.74250257497, 25787.871060644717, 6345.111684364181, 6489.545731798776, 6508.316626754194, 6521.543491955565, 6523.641199734013, 6303.968480157593, 6481.708323125447, 6587.275399706028, 6608.966955165218, 6617.8014659560295, 6518.543701940866, 6572.44134248587, 6579.638119903403, 6582.275949645536, 6582.835429114262, 6346.619202847844, 6463.709133088999, 6524.184476940382, 6564.048213009087, 6564.573302735331, 6138.662373569452, 6160.507159427235, 6163.167972323724, 6164.87670246597, 6175.3515880832765, 30054.699453005407, 30674.38651226985, 30696.84651576728, 30698.23254418635, 30708.69291307103, 2235.7652446493207, 2252.0, 2253.6056190166655, 2268.1834539565743, 2268.65970104484, 19913.60172796536, 20598.485037874023, 20816.16735330585, 20959.26642567503, 20976.265830696004, 2500.1499490173246, 2515.371157210697, 2534.9239522814346, 2559.7056338521124, 2569.974300257011, 142585.0, 147686.0, 156707.0, 164209.0, 164697.0, 15859.224635688708, 16180.919095404448, 16371.672566548841, 16658.0, 16666.250018749186, 25381.365465863502, 25471.0, 25471.235862924143, 25495.872520637276, 25528.23415297544, 10747.946260268805, 10838.0, 10942.288751231305, 11048.0, 11123.833142502868, 9837.55730992107, 9892.505374731234, 9940.055694708992, 10099.14157296638, 10199.0820826126, 9221.219300086932, 9573.664921727706, 9591.136797688241, 9654.565544550513, 9859.161971232383, 2669.6529451171614, 2767.266674331304, 2816.1973837456226, 2843.9146825595267, 2913.592097106407, 991.8214721350226, 1020.2552136940076, 1037.444966942682, 1055.646358469921, 1059.7032830807386, 20404.285849995475, 20546.28088016912, 20737.58524829525, 21409.357719268446, 21538.0, 1083.9078678312433, 1102.873169585492, 1104.089126470665, 1104.4312179227543, 1105.2594761509808, 11397.601083962021, 11600.88399115998, 11809.468573914195, 11873.050155987501, 11882.88117118835, 601636.0, 615023.0, 616519.0, 642756.0, 647457.0, 134769.0, 136549.3172534131, 136648.0, 137162.0, 138410.0, 1201.1248318865387, 1206.7707135644375, 1224.7734169178552, 1232.8767123287778, 1232.9445174967148, 18747.062646867875, 18798.3420580279, 18936.621267574847, 18984.240630374632, 19152.904235478734, 63683.681581591794, 64983.675081624286, 65249.021264682015, 65327.673361632886, 66300.6684966572, 83173.16826831654, 83514.58242708747, 83889.58055209684, 84255.57872210845, 84932.57533712292, 15254.77117843211, 15494.457693980656, 15541.766873496681, 15555.377784888931, 15555.611109722347, 23811.166609168595, 23811.40471488227, 23828.0, 23887.40281492907, 24100.276991690276, 19129.33047343336, 19545.218191272757, 19794.90102549478, 19843.40469785909, 19890.0, 16826.663466730843, 17225.74161387555, 17362.65274694524, 17405.39081132205, 17747.645047099242, 19678.311259105863, 19783.40649780509, 19857.106430210388, 20063.59872802565, 20181.39455816328, 15063.54809355721, 15148.848511515185, 15188.316525756147, 15226.543203703906, 15323.770143447635, 18368.448946531626, 19279.614407712048, 19436.90281548583, 19658.705119423506, 19658.8034119657], "value": 12744.603880373512, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.6076828872062, 1478.3125846481385, 1479.2825479642372, 1488.4418343121329, 1490.180400779571, 16271.0, 17145.657086858257, 17157.0, 17186.05476698781, 17188.65622687547, 16730.83269167308, 16811.747823782654, 16839.32642694294, 16853.241604127812, 16853.91573042133, 2769.127724766697, 2811.030194582876, 2812.817166884156, 2815.2539577012108, 2815.3383954770716, 2736.493748656495, 2789.3584475570633, 2802.9439411211765, 2821.252368122439, 2821.463921854841, 2683.758461738443, 2754.380264440505, 2766.101017169418, 2771.764400026, 2774.3480282133683, 2544.3511904464426, 2605.9348516287055, 2609.073778808515, 2618.2668852721267, 2619.3582572269725, 2567.9101231457, 2573.0479722502605, 2581.832180908235, 2593.4942686176205, 2595.2862962685413, 15626.0, 15895.52313430599, 15946.28241729125, 15984.0, 15996.280167392495, 7914.762557123296, 8261.958690206511, 8265.876011859827, 8277.95861020697, 8285.461445006054, 5045.84862454127, 5119.692818430869, 5164.04465173944, 5275.762590683428, 5542.196381524656, 2089.2478707665227, 2104.6527322991687, 2117.6400011998, 2149.9462513437134, 2180.324099529151, 26463.47073058547, 27105.45789084227, 30828.2292942676, 31396.05811825626, 31520.99999999977, 7539.283768042027, 7544.698212071456, 7562.886556701544, 7644.6942122315595, 7678.500897441649, 22709.886450567643, 22747.545049098924, 22886.08455661755, 22895.771042289365, 23033.309000730005, 8661.0, 8706.303495720327, 8710.564471776386, 8710.608022638997, 8712.303015758724, 7604.087509498895, 7780.299773020455, 7815.179406162385, 7827.099883513355, 7868.881966770503, 6011.579189456696, 6195.96902015496, 6207.906881396782, 6225.408586184305, 6251.249850018027, 1808.7739032620923, 1845.2895635180553, 1866.5986812835306, 1868.2526989204428, 1873.681474149398, 946.990530094704, 966.087047739879, 974.9463779492054, 982.9852552211722, 985.5417230987625, 8283.29591984676, 8340.666373345119, 8453.788655283544, 8460.196281353261, 8463.661453541912, 794.9960250198712, 797.4218691448654, 799.8160423102603, 802.7431222009018, 806.6934564865431, 5072.974635126875, 5087.186050231945, 5122.257272695439, 5125.410577783603, 5167.121589329823, 23163.189288374826, 23349.88325058364, 24464.633030504556, 24642.0, 24836.0, 24033.27900162998, 24279.878600606884, 24327.51344973126, 24369.14707985212, 24415.023399064194, 11328.71678208035, 12504.124711270306, 12532.937335313447, 12540.122191446693, 12621.990240780715, 8891.288696904103, 9235.0, 9349.392289501433, 9362.95318523403, 9402.34183607141, 19405.958390126132, 20526.0, 20588.691169632766, 21185.258515951868, 21478.892605536872, 21339.46651333667, 21430.892845535673, 21716.34850954474, 21846.0, 21854.562908742053, 13387.062905596904, 13561.932190338985, 13576.253306068262, 13611.86388136106, 13617.0, 15490.457833975757, 15528.301226444612, 15580.454684086002, 15684.215789210266, 15717.292721827775, 12577.685557861127, 12603.621891343275, 12654.683632909251, 12928.418221179882, 12953.676158096123, 12247.510099596273, 12410.131290809557, 12915.289659068465, 12919.0, 12995.935020324838, 10918.0, 10921.617743378943, 10989.340639561333, 11090.889091108986, 11137.10903127764, 8464.140663200764, 8517.574121293786, 8646.622178900852, 8704.390692651454, 8756.956215218883, 8273.83452330962, 8358.247757701836, 8377.246047855722, 8415.53714545706, 8448.83102337962], "value": 7251.984341237408, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.9124940009599, 576.124291077562, 576.6482445708118, 585.5549782165552, 589.9439553242444, 6251.59364641298, 6397.744090236391, 6401.967990160048, 6423.394151462135, 6433.903491447621, 6248.594066335072, 6292.238173311469, 6314.589551679138, 6316.74733010679, 6331.430171284584, 5027.170516864731, 5085.491450854922, 5151.7681704323395, 5189.662671926331, 5196.532312091911, 4946.233333833244, 5086.160783470723, 5089.549478398657, 5098.311727916721, 5220.425753167148, 5049.4950504949575, 5054.292399064134, 5057.898842023157, 5067.239914012909, 5070.923936140961, 5014.423341315759, 5026.0, 5034.270030845543, 5035.169197082477, 5039.899202015976, 4573.0, 4585.243434833248, 4589.609883159902, 4591.931121033187, 4620.491745907947, 6233.87532249357, 6298.551333193345, 6319.14691516644, 6325.683715814191, 6327.746890124389, 5953.58324917256, 5999.520038396918, 6009.909851352233, 6015.428534289235, 6039.969800150971, 6781.593104413701, 6785.01459357881, 6801.163685804854, 6813.386795188457, 6816.216135144423, 5129.820456284012, 5135.281060651511, 5135.614828887811, 5146.356705411824, 5173.663711858717, 6773.3903948644365, 6963.338482844122, 6967.79096627102, 6981.544135652834, 7120.608366539838, 5282.867928301746, 5289.735513224324, 5294.92057619136, 5296.629235953446, 5303.711698746724, 5331.653442526223, 5350.6254562180275, 5357.7053262070185, 5366.248725178478, 5383.919241211385, 5872.29532456108, 5881.3530511643685, 5936.575221946701, 5942.762289508458, 5979.701014949323, 6719.496037797185, 6753.729850806011, 6759.5606285591275, 6795.320467953264, 6834.897476537856, 1824.8905065696101, 1831.4432732177809, 1846.4028615247714, 1847.2980267498265, 1855.997761208959, 1265.8480982282001, 1293.9029572782079, 1313.1464548043657, 1319.7558451686468, 1323.7358322801701, 6116.877662446726, 6121.846953826101, 6126.479249263773, 6132.41742034506, 6342.270638876588, 6630.635315057718, 6685.726852870048, 6689.230738465041, 6825.283345248777, 6887.758928437581, 6074.0, 6107.144999700045, 6166.784162554289, 6191.35928978821, 6297.559170858088, 3496.4405695088662, 3520.1375662962228, 3546.946795798065, 3564.287142571496, 3588.569371675416, 6940.375366217065, 6977.930220697728, 7034.788956331318, 7045.189803172599, 7125.89311160333, 6843.58588710279, 6909.205441374206, 6919.273476285019, 7013.509054366247, 7070.823229419306, 6870.484713646497, 6878.759243426456, 7004.15950085993, 7033.577985321, 7071.752488662872, 6644.966775166094, 6651.235107962452, 6657.833554160991, 6788.4569234462115, 6793.388595026471, 6696.111838358123, 6715.899261511179, 6739.59562426256, 6777.45780337562, 6833.521653484408, 7039.577625342496, 7060.54106483077, 7061.329173728487, 7127.394171495481, 7128.750493732695, 5253.159494481018, 5265.4997775211295, 5272.258425618734, 5301.761420736153, 5325.946740532545, 6652.837827706112, 6806.0, 6816.454683625398, 6853.554518956252, 6902.447804175755, 6508.674566271762, 6544.3782840630065, 6699.263081061177, 6704.765333213314, 6767.1879374475375, 6640.369164929517, 6651.966740166462, 6672.0, 6676.799696009128, 6677.631085627532, 6470.708818103102, 6477.890612505929, 6501.472154043701, 6547.70535325902, 6635.568688035262, 6412.743490260337, 6659.2008958925235, 6713.4488894219885, 6729.730810767514, 6737.797866064026, 6486.643234622141, 6531.9020214695865, 6533.41199292066, 6571.901421478586, 6626.90059649096], "value": 5242.150663741292, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [955.6129767444186, 965.4786415335715, 973.3819024919175, 991.0782971836189, 994.9602015919363, 21722.13111475541, 25984.090556830513, 26026.73973260269, 26046.0, 26158.2152535424, 19147.904260478677, 19265.711014334796, 19284.710729339036, 19302.227910883583, 22322.553548929052, 1082.3668154129823, 1089.2756317049193, 1095.9726006849853, 1104.0339702760084, 1104.2049724198564, 1070.946452677367, 1107.141964977145, 1110.455876620454, 1112.8108221602347, 1114.381518257367, 1159.0669511043607, 1162.1400163878754, 1162.4187906046977, 1162.6860747598143, 1163.331084626339, 1148.3339662995484, 1156.3813359852438, 1157.184185149472, 1159.113278342069, 1159.4782347943417, 841.8105926166625, 846.5259454705384, 848.7326492155013, 851.5827244650138, 853.6542700206427, 19036.619267614707, 19343.226270949144, 19361.709574356395, 19481.415557533295, 20626.27808026712, 23430.17994370206, 23886.0, 24394.756052439603, 24541.87729061361, 24564.263072107864, 18121.909390453096, 18444.907775461037, 18604.906975465172, 18655.440336789918, 18664.533386665305, 3774.3960966245268, 3826.598207188233, 3829.770213787154, 3834.9616503835164, 3838.9826695925603, 157655.99999999886, 158467.2076639621, 158876.2056189723, 162325.18837405738, 162558.0, 17729.113544322732, 17737.645247094984, 17828.286868525374, 17952.730709039373, 18018.36935707244, 35152.82423587866, 35627.64372356295, 35947.0, 36079.4588081179, 36114.27771444556, 8459.280961118251, 8667.13328667141, 8724.69463568772, 8750.124987501198, 8804.0, 4365.738055716667, 4442.222611043055, 4449.57729015743, 4460.264056430718, 4464.330350447459, 6016.909746353721, 6041.2750469943885, 6119.357467465852, 6139.508839292846, 6141.84645383869, 1079.3469950679882, 1114.9275297105662, 1127.639155470258, 1128.8532490776147, 1129.4014172488594, 703.4688809948456, 703.5602748282323, 712.7968528969219, 725.804032911111, 729.0413106764694, 12563.874361256454, 12788.616341509769, 13112.606621801362, 14128.43486260538, 14155.575332740034, 685.9348361905611, 686.0772261308532, 700.0, 701.137600751079, 703.711478293897, 5706.065691680688, 5752.856178595569, 5822.7088645567555, 5867.207926929896, 5919.4080591940465, 147039.0, 149960.0, 151643.0, 155223.0, 158989.205053974, 134357.3282133583, 136262.31868840792, 136904.0, 136947.0, 140879.29560352338, 115324.0, 116311.41844290725, 116747.0, 117840.41079794546, 118226.0, 11238.66284011481, 11253.71865703364, 11405.201635885409, 11531.884681153417, 11564.884351156381, 53008.469915301896, 53108.0, 53374.73312633412, 54021.45978540322, 54306.45693543014, 69203.0, 69275.30724692688, 71044.28955710377, 71310.0, 72116.0, 16734.916325418297, 16745.832541674914, 16808.915955420143, 16857.241424135696, 16935.745963810798, 19187.232510699974, 19293.614127717086, 19362.4191274262, 19509.414717558495, 19614.117364718335, 17106.572335691708, 17214.311427542758, 17332.39336623212, 17343.739843902098, 17617.295308187528, 16487.917560412123, 16666.08336541502, 16713.749293760848, 16810.075445850594, 16844.15779211059, 16931.0, 16954.576135596217, 16977.74533382025, 17110.657786844444, 17353.30586776515, 12891.41988610496, 13205.405756740778, 13332.40004199794, 13478.79781803254, 13557.661058473223, 13254.80117798253, 13303.135296205715, 13389.129706569041, 13461.0, 13469.865301346861], "value": 9903.60783959755, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1365.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 106.0, 105.0, 107.0, 105.0, 106.0, 106.0, 105.0, 105.0, 105.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 112.0, 109.0, 116.0, 121.0, 113.0, 117.0, 110.0, 111.0], "value": 113.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 163.0, 161.0, 163.0, 162.0, 163.0, 162.0, 165.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 74.0, 75.0, 75.0, 73.0, 72.0, 74.0, 73.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 77.0, 78.0, 79.0, 79.0, 82.0, 79.0, 78.0], "value": 78.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 114.0, 113.0, 113.0, 112.0, 114.0, 114.0, 110.0], "value": 112.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 152.0, 149.0, 149.0, 149.0, 150.0, 149.0, 151.0, 151.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 45.0, 45.0, 45.0, 44.0, 45.0, 45.0, 44.0, 44.0, 45.0], "value": 44.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 36.0, 36.0, 36.0, 37.0, 38.0, 43.0, 37.0, 37.0], "value": 37.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 71.0, 71.0, 72.0, 71.0, 70.0, 69.0, 71.0, 73.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 104.0, 108.0, 110.0, 112.0, 113.0, 103.0, 105.0, 103.0], "value": 107.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 150.0, 150.0, 151.0, 162.0, 159.0, 152.0, 149.0, 154.0], "value": 153.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 62.0, 60.0, 60.0, 58.0, 60.0, 60.0], "value": 59.8, "unit": "score"}]}]} 04:29:53 INFO - Return code: 0 04:29:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:29:53 INFO - # TBPL SUCCESS # 04:29:53 INFO - Running post-action listener: _package_coverage_data 04:29:53 INFO - Running post-action listener: _resource_record_post_action 04:29:53 INFO - [mozharness: 2017-09-27 11:29:53.099890Z] Finished run-tests step (success) 04:29:53 INFO - Running post-run listener: _resource_record_post_run 04:29:53 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 331186176; Read time: 0; Write time: 294856 04:29:53 INFO - TinderboxPrint: CPU usage
13.1% 04:29:53 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:29:53 INFO - TinderboxPrint: I/O write bytes / time
331,186,176 / 294,856 04:29:53 INFO - TinderboxPrint: CPU idle
8,213.6 (86.9%) 04:29:53 INFO - TinderboxPrint: CPU user
1,186.1 (12.6%) 04:29:53 INFO - TinderboxPrint: Swap in / out
0 / 0 04:29:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12484608; Read time: 0; Write time: 3024 04:29:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:29:53 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 0; Write bytes: 318701568; Read time: 0; Write time: 291832 04:29:53 INFO - Running post-run listener: _upload_blobber_files 04:29:53 INFO - Blob upload gear active. 04:29:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:29:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:29:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:29:54 INFO - (blobuploader) - INFO - Open directory for files ... 04:29:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:29:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:29:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:55 INFO - (blobuploader) - INFO - Done attempting. 04:29:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:29:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:29:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:56 INFO - (blobuploader) - INFO - Done attempting. 04:29:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:29:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:57 INFO - (blobuploader) - INFO - Done attempting. 04:29:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:29:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:30:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:04 INFO - (blobuploader) - INFO - Done attempting. 04:30:04 INFO - (blobuploader) - INFO - Iteration through files over. 04:30:04 INFO - Return code: 0 04:30:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:30:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:30:04 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cecd51686c906cc67ad54e40ec5e2458d19daef0ae6657cd32d9d7bbae70c7155035cf5ca722f9c1949cd428b2e5f57ace9525624897b0f4997a692c16697173", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a95407a9b69a816e62f19e79be7558bf7618e0d722c469b596fe33d4f674e7680d97b87bc084c6237590110638227c285cdea4c5f88d5d750879714c85eadab", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82ef9bedd8bda4f95a44797e831472ce90b81ce7a6f897f529ebfe19e7a14e7c738f0b4f25f16931d0b66e472101268042da563ddc858f901bfcd9f21cb87742", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07caf12db349b008a911bc22330be0b55bfeb62beb4d145508c400c71dc26bcef5306dd729576af8fa1bd84ccc9a89961d9e2fc5a98b5b90c0043f4f1cf82922"} 04:30:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:30:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:30:04 INFO - Contents: 04:30:04 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cecd51686c906cc67ad54e40ec5e2458d19daef0ae6657cd32d9d7bbae70c7155035cf5ca722f9c1949cd428b2e5f57ace9525624897b0f4997a692c16697173", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a95407a9b69a816e62f19e79be7558bf7618e0d722c469b596fe33d4f674e7680d97b87bc084c6237590110638227c285cdea4c5f88d5d750879714c85eadab", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82ef9bedd8bda4f95a44797e831472ce90b81ce7a6f897f529ebfe19e7a14e7c738f0b4f25f16931d0b66e472101268042da563ddc858f901bfcd9f21cb87742", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07caf12db349b008a911bc22330be0b55bfeb62beb4d145508c400c71dc26bcef5306dd729576af8fa1bd84ccc9a89961d9e2fc5a98b5b90c0043f4f1cf82922"} 04:30:04 INFO - Running post-run listener: copy_logs_to_upload_dir 04:30:04 INFO - Copying logs to upload dir... 04:30:04 INFO - mkdir: /builds/slave/test/build/upload/logs 04:30:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.295641 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-27 04:30:04.510938) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 04:30:04.515298) ========= 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=826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cecd51686c906cc67ad54e40ec5e2458d19daef0ae6657cd32d9d7bbae70c7155035cf5ca722f9c1949cd428b2e5f57ace9525624897b0f4997a692c16697173", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a95407a9b69a816e62f19e79be7558bf7618e0d722c469b596fe33d4f674e7680d97b87bc084c6237590110638227c285cdea4c5f88d5d750879714c85eadab", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82ef9bedd8bda4f95a44797e831472ce90b81ce7a6f897f529ebfe19e7a14e7c738f0b4f25f16931d0b66e472101268042da563ddc858f901bfcd9f21cb87742", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07caf12db349b008a911bc22330be0b55bfeb62beb4d145508c400c71dc26bcef5306dd729576af8fa1bd84ccc9a89961d9e2fc5a98b5b90c0043f4f1cf82922"} build_url:https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011595 build_url: 'https://queue.taskcluster.net/v1/task/Ar8OP6SQTLyEO3BLSuuQ1Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cecd51686c906cc67ad54e40ec5e2458d19daef0ae6657cd32d9d7bbae70c7155035cf5ca722f9c1949cd428b2e5f57ace9525624897b0f4997a692c16697173", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a95407a9b69a816e62f19e79be7558bf7618e0d722c469b596fe33d4f674e7680d97b87bc084c6237590110638227c285cdea4c5f88d5d750879714c85eadab", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82ef9bedd8bda4f95a44797e831472ce90b81ce7a6f897f529ebfe19e7a14e7c738f0b4f25f16931d0b66e472101268042da563ddc858f901bfcd9f21cb87742", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07caf12db349b008a911bc22330be0b55bfeb62beb4d145508c400c71dc26bcef5306dd729576af8fa1bd84ccc9a89961d9e2fc5a98b5b90c0043f4f1cf82922"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 04:30:04.546438) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:30:04.546760) ========= 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=826874ccc97bd7bf541b4875000001d5-1506510130.202063-1429413072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:30:04.629733) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 04:30:04.633050) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 04:30:04.633346) ========= ========= Total master_lag: 0.24 =========