builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-084 starttime: 1506711473.56 results: success (0) revision: 5b614965e23e21272c9d7fcd8e0911956d98d543 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 11:57:53.561828) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 11:57:53.562258) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 11:57:53.562532) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 11:57:53.597022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 11:57:53.597365) ========= 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=ea65d483da93c827905c2090000001f5-1506711229.656374-389775371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-29 11:57:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2017-09-29 11:57:53 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145362 ========= master_lag: 0.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 11:57:53.986843) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 11:57:53.987147) ========= 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=ea65d483da93c827905c2090000001f5-1506711229.656374-389775371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019321 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 11:57:54.040093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 11:57:54.040403) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5b614965e23e21272c9d7fcd8e0911956d98d543 --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 5b614965e23e21272c9d7fcd8e0911956d98d543 --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=ea65d483da93c827905c2090000001f5-1506711229.656374-389775371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-29 11:57:54,192 truncating revision to first 12 chars 2017-09-29 11:57:54,192 Setting DEBUG logging. 2017-09-29 11:57:54,192 attempt 1/10 2017-09-29 11:57:54,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5b614965e23e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-29 11:57:54,580 unpacking tar archive at: mozilla-central-5b614965e23e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.672819 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 11:57:54.745303) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 11:57:54.745623) ========= script_repo_revision: 5b614965e23e21272c9d7fcd8e0911956d98d543 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 11:57:54.745990) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 11:57:54.748288) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 11:57:54.769280) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-29 11:57:54.769597) ========= /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=ea65d483da93c827905c2090000001f5-1506711229.656374-389775371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:57:55 INFO - MultiFileLogger online at 20170929 11:57:55 in /builds/slave/test 11:57:55 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 11:57:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:57:55 INFO - {'append_to_log': False, 11:57:55 INFO - 'base_work_dir': '/builds/slave/test', 11:57:55 INFO - 'blob_upload_branch': 'Firefox', 11:57:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:57:55 INFO - 'branch': 'Firefox', 11:57:55 INFO - 'buildbot_json_path': 'buildprops.json', 11:57:55 INFO - 'code_coverage': False, 11:57:55 INFO - 'config_files': ('talos/linux_config.py',), 11:57:55 INFO - 'default_actions': ('clobber', 11:57:55 INFO - 'read-buildbot-config', 11:57:55 INFO - 'download-and-extract', 11:57:55 INFO - 'populate-webroot', 11:57:55 INFO - 'create-virtualenv', 11:57:55 INFO - 'install', 11:57:55 INFO - 'setup-mitmproxy', 11:57:55 INFO - 'run-tests'), 11:57:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:57:55 INFO - 'disable_ccov_upload': False, 11:57:55 INFO - 'disable_stylo': False, 11:57:55 INFO - 'download_minidump_stackwalk': True, 11:57:55 INFO - 'download_symbols': 'ondemand', 11:57:55 INFO - 'enable_stylo': False, 11:57:55 INFO - 'enable_webrender': False, 11:57:55 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:57:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:57:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:57:55 INFO - 'gecko_profile': False, 11:57:55 INFO - 'gecko_profile_interval': 0, 11:57:55 INFO - 'installer_path': 'installer.exe', 11:57:55 INFO - 'log_level': 'info', 11:57:55 INFO - 'log_name': 'talos', 11:57:55 INFO - 'log_to_console': True, 11:57:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:57:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:57:55 INFO - 'opt_config_files': (), 11:57:55 INFO - 'pip_index': False, 11:57:55 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:57:55 INFO - 'system_bits': '32', 11:57:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:57:55 INFO - 'title': 'talos-linux64-ix-084', 11:57:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:57:55 INFO - 'use_talos_json': True, 11:57:55 INFO - 'verify': 'False', 11:57:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:57:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:57:55 INFO - 'work_dir': 'build'} 11:57:55 INFO - [mozharness: 2017-09-29 18:57:55.051649Z] Running clobber step. 11:57:55 INFO - Running pre-action listener: _resource_record_pre_action 11:57:55 INFO - Running main action method: clobber 11:57:55 INFO - rmtree: /builds/slave/test/build 11:57:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:57:56 INFO - Running post-action listener: _resource_record_post_action 11:57:56 INFO - [mozharness: 2017-09-29 18:57:56.556707Z] Finished clobber step (success) 11:57:56 INFO - [mozharness: 2017-09-29 18:57:56.556805Z] Running read-buildbot-config step. 11:57:56 INFO - Running pre-action listener: _resource_record_pre_action 11:57:56 INFO - Running main action method: read_buildbot_config 11:57:56 INFO - Using buildbot properties: 11:57:56 INFO - { 11:57:56 INFO - "project": "", 11:57:56 INFO - "product": "firefox", 11:57:56 INFO - "who": "ffxbld@noreply.mozilla.org", 11:57:56 INFO - "installer_path": "public/build/target.tar.bz2", 11:57:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:57:56 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:57:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 11:57:56 INFO - "stage_platform": "linux64-pgo", 11:57:56 INFO - "basedir": "/builds/slave/test", 11:57:56 INFO - "buildnumber": 76, 11:57:56 INFO - "platform": "ubuntu64_hw", 11:57:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:57:56 INFO - "slavebuilddir": "test", 11:57:56 INFO - "taskId": "XeuE0nPITSiLCPeUXA1IIg", 11:57:56 INFO - "branch": "mozilla-central", 11:57:56 INFO - "script_repo_revision": "production", 11:57:56 INFO - "revision": "5b614965e23e21272c9d7fcd8e0911956d98d543", 11:57:56 INFO - "slavename": "talos-linux64-ix-084", 11:57:56 INFO - "repo_path": "mozilla-central" 11:57:56 INFO - } 11:57:56 INFO - Finding installer, test and symbols from parent task. 11:57:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XeuE0nPITSiLCPeUXA1IIg'}, attempt #1 11:57:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XeuE0nPITSiLCPeUXA1IIg'}, attempt #1 11:57:57 INFO - Task dependencies: MScxg4BDTPm8_f9NwFyN5Q 11:57:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q'}, attempt #1 11:57:58 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.tar.bz2 11:57:58 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.test_packages.json 11:57:58 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.crashreporter-symbols.zip 11:57:58 INFO - Running post-action listener: _resource_record_post_action 11:57:58 INFO - [mozharness: 2017-09-29 18:57:58.021729Z] Finished read-buildbot-config step (success) 11:57:58 INFO - [mozharness: 2017-09-29 18:57:58.021950Z] Running download-and-extract step. 11:57:58 INFO - Running pre-action listener: _resource_record_pre_action 11:57:58 INFO - Running main action method: download_and_extract 11:57:58 INFO - mkdir: /builds/slave/test/build/tests 11:57:58 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')]} 11:57:58 INFO - trying https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.test_packages.json 11:57:58 INFO - Downloading https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:57:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:57:58 INFO - Downloaded 989 bytes. 11:57:58 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:57:58 INFO - Using the following test package requirements: 11:57:58 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:57:58 INFO - u'common': [u'target.common.tests.zip'], 11:57:58 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:57:58 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:57:58 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:57:58 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:57:58 INFO - u'mozbase': [u'target.common.tests.zip'], 11:57:58 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:57:58 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:57:58 INFO - u'web-platform': [u'target.common.tests.zip', 11:57:58 INFO - u'target.web-platform.tests.tar.gz'], 11:57:58 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:57:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:57:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.common.tests.zip 11:57:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:57:58 INFO - Fetch https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.common.tests.zip into memory 11:57:59 INFO - Content-Length response header: 55927232 11:57:59 INFO - Bytes received: 55927232 11:58:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.talos.tests.zip 11:58:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:58:10 INFO - Fetch https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.talos.tests.zip into memory 11:58:11 INFO - Content-Length response header: 14521355 11:58:11 INFO - Bytes received: 14521355 11:58:11 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')]} 11:58:11 INFO - trying https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.tar.bz2 11:58:11 INFO - Downloading https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:58:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:58:12 INFO - Downloaded 62424190 bytes. 11:58:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.tar.bz2 11:58:13 INFO - mkdir: /builds/slave/test/properties 11:58:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:58:13 INFO - Writing to file /builds/slave/test/properties/build_url 11:58:13 INFO - Contents: 11:58:13 INFO - build_url:https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.tar.bz2 11:58:13 INFO - Running post-action listener: _resource_record_post_action 11:58:13 INFO - Running post-action listener: find_tests_for_verification 11:58:13 INFO - Running post-action listener: set_extra_try_arguments 11:58:13 INFO - [mozharness: 2017-09-29 18:58:13.265825Z] Finished download-and-extract step (success) 11:58:13 INFO - [mozharness: 2017-09-29 18:58:13.265979Z] Running populate-webroot step. 11:58:13 INFO - Running pre-action listener: _resource_record_pre_action 11:58:13 INFO - Running main action method: populate_webroot 11:58:13 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:58:13 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:58:13 INFO - 'tests': ['tresize', 11:58:13 INFO - 'tcanvasmark']}, 11:58:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:58:13 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:58:13 INFO - 'tests': ['dromaeo_css', 11:58:13 INFO - 'kraken']}, 11:58:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:58:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:58:13 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:58:13 INFO - 'talos_options': ['--disable-stylo'], 11:58:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:58:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:58:13 INFO - 'tests': ['damp', 'tps']}, 11:58:13 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:58:13 INFO - 'talos_options': ['--disable-stylo'], 11:58:13 INFO - 'tests': ['damp', 'tps']}, 11:58:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:58:13 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:58:13 INFO - 'tests': ['dromaeo_dom']}, 11:58:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:58:13 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:58:13 INFO - 'tests': ['basic_compositor_video', 11:58:13 INFO - 'glvideo']}, 11:58:13 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:58:13 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:58:13 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:58:13 INFO - 'talos_options': ['--disable-stylo'], 11:58:13 INFO - 'tests': ['ts_paint_webext', 11:58:13 INFO - 'tp5o_webext']}, 11:58:13 INFO - 'other-e10s': {'tests': ['a11yr', 11:58:13 INFO - 'ts_paint', 11:58:13 INFO - 'tpaint', 11:58:13 INFO - 'sessionrestore', 11:58:13 INFO - 'sessionrestore_many_windows', 11:58:13 INFO - 'sessionrestore_no_auto_restore', 11:58:13 INFO - 'tabpaint', 11:58:13 INFO - 'cpstartup']}, 11:58:13 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:58:13 INFO - 'tests': ['a11yr', 11:58:13 INFO - 'ts_paint', 11:58:13 INFO - 'tpaint', 11:58:13 INFO - 'sessionrestore', 11:58:13 INFO - 'sessionrestore_many_windows', 11:58:13 INFO - 'sessionrestore_no_auto_restore', 11:58:13 INFO - 'tabpaint', 11:58:13 INFO - 'cpstartup']}, 11:58:13 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:58:13 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:58:13 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:58:13 INFO - 'tests': ['perf_reftest_singletons']}, 11:58:13 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:58:13 INFO - 'tests': ['perf_reftest']}, 11:58:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:58:13 INFO - 'tsvgr_opacity', 11:58:13 INFO - 'tart', 11:58:13 INFO - 'tscrollx', 11:58:13 INFO - 'tsvg_static']}, 11:58:13 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:58:13 INFO - 'tests': ['tsvgx', 11:58:13 INFO - 'tsvgr_opacity', 11:58:13 INFO - 'tart', 11:58:13 INFO - 'tscrollx', 11:58:13 INFO - 'tsvg_static']}, 11:58:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:58:13 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:58:13 INFO - 'talos_options': ['--disable-stylo'], 11:58:13 INFO - 'tests': ['tp5o']}, 11:58:13 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:58:13 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:58:13 INFO - 'talos_options': ['--mitmproxy', 11:58:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:58:13 INFO - '--firstNonBlankPaint'], 11:58:13 INFO - 'tests': ['tp6_google', 11:58:13 INFO - 'tp6_youtube', 11:58:13 INFO - 'tp6_amazon', 11:58:13 INFO - 'tp6_facebook']}, 11:58:13 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:58:13 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:58:13 INFO - 'talos_options': ['--disable-stylo', 11:58:13 INFO - '--mitmproxy', 11:58:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:58:13 INFO - '--firstNonBlankPaint'], 11:58:13 INFO - 'tests': ['tp6_google', 11:58:13 INFO - 'tp6_youtube', 11:58:13 INFO - 'tp6_amazon', 11:58:13 INFO - 'tp6_facebook']}, 11:58:13 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:58:13 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:58:13 INFO - 'talos_options': ['--stylo-threads=1', 11:58:13 INFO - '--mitmproxy', 11:58:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:58:13 INFO - '--firstNonBlankPaint'], 11:58:13 INFO - 'tests': ['tp6_google', 11:58:13 INFO - 'tp6_youtube', 11:58:13 INFO - 'tp6_amazon', 11:58:13 INFO - 'tp6_facebook']}, 11:58:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:58:13 INFO - 'talos_options': ['--xperf_path', 11:58:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:58:13 INFO - 'tests': ['tp5n']}, 11:58:13 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:58:13 INFO - 'talos_options': ['--disable-stylo', 11:58:13 INFO - '--xperf_path', 11:58:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:58:13 INFO - 'tests': ['tp5n']}}} 11:58:13 INFO - Running post-action listener: _resource_record_post_action 11:58:13 INFO - [mozharness: 2017-09-29 18:58:13.289364Z] Finished populate-webroot step (success) 11:58:13 INFO - [mozharness: 2017-09-29 18:58:13.289472Z] Running create-virtualenv step. 11:58:13 INFO - Running pre-action listener: _resource_record_pre_action 11:58:13 INFO - Running main action method: create_virtualenv 11:58:13 INFO - Creating virtualenv /builds/slave/test/build/venv 11:58:13 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:58:13 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:58:13 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:58:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:58:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:58:14 INFO - Installing distribute.............................................................................................................................................................................................done. 11:58:14 INFO - Installing pip...............done. 11:58:14 INFO - Return code: 0 11:58:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:58:15 INFO - Reading from file tmpfile_stdout 11:58:15 INFO - Output received: 11:58:15 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:58:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:58:15 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')]} 11:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:15 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')]} 11:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:15 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 0x1b631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecdd60>, '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 0x1ecea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eceef0>, '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': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', '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 11:58:15 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 11:58:15 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 11:58:15 INFO - Using env: {'DISPLAY': ':0', 11:58:15 INFO - 'HOME': '/home/cltbld', 11:58:15 INFO - 'LANG': 'en_US.UTF-8', 11:58:15 INFO - 'LANGUAGE': 'en_US:en', 11:58:15 INFO - 'LOGNAME': 'cltbld', 11:58:15 INFO - 'MAIL': '/var/mail/cltbld', 11:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:15 INFO - 'MOZ_NO_REMOTE': '1', 11:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:15 INFO - 'NO_EM_RESTART': '1', 11:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:15 INFO - 'PWD': '/builds/slave/test', 11:58:15 INFO - 'SHELL': '/bin/bash', 11:58:15 INFO - 'SHLVL': '1', 11:58:15 INFO - 'TERM': 'linux', 11:58:15 INFO - 'TMOUT': '86400', 11:58:15 INFO - 'USER': 'cltbld', 11:58:15 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', 11:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:15 INFO - '_': '/tools/buildbot/bin/python'} 11:58:16 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:58:16 INFO - Downloading/unpacking pip>=1.5 11:58:16 INFO - Running setup.py egg_info for package pip 11:58:16 INFO - warning: no files found matching 'pip/cacert.pem' 11:58:16 INFO - warning: no files found matching '*.html' under directory 'docs' 11:58:16 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:58:16 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:58:16 INFO - Installing collected packages: pip 11:58:16 INFO - Found existing installation: pip 1.1 11:58:16 INFO - Uninstalling pip: 11:58:16 INFO - Successfully uninstalled pip 11:58:16 INFO - Running setup.py install for pip 11:58:16 INFO - warning: no files found matching 'pip/cacert.pem' 11:58:16 INFO - warning: no files found matching '*.html' under directory 'docs' 11:58:16 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:58:16 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:58:16 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:58:16 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:58:16 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:58:16 INFO - Successfully installed pip 11:58:16 INFO - Cleaning up... 11:58:16 INFO - Return code: 0 11:58:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecdd60>, '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 0x1ecea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eceef0>, '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': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', '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 11:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:58:16 INFO - Using env: {'DISPLAY': ':0', 11:58:16 INFO - 'HOME': '/home/cltbld', 11:58:16 INFO - 'LANG': 'en_US.UTF-8', 11:58:16 INFO - 'LANGUAGE': 'en_US:en', 11:58:16 INFO - 'LOGNAME': 'cltbld', 11:58:16 INFO - 'MAIL': '/var/mail/cltbld', 11:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:16 INFO - 'MOZ_NO_REMOTE': '1', 11:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:16 INFO - 'NO_EM_RESTART': '1', 11:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:16 INFO - 'PWD': '/builds/slave/test', 11:58:16 INFO - 'SHELL': '/bin/bash', 11:58:16 INFO - 'SHLVL': '1', 11:58:16 INFO - 'TERM': 'linux', 11:58:16 INFO - 'TMOUT': '86400', 11:58:16 INFO - 'USER': 'cltbld', 11:58:16 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', 11:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:16 INFO - '_': '/tools/buildbot/bin/python'} 11:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:16 INFO - Downloading/unpacking psutil>=3.1.1 11:58:16 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 11:58:16 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 11:58:16 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 11:58:16 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 11:58:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:58:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:58:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:58:17 INFO - Installing collected packages: psutil 11:58:17 INFO - Running setup.py install for psutil 11:58:17 INFO - building 'psutil._psutil_linux' extension 11:58:17 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 11:58:17 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 11:58:17 INFO - building 'psutil._psutil_posix' extension 11:58:17 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 11:58:18 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 11:58:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:58:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:58:18 INFO - Successfully installed psutil 11:58:18 INFO - Cleaning up... 11:58:18 INFO - Return code: 0 11:58:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:18 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 0x1b631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecdd60>, '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 0x1ecea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eceef0>, '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': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', '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 11:58:18 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 11:58:18 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 11:58:18 INFO - Using env: {'DISPLAY': ':0', 11:58:18 INFO - 'HOME': '/home/cltbld', 11:58:18 INFO - 'LANG': 'en_US.UTF-8', 11:58:18 INFO - 'LANGUAGE': 'en_US:en', 11:58:18 INFO - 'LOGNAME': 'cltbld', 11:58:18 INFO - 'MAIL': '/var/mail/cltbld', 11:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:18 INFO - 'MOZ_NO_REMOTE': '1', 11:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:18 INFO - 'NO_EM_RESTART': '1', 11:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:18 INFO - 'PWD': '/builds/slave/test', 11:58:18 INFO - 'SHELL': '/bin/bash', 11:58:18 INFO - 'SHLVL': '1', 11:58:18 INFO - 'TERM': 'linux', 11:58:18 INFO - 'TMOUT': '86400', 11:58:18 INFO - 'USER': 'cltbld', 11:58:18 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', 11:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:18 INFO - '_': '/tools/buildbot/bin/python'} 11:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:58:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:58:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:58:19 INFO - Installing collected packages: mozsystemmonitor 11:58:19 INFO - Running setup.py install for mozsystemmonitor 11:58:19 INFO - Successfully installed mozsystemmonitor 11:58:19 INFO - Cleaning up... 11:58:20 INFO - Return code: 0 11:58:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecdd60>, '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 0x1ecea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eceef0>, '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': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', '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 11:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:58:20 INFO - Using env: {'DISPLAY': ':0', 11:58:20 INFO - 'HOME': '/home/cltbld', 11:58:20 INFO - 'LANG': 'en_US.UTF-8', 11:58:20 INFO - 'LANGUAGE': 'en_US:en', 11:58:20 INFO - 'LOGNAME': 'cltbld', 11:58:20 INFO - 'MAIL': '/var/mail/cltbld', 11:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:20 INFO - 'MOZ_NO_REMOTE': '1', 11:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:20 INFO - 'NO_EM_RESTART': '1', 11:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:20 INFO - 'PWD': '/builds/slave/test', 11:58:20 INFO - 'SHELL': '/bin/bash', 11:58:20 INFO - 'SHLVL': '1', 11:58:20 INFO - 'TERM': 'linux', 11:58:20 INFO - 'TMOUT': '86400', 11:58:20 INFO - 'USER': 'cltbld', 11:58:20 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', 11:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:20 INFO - '_': '/tools/buildbot/bin/python'} 11:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:20 INFO - Downloading/unpacking jsonschema==2.5.1 11:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:58:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:58:21 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 11:58:21 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 11:58:21 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 11:58:21 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 11:58:21 INFO - Downloading functools32-3.2.3-2.tar.gz 11:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:58:22 INFO - warning: no files found matching '*.txt' 11:58:22 INFO - no previously-included directories found matching 'build' 11:58:22 INFO - no previously-included directories found matching 'dist' 11:58:22 INFO - no previously-included directories found matching '.git*' 11:58:22 INFO - Installing collected packages: jsonschema, functools32 11:58:22 INFO - Running setup.py install for functools32 11:58:22 INFO - warning: no files found matching '*.txt' 11:58:22 INFO - no previously-included directories found matching 'build' 11:58:22 INFO - no previously-included directories found matching 'dist' 11:58:22 INFO - no previously-included directories found matching '.git*' 11:58:22 INFO - Successfully installed jsonschema functools32 11:58:22 INFO - Cleaning up... 11:58:22 INFO - Return code: 0 11:58:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecdd60>, '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 0x1ecea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eceef0>, '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': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', '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 11:58:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:58:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:58:22 INFO - Using env: {'DISPLAY': ':0', 11:58:22 INFO - 'HOME': '/home/cltbld', 11:58:22 INFO - 'LANG': 'en_US.UTF-8', 11:58:22 INFO - 'LANGUAGE': 'en_US:en', 11:58:22 INFO - 'LOGNAME': 'cltbld', 11:58:22 INFO - 'MAIL': '/var/mail/cltbld', 11:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:22 INFO - 'MOZ_NO_REMOTE': '1', 11:58:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:22 INFO - 'NO_EM_RESTART': '1', 11:58:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:22 INFO - 'PWD': '/builds/slave/test', 11:58:22 INFO - 'SHELL': '/bin/bash', 11:58:22 INFO - 'SHLVL': '1', 11:58:22 INFO - 'TERM': 'linux', 11:58:22 INFO - 'TMOUT': '86400', 11:58:22 INFO - 'USER': 'cltbld', 11:58:22 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', 11:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:22 INFO - '_': '/tools/buildbot/bin/python'} 11:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:58:22 INFO - Cleaning up... 11:58:22 INFO - Return code: 0 11:58:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecdd60>, '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 0x1ecea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eceef0>, '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': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', '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 11:58:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:58:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:58:22 INFO - Using env: {'DISPLAY': ':0', 11:58:22 INFO - 'HOME': '/home/cltbld', 11:58:22 INFO - 'LANG': 'en_US.UTF-8', 11:58:22 INFO - 'LANGUAGE': 'en_US:en', 11:58:22 INFO - 'LOGNAME': 'cltbld', 11:58:22 INFO - 'MAIL': '/var/mail/cltbld', 11:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:22 INFO - 'MOZ_NO_REMOTE': '1', 11:58:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:22 INFO - 'NO_EM_RESTART': '1', 11:58:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:22 INFO - 'PWD': '/builds/slave/test', 11:58:22 INFO - 'SHELL': '/bin/bash', 11:58:22 INFO - 'SHLVL': '1', 11:58:22 INFO - 'TERM': 'linux', 11:58:22 INFO - 'TMOUT': '86400', 11:58:22 INFO - 'USER': 'cltbld', 11:58:22 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', 11:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:22 INFO - '_': '/tools/buildbot/bin/python'} 11:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:22 INFO - Downloading/unpacking blobuploader==1.2.4 11:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:23 INFO - Downloading blobuploader-1.2.4.tar.gz 11:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:58:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:58:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:24 INFO - Downloading docopt-0.6.1.tar.gz 11:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:58:24 INFO - Installing collected packages: blobuploader, requests, docopt 11:58:24 INFO - Running setup.py install for blobuploader 11:58:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:58:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:58:24 INFO - Running setup.py install for requests 11:58:24 INFO - Running setup.py install for docopt 11:58:24 INFO - Successfully installed blobuploader requests docopt 11:58:24 INFO - Cleaning up... 11:58:24 INFO - Return code: 0 11:58:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:24 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 0x1b631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecdd60>, '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 0x1ecea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eceef0>, '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': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', '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 11:58:24 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 11:58:24 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 11:58:24 INFO - Using env: {'DISPLAY': ':0', 11:58:24 INFO - 'HOME': '/home/cltbld', 11:58:24 INFO - 'LANG': 'en_US.UTF-8', 11:58:24 INFO - 'LANGUAGE': 'en_US:en', 11:58:24 INFO - 'LOGNAME': 'cltbld', 11:58:24 INFO - 'MAIL': '/var/mail/cltbld', 11:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:24 INFO - 'MOZ_NO_REMOTE': '1', 11:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:24 INFO - 'NO_EM_RESTART': '1', 11:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:24 INFO - 'PWD': '/builds/slave/test', 11:58:24 INFO - 'SHELL': '/bin/bash', 11:58:24 INFO - 'SHLVL': '1', 11:58:24 INFO - 'TERM': 'linux', 11:58:24 INFO - 'TMOUT': '86400', 11:58:24 INFO - 'USER': 'cltbld', 11:58:24 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', 11:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:24 INFO - '_': '/tools/buildbot/bin/python'} 11:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:25 INFO - Running setup.py (path:/tmp/pip-Wt4Ag6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:25 INFO - Running setup.py (path:/tmp/pip-KM2l5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:25 INFO - Running setup.py (path:/tmp/pip-4xvRqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:25 INFO - Running setup.py (path:/tmp/pip-L1HMW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:25 INFO - Running setup.py (path:/tmp/pip-_27GKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:25 INFO - Running setup.py (path:/tmp/pip-O4ee7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:25 INFO - Running setup.py (path:/tmp/pip-Nb4p3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:25 INFO - Running setup.py (path:/tmp/pip-J6KizK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:25 INFO - Running setup.py (path:/tmp/pip-89DvZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:25 INFO - Running setup.py (path:/tmp/pip-k2MVI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:25 INFO - Running setup.py (path:/tmp/pip-rfow4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:25 INFO - Running setup.py (path:/tmp/pip-xR5zD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:26 INFO - Running setup.py (path:/tmp/pip-hgz2Vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:26 INFO - Running setup.py (path:/tmp/pip-_C3DUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:26 INFO - Running setup.py (path:/tmp/pip-nEJx8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:26 INFO - Running setup.py (path:/tmp/pip-gNCKGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:26 INFO - Running setup.py (path:/tmp/pip-9R5pNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:58:26 INFO - Running setup.py install for manifestparser 11:58:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:58:26 INFO - Running setup.py install for mozcrash 11:58:26 INFO - Running setup.py install for mozdebug 11:58:26 INFO - Running setup.py install for mozdevice 11:58:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:58:26 INFO - Running setup.py install for mozfile 11:58:26 INFO - Running setup.py install for mozhttpd 11:58:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:58:26 INFO - Running setup.py install for mozinfo 11:58:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:58:27 INFO - Running setup.py install for mozInstall 11:58:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:58:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:58:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:58:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:58:27 INFO - Running setup.py install for mozleak 11:58:27 INFO - Running setup.py install for mozlog 11:58:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:58:27 INFO - Running setup.py install for moznetwork 11:58:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:58:27 INFO - Running setup.py install for mozprocess 11:58:27 INFO - Running setup.py install for mozprofile 11:58:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:58:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:58:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:58:27 INFO - Running setup.py install for mozrunner 11:58:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:58:27 INFO - Running setup.py install for mozscreenshot 11:58:27 INFO - Running setup.py install for moztest 11:58:28 INFO - Running setup.py install for mozversion 11:58:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:58:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:58:28 INFO - Cleaning up... 11:58:28 INFO - Return code: 0 11:58:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:28 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')]} 11:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:28 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')]} 11:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:28 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 0x1b631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecdd60>, '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 0x1ecea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eceef0>, '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': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', '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 11:58:28 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 11:58:28 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 11:58:28 INFO - Using env: {'DISPLAY': ':0', 11:58:28 INFO - 'HOME': '/home/cltbld', 11:58:28 INFO - 'LANG': 'en_US.UTF-8', 11:58:28 INFO - 'LANGUAGE': 'en_US:en', 11:58:28 INFO - 'LOGNAME': 'cltbld', 11:58:28 INFO - 'MAIL': '/var/mail/cltbld', 11:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:28 INFO - 'MOZ_NO_REMOTE': '1', 11:58:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:28 INFO - 'NO_EM_RESTART': '1', 11:58:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:28 INFO - 'PWD': '/builds/slave/test', 11:58:28 INFO - 'SHELL': '/bin/bash', 11:58:28 INFO - 'SHLVL': '1', 11:58:28 INFO - 'TERM': 'linux', 11:58:28 INFO - 'TMOUT': '86400', 11:58:28 INFO - 'USER': 'cltbld', 11:58:28 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', 11:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:28 INFO - '_': '/tools/buildbot/bin/python'} 11:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:28 INFO - Running setup.py (path:/tmp/pip-5PI1pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:28 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)) 11:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:28 INFO - Running setup.py (path:/tmp/pip-ia5vPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:28 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)) 11:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:28 INFO - Running setup.py (path:/tmp/pip-duxABL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:28 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)) 11:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:28 INFO - Running setup.py (path:/tmp/pip-S3Pdof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:28 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)) 11:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:28 INFO - Running setup.py (path:/tmp/pip-41c6QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:28 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)) 11:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:28 INFO - Running setup.py (path:/tmp/pip-8l0hiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:28 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)) 11:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:28 INFO - Running setup.py (path:/tmp/pip-ZKi95Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:28 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)) 11:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:28 INFO - Running setup.py (path:/tmp/pip-cEy9lM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:28 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)) 11:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:28 INFO - Running setup.py (path:/tmp/pip-QQwp8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58:29 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)) 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:29 INFO - Running setup.py (path:/tmp/pip-xTqCY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58:29 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)) 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:29 INFO - Running setup.py (path:/tmp/pip-GQ6V68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:29 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)) 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:29 INFO - Running setup.py (path:/tmp/pip-w6wURj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:29 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)) 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:29 INFO - Running setup.py (path:/tmp/pip-GFUfqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:29 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)) 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:29 INFO - Running setup.py (path:/tmp/pip-NWIqoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:29 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)) 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:29 INFO - Running setup.py (path:/tmp/pip-PRWGLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:29 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)) 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:29 INFO - Running setup.py (path:/tmp/pip-rMwZq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:29 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)) 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:29 INFO - Running setup.py (path:/tmp/pip-wH3Ns2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:29 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)) 11:58:29 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)) 11:58:29 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)) 11:58:29 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)) 11:58:29 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)) 11:58:29 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)) 11:58:29 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)) 11:58:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:58:29 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 11:58:29 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 11:58:29 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 11:58:29 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 11:58:30 INFO - Downloading blessings-1.6.tar.gz 11:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:58:30 INFO - Installing collected packages: blessings 11:58:30 INFO - Running setup.py install for blessings 11:58:30 INFO - Successfully installed blessings 11:58:30 INFO - Cleaning up... 11:58:30 INFO - Return code: 0 11:58:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:58:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:31 INFO - Reading from file tmpfile_stdout 11:58:31 INFO - Current package versions: 11:58:31 INFO - argparse == 1.2.1 11:58:31 INFO - blessings == 1.6 11:58:31 INFO - blobuploader == 1.2.4 11:58:31 INFO - docopt == 0.6.1 11:58:31 INFO - functools32 == 3.2.3-2 11:58:31 INFO - jsonschema == 2.5.1 11:58:31 INFO - manifestparser == 1.1 11:58:31 INFO - mozInstall == 1.13 11:58:31 INFO - mozcrash == 1.0 11:58:31 INFO - mozdebug == 0.1 11:58:31 INFO - mozdevice == 0.51 11:58:31 INFO - mozfile == 1.2 11:58:31 INFO - mozhttpd == 0.7 11:58:31 INFO - mozinfo == 0.10 11:58:31 INFO - mozleak == 0.1 11:58:31 INFO - mozlog == 3.5 11:58:31 INFO - moznetwork == 0.27 11:58:31 INFO - mozprocess == 0.25 11:58:31 INFO - mozprofile == 0.28 11:58:31 INFO - mozrunner == 6.13 11:58:31 INFO - mozscreenshot == 0.1 11:58:31 INFO - mozsystemmonitor == 0.3 11:58:31 INFO - moztest == 0.8 11:58:31 INFO - mozversion == 1.4 11:58:31 INFO - psutil == 3.1.1 11:58:31 INFO - requests == 1.2.3 11:58:31 INFO - wsgiref == 0.1.2 11:58:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:31 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 0x1b631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecdd60>, '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 0x1ecea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eceef0>, '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': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', '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 11:58:31 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 11:58:31 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 11:58:31 INFO - Using env: {'DISPLAY': ':0', 11:58:31 INFO - 'HOME': '/home/cltbld', 11:58:31 INFO - 'LANG': 'en_US.UTF-8', 11:58:31 INFO - 'LANGUAGE': 'en_US:en', 11:58:31 INFO - 'LOGNAME': 'cltbld', 11:58:31 INFO - 'MAIL': '/var/mail/cltbld', 11:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:31 INFO - 'MOZ_NO_REMOTE': '1', 11:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:31 INFO - 'NO_EM_RESTART': '1', 11:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:31 INFO - 'PWD': '/builds/slave/test', 11:58:31 INFO - 'SHELL': '/bin/bash', 11:58:31 INFO - 'SHLVL': '1', 11:58:31 INFO - 'TERM': 'linux', 11:58:31 INFO - 'TMOUT': '86400', 11:58:31 INFO - 'USER': 'cltbld', 11:58:31 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', 11:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:31 INFO - '_': '/tools/buildbot/bin/python'} 11:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:31 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)) 11:58:31 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)) 11:58:31 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)) 11:58:31 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)) 11:58:31 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)) 11:58:31 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)) 11:58:31 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)) 11:58:31 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)) 11:58:31 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)) 11:58:31 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:58:32 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)) 11:58:32 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)) 11:58:32 INFO - Installing collected packages: simplejson 11:58:32 INFO - Running setup.py install for simplejson 11:58:32 INFO - building 'simplejson._speedups' extension 11:58:32 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 11:58:33 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 11:58:33 INFO - Successfully installed simplejson 11:58:33 INFO - Cleaning up... 11:58:33 INFO - Return code: 0 11:58:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecdd60>, '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 0x1ecea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eceef0>, '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': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', '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 11:58:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:58:33 INFO - Using env: {'DISPLAY': ':0', 11:58:33 INFO - 'HOME': '/home/cltbld', 11:58:33 INFO - 'LANG': 'en_US.UTF-8', 11:58:33 INFO - 'LANGUAGE': 'en_US:en', 11:58:33 INFO - 'LOGNAME': 'cltbld', 11:58:33 INFO - 'MAIL': '/var/mail/cltbld', 11:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:33 INFO - 'MOZ_NO_REMOTE': '1', 11:58:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:33 INFO - 'NO_EM_RESTART': '1', 11:58:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:33 INFO - 'PWD': '/builds/slave/test', 11:58:33 INFO - 'SHELL': '/bin/bash', 11:58:33 INFO - 'SHLVL': '1', 11:58:33 INFO - 'TERM': 'linux', 11:58:33 INFO - 'TMOUT': '86400', 11:58:33 INFO - 'USER': 'cltbld', 11:58:33 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', 11:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:33 INFO - '_': '/tools/buildbot/bin/python'} 11:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:58:33 INFO - Cleaning up... 11:58:33 INFO - Return code: 0 11:58:33 INFO - Running post-action listener: _resource_record_post_action 11:58:33 INFO - Running post-action listener: _start_resource_monitoring 11:58:33 INFO - Starting resource monitoring. 11:58:33 INFO - [mozharness: 2017-09-29 18:58:33.898424Z] Finished create-virtualenv step (success) 11:58:33 INFO - [mozharness: 2017-09-29 18:58:33.898898Z] Running install step. 11:58:33 INFO - Running pre-action listener: _resource_record_pre_action 11:58:33 INFO - Running main action method: install 11:58:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:34 INFO - Reading from file tmpfile_stdout 11:58:34 INFO - Detecting whether we're running mozinstall >=1.0... 11:58:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:58:34 INFO - Reading from file tmpfile_stdout 11:58:34 INFO - Output received: 11:58:34 INFO - Usage: mozinstall [options] installer 11:58:34 INFO - Options: 11:58:34 INFO - -h, --help show this help message and exit 11:58:34 INFO - -d DEST, --destination=DEST 11:58:34 INFO - Directory to install application into. [default: 11:58:34 INFO - "/builds/slave/test"] 11:58:34 INFO - --app=APP Application being installed. [default: firefox] 11:58:34 INFO - mkdir: /builds/slave/test/build/application 11:58:34 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'] 11:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:58:51 INFO - Reading from file tmpfile_stdout 11:58:51 INFO - Output received: 11:58:51 INFO - /builds/slave/test/build/application/firefox/firefox 11:58:51 INFO - Running post-action listener: _resource_record_post_action 11:58:51 INFO - [mozharness: 2017-09-29 18:58:51.849215Z] Finished install step (success) 11:58:51 INFO - [mozharness: 2017-09-29 18:58:51.849471Z] Running setup-mitmproxy step. 11:58:51 INFO - Running pre-action listener: _resource_record_pre_action 11:58:51 INFO - Running main action method: setup_mitmproxy 11:58:51 INFO - Skipping: mitmproxy is not required 11:58:51 INFO - Running post-action listener: _resource_record_post_action 11:58:51 INFO - [mozharness: 2017-09-29 18:58:51.850674Z] Finished setup-mitmproxy step (success) 11:58:51 INFO - [mozharness: 2017-09-29 18:58:51.850897Z] Running run-tests step. 11:58:51 INFO - Running pre-action listener: _resource_record_pre_action 11:58:51 INFO - Running pre-action listener: _set_gcov_prefix 11:58:51 INFO - Running main action method: run_tests 11:58:51 WARNING - Try message not found. 11:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:58:51 INFO - Python 2.7.3 11:58:51 INFO - Return code: 0 11:58:51 INFO - grabbing minidump binary from tooltool 11:58: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')]} 11:58:51 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 0x1ecdd60>, '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 0x1ecea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eceef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:58:51 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 11:58:51 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 11:58:51 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 11:58:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:58:51 INFO - Return code: 0 11:58:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:58:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:58:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:58:51 INFO - ENV: RUST_BACKTRACE is now full 11:58:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:58:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:58:51 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/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 11:58:51 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/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --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 11:58:51 INFO - Using env: {'DISPLAY': ':0', 11:58:51 INFO - 'HOME': '/home/cltbld', 11:58:51 INFO - 'LANG': 'en_US.UTF-8', 11:58:51 INFO - 'LANGUAGE': 'en_US:en', 11:58:51 INFO - 'LOGNAME': 'cltbld', 11:58:51 INFO - 'MAIL': '/var/mail/cltbld', 11:58:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:58:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:51 INFO - 'MOZ_NO_REMOTE': '1', 11:58:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:51 INFO - 'NO_EM_RESTART': '1', 11:58:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:51 INFO - 'PWD': '/builds/slave/test', 11:58:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:58:51 INFO - 'RUST_BACKTRACE': 'full', 11:58:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:58:51 INFO - 'SHELL': '/bin/bash', 11:58:51 INFO - 'SHLVL': '1', 11:58:51 INFO - 'TERM': 'linux', 11:58:51 INFO - 'TMOUT': '86400', 11:58:51 INFO - 'USER': 'cltbld', 11:58:51 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', 11:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:51 INFO - '_': '/tools/buildbot/bin/python'} 11:58:51 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/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 11:58:52 INFO - mozversion application_buildid: 20170929173359 11:58:52 INFO - mozversion application_changeset: 5b614965e23e21272c9d7fcd8e0911956d98d543 11:58:52 INFO - mozversion application_display_name: Nightly 11:58:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:58:52 INFO - mozversion application_name: Firefox 11:58:52 INFO - mozversion application_remotingname: firefox 11:58:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:58:52 INFO - mozversion application_vendor: Mozilla 11:58:52 INFO - mozversion application_version: 58.0a1 11:58:52 INFO - mozversion platform_buildid: 20170929173359 11:58:52 INFO - mozversion platform_changeset: 5b614965e23e21272c9d7fcd8e0911956d98d543 11:58:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:58:52 INFO - mozversion platform_version: 58.0a1 11:58:52 INFO - using testdate: 1506711532 11:58:52 INFO - actual date: 1506711532 11:58:52 INFO - starting webserver on 'localhost:41654' 11:58:52 INFO - SUITE-START | Running 2 tests 11:58:52 INFO - TEST-START | dromaeo_css 11:58:52 INFO - Initialising browser for dromaeo_css test... 11:58:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41654/getInfo.html -profile /tmp/tmp4zPZXy/profile 11:58:52 INFO - TEST-INFO | started process 12607 (/builds/slave/test/build/application/firefox/firefox http://localhost:41654/getInfo.html) 11:58:58 INFO - TEST-INFO | 12607: exit 0 11:58:58 INFO - Browser initialized. 11:58:58 INFO - Running cycle 1/1 for dromaeo_css test... 11:58:58 INFO - Using env: {'DISPLAY': ':0', 11:58:58 INFO - 'HOME': '/home/cltbld', 11:58:58 INFO - 'JSGC_DISABLE_POISONING': '1', 11:58:58 INFO - 'LANG': 'en_US.UTF-8', 11:58:58 INFO - 'LANGUAGE': 'en_US:en', 11:58:58 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:58:58 INFO - 'LOGNAME': 'cltbld', 11:58:58 INFO - 'MAIL': '/var/mail/cltbld', 11:58:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:58:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:58:58 INFO - 'MOZ_CRASHREPORTER': '1', 11:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:58 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:58:58 INFO - 'MOZ_NO_REMOTE': '1', 11:58:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:58 INFO - 'NO_EM_RESTART': '1', 11:58:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:58 INFO - 'PWD': '/builds/slave/test', 11:58:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:58:58 INFO - 'RUST_BACKTRACE': 'full', 11:58:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:58:58 INFO - 'SHELL': '/bin/bash', 11:58:58 INFO - 'SHLVL': '1', 11:58:58 INFO - 'STYLO_FORCE_DISABLED': '1', 11:58:58 INFO - 'TERM': 'linux', 11:58:58 INFO - 'TMOUT': '86400', 11:58:58 INFO - 'USER': 'cltbld', 11:58:58 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', 11:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:58 INFO - '_': '/tools/buildbot/bin/python'} 11:58:58 INFO - TEST-INFO | started process 12844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4zPZXy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:58:59 INFO - PID 12844 | 11:58:59 INFO - PID 12844 | (/builds/slave/test/build/application/firefox/firefox:12892): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:58:59 INFO - PID 12844 | 11:59:09 INFO - PID 12844 | RSS: Main: 145186816 11:59:09 INFO - PID 12844 | 12:02:06 INFO - PID 12844 | Cycle 1(1): loaded http://localhost:41654/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41654/tests/dromaeo/cssquery-ext.html) 12:02:08 INFO - PID 12844 | RSS: Main: 143114240 12:02:08 INFO - PID 12844 | 12:05:10 INFO - PID 12844 | Cycle 1(1): loaded http://localhost:41654/tests/dromaeo/cssquery-ext.html (next: http://localhost:41654/tests/dromaeo/cssquery-jquery.html) 12:05:10 INFO - PID 12844 | RSS: Main: 144134144 12:05:10 INFO - PID 12844 | 12:08:12 INFO - PID 12844 | Cycle 1(1): loaded http://localhost:41654/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41654/tests/dromaeo/cssquery-mootools.html) 12:08:12 INFO - PID 12844 | RSS: Main: 145199104 12:08:12 INFO - PID 12844 | 12:11:14 INFO - PID 12844 | Cycle 1(1): loaded http://localhost:41654/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41654/tests/dromaeo/cssquery-prototype.html) 12:11:14 INFO - PID 12844 | RSS: Main: 145334272 12:11:14 INFO - PID 12844 | 12:14:17 INFO - PID 12844 | Cycle 1(1): loaded http://localhost:41654/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41654/tests/dromaeo/cssquery-yui.html) 12:14:18 INFO - PID 12844 | RSS: Main: 148377600 12:14:18 INFO - PID 12844 | 12:17:19 INFO - PID 12844 | Cycle 1(1): loaded http://localhost:41654/tests/dromaeo/cssquery-yui.html (next: http://localhost:41654/tests/dromaeo/cssquery-dojo.html) 12:17:20 INFO - PID 12844 | RSS: Main: 149438464 12:17:20 INFO - PID 12844 | 12:17:20 INFO - PID 12844 | __start_tp_report 12:17:20 INFO - PID 12844 | _x_x_mozilla_page_load 12:17:20 INFO - PID 12844 | _x_x_mozilla_page_load_details 12:17:20 INFO - PID 12844 | |i|pagename|runs| 12:17:20 INFO - PID 12844 | |0;dojo.html;3819.885403437898;3823.9808800955993;3824.9235015299714;3830.7510011849226;3888.0862997195663;6106.3893610639025;6136.9079463808075;6167.599106058103;6242.344553821846;6244.500439964803;6278.68606569672;6337.588056776306;6395.552311338208;6402.8079157625225;6422.9357706422925;5617.775288988436;5646.18130371096;5667;5735.483806457418;5764.855878603047;5597.552195824324;5713.228714123603;5721.342045664739;5758.971205143989;5784.855378615547;5613.4386561343945;5658.830235092953;5671.829845104653;5693.886122277573;5738.340090889559;5655.406182350876;5693.715314234271;5699.601027928046;5699.886002279931;5706.54347652191;5580.414056524088;5618.859528511779;5684.7157642118145;5729.713514324267;5759.136129580555;6219.346968568326;6288.937110628926;6299.6850157491945;6317.368263173692;6391.073294372336;6772.593644381303;6833.897491537631;6836.931630683679;6872.10662613857;6972.442204623618;6912.688928998207;6999.160100787887;7020.684069216846;7021.192562855286;7028.43772498204;6150.50795936324;6192.504599632019;6200.565960382775;6375.2349718033665;6446.677666116675;7053.188883278489;7057.50597458173;7063.89404158938;7065.2228254891925;7074.610896400747;6683.365080317362;6714.462842972551;6748.595084294958;6754.696038678271;6759.391654751096;6840;6843.110395648534;6848.486363522756;6850.38346548813;6854.383105520527;6891.173059232824;6896.724131034803;6901.206361268418;6904.3095690430555;6908.378245957888;6846.828829279308;6847.520673552804;6850.623215723183;6931.792046238621;6944.826379340456;4935.802567897315;4998.500149984972;5006.499350065037;5078.593712503065;5089.134847076006;4590.081983603292;4607.976960115245;4619.653525985565;4631.745254011062;4636.188666983265;6277.466415354746;6345;6346.048092786119;6346.174997250328;6374.74501019954;6751.054852320679;6776.830579235559;6779.220389655253;6863.553868998499;6872.656367181621;6223.190985171898;6279.654618995908;6306.842328941813;6344.555881088279;6347.428731414195;5433.538149257357;5438.619296649275;5447.918281225785;5451.373092094381;5466.699331536804;6899.310068993061;6931.029655848185;6932.341427564374;7007.789766307019;7013.438924885997;6601.603903765789;6644.568103073285;6700.229473610597;6705.832354191184;6713.328667133248;7087.929120708934;7092.219855815959;7109.928900710926;7148.499605027806;7165.8925116122255;6693.564918280296;6712.463002959849;6722.563033402813;6734.764283250062;6747.089142965833;6668.233153187445;6772.5936443813525;6847.144106986627;6848.2466928638805;6850.075239842757;6462.321456247027;6471.06169605414;6524.934750652433;6557.672116394257;6635.2037755469655;6585.176852893388;6599.571027883172;6624.635645039569;6627.37039981201;6674.599524028574;6438.742450301936;6518.804435866931;6536.379043990813;6590.505712071518;6601.768938087144;6662.433693136138;6745.730170793114;6752.628605426552;6757.087793147862;6776.390124888783;6474.5791523550815;6506.544541882212;6532.510061745293;6547.050677651809;6560.40956313934 12:17:20 INFO - PID 12844 | |1;ext.html;897.5960817632067;958.7986522830205;984.0503913723255;1281.1032277405818;1301.4078594239622;43135.35296970544;44764.552354476444;44843.103137937265;44879.77560112203;44918.55081449184;44362;44672;44722.32916506247;45068.774656126676;45097;8016.599170041503;8019.799505012377;8025.438219324649;8035.437519373646;8190.467619604737;8164.265216130547;8290.544020078893;8325.708600198994;8327.83344333116;8356.415050946436;8330.291925186337;8338.291245244161;8373.204545568162;8421.115782842806;8589.95705021474;8504.744857654281;8550.828983420328;8555.272801811885;8557.700480483154;8561.0582835888;8308.252257296812;8396.496210227406;8474.322054235647;8485.32117430604;8489.490630562124;41319.7934010328;41766.58233417657;41846.790766045975;41905.37141942873;42014.36978445326;3717.4795528626014;3726.124360775216;3742.064483879003;3761.793101379423;3790.6777923876502;34291;34341.31317373639;34352.65647343519;34457.82771086154;34706.479402808975;5305.840824775263;5318.73406329682;5330.973345133289;5354.116570765819;5380.91928621071;228243;228575;228736;228945;230846;54285.72857135689;54667;54685.179722304194;54970.72514637481;55012;57877;57993.8401231973;58085;58324.70837645785;58591.70704146452;15453.459128930434;15509.224538773242;15533.301001454962;15593.844061559466;15636.765448518281;12525.31110788897;12571.245725256515;12572.811407828889;12579.433925473375;12593.433295501725;15636.296366663528;15802;15979.360825566848;15984.600384990235;15989.440369587008;5275.841724748264;6403.167588213502;6424.982946709077;6434.420902118738;6710.698018589175;1100.5487750022612;1113.2207454781685;1122.3882983773863;1122.960696375623;1124.8200287954053;25496.745032549807;25684.614730779052;25745.356366090622;25780.613290800655;25898.482030359664;1187.5309252845077;1192.4557697781395;1204.175140029083;1204.4158583087196;1205.4093494187784;13651.180929144084;13700.177989320473;13791.586252412444;13894.166350019032;13947.930260348634;307543;308841;309815;310493;311173;60322.39677603168;60521.09218361728;60816.69591652013;60820.39179608236;61027.38972610306;1476.372541669786;1492.0898252066231;1503.6466430389069;1512.3496896334461;1534.1436861397833;24977.126715496048;25368.492630147663;25666;25698.35754106162;25718.228453146436;42333;42413;42430.36354454624;42471.78764106159;42515.149697006505;240722;241876;243552;244891;244984;32606.695732171396;32777.50833737448;32791.18022049468;32794.83602581972;32901;41418;42654.573454266305;42986.785066074466;43023.78488107539;43197.352039720055;31773.523397148598;32607.510887336233;32660.34679306448;32674.50988235226;32713.34573308473;32344.676553234167;32359;32573.309395571327;33190.834045829615;33193.502097468074;37952.43071353987;38046.239075218895;38124.237515248984;38413.80793096129;38482.42276365801;31260.374792504477;31497.685023149475;31802.204944875637;31812.84093579517;32334.029979100666;24259.272221833373;24354.904029318368;24441.87779061093;25203.495930081663;25211.11761088353 12:17:20 INFO - PID 12844 | |2;jquery.html;623.5541587764748;627.2473032361167;635.6481020225165;644.8678021005688;647.8866198415277;22622.321330360115;23022.769772302272;23878.28365149044;24079.39801504961;24414.877925610348;25926.22221333358;26224.606630900504;26273.21180364592;26280;26307.605385919225;6698.966505167467;6699.19609646843;6727.966360168192;6748.595084294933;6789.5926244425245;6883.621400822953;6950.79147625572;6962.651867406635;6964.164300283973;6969.930300697004;6852.074969879077;6908;6921.411680007205;6925.065116209297;6925.37671609555;6868.416184624338;6926.307369263084;6926.480513961473;6934.063901373301;6940.6529673516125;6442.903356449657;6447.709853056624;6462.192225971754;6464.353564643545;6484.221893372778;29222;29980.57285180573;30367.848160759055;30451.847740761375;30483.23791905198;2126.415235810149;2142.121730090671;2152.87082775034;2158.525124472629;2159.8920053997394;20025.399238022736;20510.256628186624;20535.38393848187;20603.07286172111;20669;2538.289279001864;2545.567253566898;2626;2637.235201791478;2641.3528685472183;141315.29342353327;146999;147498;160382;168541;15832.366705331888;16634.417795377103;16670;16728.41450549225;17027.659446810994;27117.72882271152;27132.728672713416;27169.184924452296;27184.184474465797;27252;10690.572377104983;10697.251192416456;10768.138548916068;10876.619318323821;10888.29226100301;9667.081627245401;9689;9771.234179894798;9867.259955503367;9885.110340069428;9868.21054315653;9997.600815722544;10164.186865050779;10270.589176432859;10361.4301213434;2957.9704202957696;2969.8663560139844;2998.4902566563737;3026.334206474572;3096.442640324763;1037.5901518899993;1042.5673345561659;1053.8050460664801;1057.9788404231872;1061.3313612424124;21233.256836010667;21805.67291490629;21808.672869906964;21979.560408791735;22120.557588848133;1083.6911480228255;1111.9388433636227;1121.5962253588702;1128.4132251229478;1135.4436326200102;11543.480543375568;12081;12102.757944841054;12165.391730413445;12198.695032624079;573005;584533;590436;590511;627952;129931.35034324956;132306.33846830897;132869;134908.32545837207;135210.32394837964;1106.690126764507;1146.6789298996293;1213.7754515414676;1217.8599461062092;1261.8485781706254;21749.73753936922;22386.888065559568;22432.775672243723;22462.213822516132;22559.323220303417;61278.38721612905;61535.38464615297;62749.68625156845;62953.68523157355;63527.364726354;74238.62880685562;78189.21810781819;78299;78636.2136378629;79871.60064199643;15725.135117568643;15728.60678483047;15938.123403212934;16138.838611613734;16265.105419201584;23757;23919.52160956806;23934.401639959142;24060.51878962376;24245.272641820775;19103.235870565022;19816;19934.60130797347;19980;20009.599808004048;17197;17412.82587174112;17566.190428613838;17699.557511062325;18137.81862181414;18420.263189472273;18702.53243668919;19029;19030.809691902905;19036.619267614846;15743.921280393524;15745.13401762914;15801.920990394974;15823.525294240731;15858.60353491172;19414.320498782476;19619.313324033592;19634.60730785405;19699.70450443273;19919 12:17:20 INFO - PID 12844 | |3;mootools.html;1414.6958403943154;1507.6381668399574;1515.6589767302364;1534.2405509272912;1537.262114185191;16340.91829540852;16999.74500382495;17050.74423883641;17065.744013839787;17067.14664266785;16579.17104144794;16703.164841757894;16819.327226910907;16904.408345707903;16935.237914293855;2828.9292767680768;2851.7290857368516;2918.0953904289736;2924.4004978979365;2927.3267148555847;2816.4648716743854;2832.943341133176;2835.4754370441533;2856.9285767855763;2863.26986618412;2685.717999610042;2823.237725814039;2916.8833246670106;2917.8249305041763;2918.2412572731137;2638.6833579970335;2697.0695110186953;2892.884284628623;2929.9267518312;2946.1014390610853;2796.566532187514;2868.6557613086356;2885;2888.79778415511;2896.956545651817;16413.097279649613;16551.91724041384;16562.58593535159;16582.83417165825;16608.086555239457;8519.616617252239;8741.7814554636;8784.472931624123;8786.428882122642;8797.164269394398;5814.360420353758;5880.529557635422;6048.213732214784;6059.303180134253;6137.631742095488;2124.468882779305;2130.4247853079582;2131.5736852629534;2195.6706494025866;2200.9889950550305;28764.280892977633;28958.27604309909;28963.85518072396;29427.85286073556;29475.115746527852;7453.962730186315;7513.511621744569;7527.172011078777;7646.197149299243;7714.807129821799;19888.204471821253;19914.302999394953;19986.300479483147;20014.29949951745;20069.39791806248;8474.152584741476;8686.478811271218;8698.565071746387;8701.869471957925;8708.433951793113;7816.257455541714;7835.764927052198;7897.644605992744;7904.841903161904;7987.720429784929;5701.629394089371;5812.883742325214;5889.852753681106;5923.585349025613;5929.792457263975;1680.5378520906847;1711.8544923681377;1714.1600615698467;1740.6779745747078;1763.2682436788846;980.3137803537552;1004.7638804880847;1020.739711373595;1025.379645314574;1045.7019749371393;8905.154010369004;9003.954980225057;9031.909680903238;9078.182963533181;9142.177204051668;785.8899754034439;796.2873228460495;800.2477670989251;809.6599428240153;811.2090711556185;5210.53105220532;5446.8910621787345;5806.477417032487;6213.3581721549035;6365.49076073913;23995.28014159578;24056.7594324058;25060.248192554252;25175.874120629647;25198.118065867973;23531.17640882561;24433.511329773304;24594.50810983806;24676.506469870503;24752.628710569355;12474.501019959282;12535.937320313522;12833.422495987703;12882.033847461478;12896.742065158833;9557.522123893916;9590.712278631652;9624.941256461643;9639.132478077006;9912.454814984956;20164.193432262546;20265.392038238875;20657;20769.026942440443;21124.260650877146;21096.789032109482;21100.57798844045;21409;21601.459963501038;21718;12382.257064576153;12475.251484910934;12489.687757806127;12509.374531273217;12512.74974500523;14790.186539739987;14855;14996.325165367367;15168.469103581321;15205.087694738351;12330.260184388966;12559.93720031394;12764.744705106032;12858.678533036375;12992.350382481027;11964.521419143484;12031.097667674785;12059.69850753703;12292.446839892047;12427.813582796085;10694.358338499715;10749.89250107489;10816.621418250323;10819.621313253998;10828.079613232963;8564.314854811475;8647.092055334351;8659;8659.956700216459;8737.03892571804;8499.32005439551;8551.401401901807;8595.226429621363;8630.136986301319;8724.345674074342 12:17:20 INFO - PID 12844 | |4;prototype.html;558.6201383059517;563.701238343678;574.5604612471459;597.354856754705;614.0543562913114;6120.632762034275;6198.814035578935;6291.811245662638;6302.621842689437;6309.6683302609335;6204.751809927598;6220.667249781332;6245.437910588046;6257.217847769029;6267.498600111991;5141.82003629873;5151.072806894757;5214.921776173361;5214.983078299733;5220.582353411718;4925.38432695913;5075.264086707425;5084.313617661605;5163.122269214243;5163.173892177252;4962.528559786814;4989.600831933455;5021.372328458942;5035.924461133068;5059.949400506003;4962.3548938638105;4968.950310496885;4981.72600506972;5019.0463811875625;5028.949710502885;4567.33773602829;4592.908141837178;4594.839180628695;4663.533646635343;4672.532746725335;6154.599951003215;6190.112015835169;6202.224721909762;6250.249970003583;6250.312465628777;5917.8816423671715;5970.940290597082;5981.671008094553;5998.220231369937;6006.309274433453;6555.44278736308;6626.73493060277;6648.135742353512;6654.837177917197;6682;4957.82647607332;5116.386033675945;5121.180611102206;5128.1282182029145;5133.743312834344;6790.728370865159;6824.556403833784;6894.620795856226;7017.649117544102;7038.718451261943;5297.125974214211;5299.5230429261555;5329.8934021319355;5332.173513105475;5338.439463856239;5380.7309634518115;5387.75755091014;5393.352797664305;5395.11741873605;5410.648307860055;5868.794592189253;5880.295064270398;5912.231409916683;5983.491403230774;6016.157737916695;6757.966210169016;6780.898286525706;6782.796516104525;6783.491238157059;6786.287439818847;1862.938125268584;1864.1611274926338;1868.392772348992;1875.6998880179106;1884.5759704066475;1249.4377530111485;1336.1916040795372;1341.98009512771;1349.1702602899147;1353.1272329347516;6097.390260973867;6144.139820425144;6158.306465721962;6225.564210505312;6246.219222597176;6594.472442204612;6643.169603799525;6703.128593282842;6706.429953453913;6739.629320387327;6131.724072416752;6151.692415379213;6163.599366041193;6230.190075290183;6270.843228919313;3499.562554680665;3531.6644918732677;3539.309834582232;3550.899221241423;3557.8576856925433;6946.2011868635755;6999.51003429755;7009.264027277062;7034.577925324497;7069;6978.232394436608;6988.475864310197;6996.615186164708;7001.404880585207;7023.122109736283;6903.792886213421;6921.2732663069655;6985.301469852974;7015.614141222281;7072.8939065914055;6655.434288085373;6723.663816809238;6731.697073631601;6750.561213521302;6750.763723269662;6632.303608121078;6640.302768209269;6643.833904152435;6676.566023208476;6711.161104861892;6842.486813488908;6886.965565172142;6913.446924246149;6931.376176144171;6976.651167441709;5228.215767634885;5228.320318358741;5228.660137091077;5261.921071184011;5269.104252277046;6550.868982620416;6591.439727623206;6744.696488657924;6746.392824645805;6765.357291057342;6154.76904619087;6321.672448785623;6418.903716444351;6465.415973086436;6470.6441145737435;6386.68066596659;6452.257990331172;6507.316731743288;6512.511561632802;6548.377904099103;6267.811965641038;6352.682365881595;6400.23197216337;6415.1981002374705;6466.805995820133;6528.347165283433;6531.412172904462;6603;6628.403443689898;6673.866522669617;6380.266269379081;6382.44702119156;6385.201849768779;6400.615963042233;6476.8704625906275 12:17:20 INFO - PID 12844 | |5;yui.html;962.3696478806376;969.980600387992;992.7716625176209;995.462450276851;997.8154041502322;20974.790252097475;21505;21507.139714411423;21530.784692153073;21537.353879383605;19561.608767824637;19743.70384444231;19829.40511784645;19883.30408435705;19941.401757947286;1047.7904419116169;1065.8720953485592;1066.1524088349781;1066.5733706517378;1066.6160182334354;1040.6617849199004;1072.2387105155349;1077.1221454514546;1080.9135269178446;1081.816091264483;1124.3254047571475;1140.481081108098;1141.4178768827874;1141.9942900285487;1144.1933436926947;1133.18410744264;1140.2531341971023;1141.2981016674769;1141.9086473082175;1142.063507923503;786.6774622404844;812.808989887376;813.5606772342928;813.8372325534916;817.8159914019358;20879.686804697943;20937;20995.475113122142;21021.264255750975;21033.158673653037;23693.289201323987;23981.40046498834;24554.631680524806;24700.629490557476;24734.876325618436;18592.256309747594;18665.62668746631;18965.24139034437;18994;19029.80970190294;3771.754835935683;3780.7542509736777;3794.3739283018267;3797.2974999625158;3797.620237976208;170925;170999.14500427543;171339;172980;174180.12909935496;18072.728909066376;18346.63306733858;18353.449396518125;18387.356442524713;18423.447296581126;34101.82949085239;35372.469412958824;35883.82058089745;36139;36150.8192459036;9012.459252444874;9144.268458523302;9149.268058555434;9177.862332065024;9187.908120918706;4591.44902611682;4744.169770290186;4799.568038876518;4814.614830813526;4832.106060378841;6152.600080994721;6272.090546870678;6273.65494897785;6277.340879207709;6280.497560195174;1061.135174832509;1097.7804439112049;1099.1701265544623;1109.7225693576606;1113.9498722557505;688.769262297126;691.4813889582813;697.292248367907;701.435344547644;705.4074577355046;12728.6817829555;13548.661283467993;14016.509422170175;14050.437982480586;14216.857831421554;736.4403053679135;738.9593572353465;739;749.6476655971685;755.9395248380116;6227.314995350508;6233.501319894398;6235.563510554218;6309.873802523924;6315.842103947346;155484.22257888637;158912.20543897207;159107;160378;164933;137799;138831.30584347012;140232;141511;144580.27709861382;117437;118182;119503.40248298876;122474;123978.38010809888;11613.30320180792;11659.358735269641;11693;11812;11850.703732406759;55338.72330638321;56613;56943;56977;57051.42948570461;71877.64061179661;73026.63486682532;73242;73869.26130738624;74721.6263918677;17324.480265592054;17543.912280438515;18014.2794288227;18040.368587099387;18101.637967240844;19556.11997460146;19588.510287242934;19753.209871604973;19795;19848.30530931468;17940.730889036415;17948.641027179645;17953.461396158134;18005.819941800415;18219.453416397;17325.65348692994;17654.558636034202;17681.911590441967;17683.911580442014;17714.379996700052;17559.736603951205;17588.29646814164;17688.469345919642;17857.642847143245;17876.463706088838;12748.298843563693;12836.422360993964;12914.806277906027;12952.158109722837;12998.350082495648;13796.379162937492;13818;13844.723105538034;13853.515126970507;13907.930460347634 12:17:20 INFO - PID 12844 | __end_tp_report 12:17:20 INFO - PID 12844 | __start_cc_report 12:17:20 INFO - PID 12844 | _x_x_mozilla_cycle_collect,252 12:17:20 INFO - PID 12844 | __end_cc_report 12:17:20 INFO - PID 12844 | __startTimestamp1506712640008__endTimestamp 12:17:20 INFO - PID 12844 | 12:17:20 INFO - PID 12844 | ------- Summary: start ------- 12:17:20 INFO - PID 12844 | Number of tests: 6 12:17:20 INFO - PID 12844 | 12:17:20 INFO - PID 12844 | [#0] dojo.html Cycles:165 Average:6286.08 Median:6532.51 stddev:744.27 (11.4%) stddev-sans-first:720.96 12:17:20 INFO - PID 12844 | Values: 3819.9 3824.0 3824.9 3830.8 3888.1 6106.4 6136.9 6167.6 6242.3 6244.5 6278.7 6337.6 6395.6 6402.8 6422.9 5617.8 5646.2 5667.0 5735.5 5764.9 5597.6 5713.2 5721.3 5759.0 5784.9 5613.4 5658.8 5671.8 5693.9 5738.3 5655.4 5693.7 5699.6 5699.9 5706.5 5580.4 5618.9 5684.7 5729.7 5759.1 6219.3 6288.9 6299.7 6317.4 6391.1 6772.6 6833.9 6836.9 6872.1 6972.4 6912.7 6999.2 7020.7 7021.2 7028.4 6150.5 6192.5 6200.6 6375.2 6446.7 7053.2 7057.5 7063.9 7065.2 7074.6 6683.4 6714.5 6748.6 6754.7 6759.4 6840.0 6843.1 6848.5 6850.4 6854.4 6891.2 6896.7 6901.2 6904.3 6908.4 6846.8 6847.5 6850.6 6931.8 6944.8 4935.8 4998.5 5006.5 5078.6 5089.1 4590.1 4608.0 4619.7 4631.7 4636.2 6277.5 6345.0 6346.0 6346.2 6374.7 6751.1 6776.8 6779.2 6863.6 6872.7 6223.2 6279.7 6306.8 6344.6 6347.4 5433.5 5438.6 5447.9 5451.4 5466.7 6899.3 6931.0 6932.3 7007.8 7013.4 6601.6 6644.6 6700.2 6705.8 6713.3 7087.9 7092.2 7109.9 7148.5 7165.9 6693.6 6712.5 6722.6 6734.8 6747.1 6668.2 6772.6 6847.1 6848.2 6850.1 6462.3 6471.1 6524.9 6557.7 6635.2 6585.2 6599.6 6624.6 6627.4 6674.6 6438.7 6518.8 6536.4 6590.5 6601.8 6662.4 6745.7 6752.6 6757.1 6776.4 6474.6 6506.5 6532.5 6547.1 6560.4 12:17:20 INFO - PID 12844 | 12:17:20 INFO - PID 12844 | [#1] ext.html Cycles:180 Average:43600.94 Median:34582.15 stddev:68604.32 (198.4%) stddev-sans-first:68721.84 12:17:20 INFO - PID 12844 | Values: 897.6 958.8 984.1 1281.1 1301.4 43135.4 44764.6 44843.1 44879.8 44918.6 44362.0 44672.0 44722.3 45068.8 45097.0 8016.6 8019.8 8025.4 8035.4 8190.5 8164.3 8290.5 8325.7 8327.8 8356.4 8330.3 8338.3 8373.2 8421.1 8590.0 8504.7 8550.8 8555.3 8557.7 8561.1 8308.3 8396.5 8474.3 8485.3 8489.5 41319.8 41766.6 41846.8 41905.4 42014.4 3717.5 3726.1 3742.1 3761.8 3790.7 34291.0 34341.3 34352.7 34457.8 34706.5 5305.8 5318.7 5331.0 5354.1 5380.9 228243.0 228575.0 228736.0 228945.0 230846.0 54285.7 54667.0 54685.2 54970.7 55012.0 57877.0 57993.8 58085.0 58324.7 58591.7 15453.5 15509.2 15533.3 15593.8 15636.8 12525.3 12571.2 12572.8 12579.4 12593.4 15636.3 15802.0 15979.4 15984.6 15989.4 5275.8 6403.2 6425.0 6434.4 6710.7 1100.5 1113.2 1122.4 1123.0 1124.8 25496.7 25684.6 25745.4 25780.6 25898.5 1187.5 1192.5 1204.2 1204.4 1205.4 13651.2 13700.2 13791.6 13894.2 13947.9 307543.0 308841.0 309815.0 310493.0 311173.0 60322.4 60521.1 60816.7 60820.4 61027.4 1476.4 1492.1 1503.6 1512.3 1534.1 24977.1 25368.5 25666.0 25698.4 25718.2 42333.0 42413.0 42430.4 42471.8 42515.1 240722.0 241876.0 243552.0 244891.0 244984.0 32606.7 32777.5 32791.2 32794.8 32901.0 41418.0 42654.6 42986.8 43023.8 43197.4 31773.5 32607.5 32660.3 32674.5 32713.3 32344.7 32359.0 32573.3 33190.8 33193.5 37952.4 38046.2 38124.2 38413.8 38482.4 31260.4 31497.7 31802.2 31812.8 32334.0 24259.3 24354.9 24441.9 25203.5 25211.1 12:17:20 INFO - PID 12844 | 12:17:20 INFO - PID 12844 | [#2] jquery.html Cycles:180 Average:39661.15 Median:22447.49 stddev:99531.26 (443.4%) stddev-sans-first:99767.31 12:17:20 INFO - PID 12844 | Values: 623.6 627.2 635.6 644.9 647.9 22622.3 23022.8 23878.3 24079.4 24414.9 25926.2 26224.6 26273.2 26280.0 26307.6 6699.0 6699.2 6728.0 6748.6 6789.6 6883.6 6950.8 6962.7 6964.2 6969.9 6852.1 6908.0 6921.4 6925.1 6925.4 6868.4 6926.3 6926.5 6934.1 6940.7 6442.9 6447.7 6462.2 6464.4 6484.2 29222.0 29980.6 30367.8 30451.8 30483.2 2126.4 2142.1 2152.9 2158.5 2159.9 20025.4 20510.3 20535.4 20603.1 20669.0 2538.3 2545.6 2626.0 2637.2 2641.4 141315.3 146999.0 147498.0 160382.0 168541.0 15832.4 16634.4 16670.0 16728.4 17027.7 27117.7 27132.7 27169.2 27184.2 27252.0 10690.6 10697.3 10768.1 10876.6 10888.3 9667.1 9689.0 9771.2 9867.3 9885.1 9868.2 9997.6 10164.2 10270.6 10361.4 2958.0 2969.9 2998.5 3026.3 3096.4 1037.6 1042.6 1053.8 1058.0 1061.3 21233.3 21805.7 21808.7 21979.6 22120.6 1083.7 1111.9 1121.6 1128.4 1135.4 11543.5 12081.0 12102.8 12165.4 12198.7 573005.0 584533.0 590436.0 590511.0 627952.0 129931.4 132306.3 132869.0 134908.3 135210.3 1106.7 1146.7 1213.8 1217.9 1261.8 21749.7 22386.9 22432.8 22462.2 22559.3 61278.4 61535.4 62749.7 62953.7 63527.4 74238.6 78189.2 78299.0 78636.2 79871.6 15725.1 15728.6 15938.1 16138.8 16265.1 23757.0 23919.5 23934.4 24060.5 24245.3 19103.2 19816.0 19934.6 19980.0 20009.6 17197.0 17412.8 17566.2 17699.6 18137.8 18420.3 18702.5 19029.0 19030.8 19036.6 15743.9 15745.1 15801.9 15823.5 15858.6 19414.3 19619.3 19634.6 19699.7 19919.0 12:17:20 INFO - PID 12844 | 12:17:20 INFO - PID 12844 | [#3] mootools.html Cycles:180 Average:10393.09 Median:2691.39 stddev:7485.67 (278.1%) stddev-sans-first:7476.27 12:17:20 INFO - PID 12844 | Values: 1414.7 1507.6 1515.7 1534.2 1537.3 16340.9 16999.7 17050.7 17065.7 17067.1 16579.2 16703.2 16819.3 16904.4 16935.2 2828.9 2851.7 2918.1 2924.4 2927.3 2816.5 2832.9 2835.5 2856.9 2863.3 2685.7 2823.2 2916.9 2917.8 2918.2 2638.7 2697.1 2892.9 2929.9 2946.1 2796.6 2868.7 2885.0 2888.8 2897.0 16413.1 16551.9 16562.6 16582.8 16608.1 8519.6 8741.8 8784.5 8786.4 8797.2 5814.4 5880.5 6048.2 6059.3 6137.6 2124.5 2130.4 2131.6 2195.7 2201.0 28764.3 28958.3 28963.9 29427.9 29475.1 7454.0 7513.5 7527.2 7646.2 7714.8 19888.2 19914.3 19986.3 20014.3 20069.4 8474.2 8686.5 8698.6 8701.9 8708.4 7816.3 7835.8 7897.6 7904.8 7987.7 5701.6 5812.9 5889.9 5923.6 5929.8 1680.5 1711.9 1714.2 1740.7 1763.3 980.3 1004.8 1020.7 1025.4 1045.7 8905.2 9004.0 9031.9 9078.2 9142.2 785.9 796.3 800.2 809.7 811.2 5210.5 5446.9 5806.5 6213.4 6365.5 23995.3 24056.8 25060.2 25175.9 25198.1 23531.2 24433.5 24594.5 24676.5 24752.6 12474.5 12535.9 12833.4 12882.0 12896.7 9557.5 9590.7 9624.9 9639.1 9912.5 20164.2 20265.4 20657.0 20769.0 21124.3 21096.8 21100.6 21409.0 21601.5 21718.0 12382.3 12475.3 12489.7 12509.4 12512.7 14790.2 14855.0 14996.3 15168.5 15205.1 12330.3 12559.9 12764.7 12858.7 12992.4 11964.5 12031.1 12059.7 12292.4 12427.8 10694.4 10749.9 10816.6 10819.6 10828.1 8564.3 8647.1 8659.0 8660.0 8737.0 8499.3 8551.4 8595.2 8630.1 8724.3 12:17:20 INFO - PID 12844 | 12:17:20 INFO - PID 12844 | [#4] prototype.html Cycles:180 Average:5650.36 Median:6237.81 stddev:1553.81 (24.9%) stddev-sans-first:1510.44 12:17:20 INFO - PID 12844 | Values: 558.6 563.7 574.6 597.4 614.1 6120.6 6198.8 6291.8 6302.6 6309.7 6204.8 6220.7 6245.4 6257.2 6267.5 5141.8 5151.1 5214.9 5215.0 5220.6 4925.4 5075.3 5084.3 5163.1 5163.2 4962.5 4989.6 5021.4 5035.9 5059.9 4962.4 4969.0 4981.7 5019.0 5028.9 4567.3 4592.9 4594.8 4663.5 4672.5 6154.6 6190.1 6202.2 6250.2 6250.3 5917.9 5970.9 5981.7 5998.2 6006.3 6555.4 6626.7 6648.1 6654.8 6682.0 4957.8 5116.4 5121.2 5128.1 5133.7 6790.7 6824.6 6894.6 7017.6 7038.7 5297.1 5299.5 5329.9 5332.2 5338.4 5380.7 5387.8 5393.4 5395.1 5410.6 5868.8 5880.3 5912.2 5983.5 6016.2 6758.0 6780.9 6782.8 6783.5 6786.3 1862.9 1864.2 1868.4 1875.7 1884.6 1249.4 1336.2 1342.0 1349.2 1353.1 6097.4 6144.1 6158.3 6225.6 6246.2 6594.5 6643.2 6703.1 6706.4 6739.6 6131.7 6151.7 6163.6 6230.2 6270.8 3499.6 3531.7 3539.3 3550.9 3557.9 6946.2 6999.5 7009.3 7034.6 7069.0 6978.2 6988.5 6996.6 7001.4 7023.1 6903.8 6921.3 6985.3 7015.6 7072.9 6655.4 6723.7 6731.7 6750.6 6750.8 6632.3 6640.3 6643.8 6676.6 6711.2 6842.5 6887.0 6913.4 6931.4 6976.7 5228.2 5228.3 5228.7 5261.9 5269.1 6550.9 6591.4 6744.7 6746.4 6765.4 6154.8 6321.7 6418.9 6465.4 6470.6 6386.7 6452.3 6507.3 6512.5 6548.4 6267.8 6352.7 6400.2 6415.2 6466.8 6528.3 6531.4 6603.0 6628.4 6673.9 6380.3 6382.4 6385.2 6400.6 6476.9 12:17:20 INFO - PID 12844 | 12:17:20 INFO - PID 12844 | [#5] yui.html Cycles:180 Average:29551.42 Median:18628.94 stddev:45134.06 (242.3%) stddev-sans-first:45209.62 12:17:20 INFO - PID 12844 | Values: 962.4 970.0 992.8 995.5 997.8 20974.8 21505.0 21507.1 21530.8 21537.4 19561.6 19743.7 19829.4 19883.3 19941.4 1047.8 1065.9 1066.2 1066.6 1066.6 1040.7 1072.2 1077.1 1080.9 1081.8 1124.3 1140.5 1141.4 1142.0 1144.2 1133.2 1140.3 1141.3 1141.9 1142.1 786.7 812.8 813.6 813.8 817.8 20879.7 20937.0 20995.5 21021.3 21033.2 23693.3 23981.4 24554.6 24700.6 24734.9 18592.3 18665.6 18965.2 18994.0 19029.8 3771.8 3780.8 3794.4 3797.3 3797.6 170925.0 170999.1 171339.0 172980.0 174180.1 18072.7 18346.6 18353.4 18387.4 18423.4 34101.8 35372.5 35883.8 36139.0 36150.8 9012.5 9144.3 9149.3 9177.9 9187.9 4591.4 4744.2 4799.6 4814.6 4832.1 6152.6 6272.1 6273.7 6277.3 6280.5 1061.1 1097.8 1099.2 1109.7 1113.9 688.8 691.5 697.3 701.4 705.4 12728.7 13548.7 14016.5 14050.4 14216.9 736.4 739.0 739.0 749.6 755.9 6227.3 6233.5 6235.6 6309.9 6315.8 155484.2 158912.2 159107.0 160378.0 164933.0 137799.0 138831.3 140232.0 141511.0 144580.3 117437.0 118182.0 119503.4 122474.0 123978.4 11613.3 11659.4 11693.0 11812.0 11850.7 55338.7 56613.0 56943.0 56977.0 57051.4 71877.6 73026.6 73242.0 73869.3 74721.6 17324.5 17543.9 18014.3 18040.4 18101.6 19556.1 19588.5 19753.2 19795.0 19848.3 17940.7 17948.6 17953.5 18005.8 18219.5 17325.7 17654.6 17681.9 17683.9 17714.4 17559.7 17588.3 17688.5 17857.6 17876.5 12748.3 12836.4 12914.8 12952.2 12998.4 13796.4 13818.0 13844.7 13853.5 13907.9 12:17:20 INFO - PID 12844 | -------- Summary: end -------- 12:17:20 INFO - PID 12844 | 12:17:20 INFO - TEST-INFO | 12844: exit 0 12:17:20 INFO - TEST-OK | dromaeo_css | took 1108318ms 12:17:20 INFO - TEST-START | kraken 12:17:20 INFO - Initialising browser for kraken test... 12:17:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41654/getInfo.html -profile /tmp/tmpZoBwrP/profile 12:17:20 INFO - TEST-INFO | started process 13206 (/builds/slave/test/build/application/firefox/firefox http://localhost:41654/getInfo.html) 12:17:26 INFO - TEST-INFO | 13206: exit 0 12:17:26 INFO - Browser initialized. 12:17:26 INFO - Running cycle 1/1 for kraken test... 12:17:26 INFO - Using env: {'DISPLAY': ':0', 12:17:26 INFO - 'HOME': '/home/cltbld', 12:17:26 INFO - 'JSGC_DISABLE_POISONING': '1', 12:17:26 INFO - 'LANG': 'en_US.UTF-8', 12:17:26 INFO - 'LANGUAGE': 'en_US:en', 12:17:26 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:17:26 INFO - 'LOGNAME': 'cltbld', 12:17:26 INFO - 'MAIL': '/var/mail/cltbld', 12:17:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:17:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:17:26 INFO - 'MOZ_CRASHREPORTER': '1', 12:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:26 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:17:26 INFO - 'MOZ_NO_REMOTE': '1', 12:17:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:26 INFO - 'NO_EM_RESTART': '1', 12:17:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:26 INFO - 'PWD': '/builds/slave/test', 12:17:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:17:26 INFO - 'RUST_BACKTRACE': 'full', 12:17:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:17:26 INFO - 'SHELL': '/bin/bash', 12:17:26 INFO - 'SHLVL': '1', 12:17:26 INFO - 'STYLO_FORCE_DISABLED': '1', 12:17:26 INFO - 'TERM': 'linux', 12:17:26 INFO - 'TMOUT': '86400', 12:17:26 INFO - 'USER': 'cltbld', 12:17:26 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506711229.656374-389775371', 12:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:26 INFO - '_': '/tools/buildbot/bin/python'} 12:17:26 INFO - TEST-INFO | started process 13439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZoBwrP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:17:26 INFO - PID 13439 | 12:17:26 INFO - PID 13439 | (/builds/slave/test/build/application/firefox/firefox:13489): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:17:26 INFO - PID 13439 | 12:17:37 INFO - PID 13439 | RSS: Main: 144711680 12:17:37 INFO - PID 13439 | 12:17:39 INFO - PID 13439 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41654/tests/kraken/driver.html?testName=audio-beat-detection) 12:17:40 INFO - PID 13439 | RSS: Main: 150634496 12:17:40 INFO - PID 13439 | 12:17:43 INFO - PID 13439 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41654/tests/kraken/driver.html?testName=audio-dft) 12:17:43 INFO - PID 13439 | RSS: Main: 151089152 12:17:43 INFO - PID 13439 | 12:17:46 INFO - PID 13439 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41654/tests/kraken/driver.html?testName=audio-fft) 12:17:47 INFO - PID 13439 | RSS: Main: 147472384 12:17:47 INFO - PID 13439 | 12:17:49 INFO - PID 13439 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41654/tests/kraken/driver.html?testName=audio-oscillator) 12:17:50 INFO - PID 13439 | RSS: Main: 148557824 12:17:50 INFO - PID 13439 | 12:17:52 INFO - PID 13439 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41654/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:17:52 INFO - PID 13439 | RSS: Main: 148717568 12:17:52 INFO - PID 13439 | 12:17:55 INFO - PID 13439 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41654/tests/kraken/driver.html?testName=imaging-darkroom) 12:17:56 INFO - PID 13439 | RSS: Main: 148619264 12:17:56 INFO - PID 13439 | 12:17:59 INFO - PID 13439 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41654/tests/kraken/driver.html?testName=imaging-desaturate) 12:18:00 INFO - PID 13439 | RSS: Main: 150007808 12:18:00 INFO - PID 13439 | 12:18:03 INFO - PID 13439 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41654/tests/kraken/driver.html?testName=json-parse-financial) 12:18:04 INFO - PID 13439 | RSS: Main: 151564288 12:18:04 INFO - PID 13439 | 12:18:05 INFO - PID 13439 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41654/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:18:06 INFO - PID 13439 | RSS: Main: 151969792 12:18:06 INFO - PID 13439 | 12:18:07 INFO - PID 13439 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41654/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:18:08 INFO - PID 13439 | RSS: Main: 151793664 12:18:08 INFO - PID 13439 | 12:18:10 INFO - PID 13439 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41654/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:18:10 INFO - PID 13439 | RSS: Main: 148787200 12:18:10 INFO - PID 13439 | 12:18:13 INFO - PID 13439 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:18:13 INFO - PID 13439 | RSS: Main: 148787200 12:18:13 INFO - PID 13439 | 12:18:16 INFO - PID 13439 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:18:17 INFO - PID 13439 | RSS: Main: 149372928 12:18:17 INFO - PID 13439 | 12:18:18 INFO - PID 13439 | Cycle 1(1): loaded http://localhost:41654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41654/tests/kraken/driver.html?testName=ai-astar) 12:18:19 INFO - PID 13439 | RSS: Main: 150609920 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | __start_tp_report 12:18:19 INFO - PID 13439 | _x_x_mozilla_page_load 12:18:19 INFO - PID 13439 | _x_x_mozilla_page_load_details 12:18:19 INFO - PID 13439 | |i|pagename|runs| 12:18:19 INFO - PID 13439 | |0;ai-astar;106;105;104;104;104;106;109;105;103;107 12:18:19 INFO - PID 13439 | |1;audio-beat-detection;114;113;111;113;111;139;115;116;112;113 12:18:19 INFO - PID 13439 | |2;audio-dft;162;164;161;162;162;162;163;162;160;164 12:18:19 INFO - PID 13439 | |3;audio-fft;73;73;73;72;73;72;76;72;74;74 12:18:19 INFO - PID 13439 | |4;audio-oscillator;77;78;77;80;77;76;77;77;79;78 12:18:19 INFO - PID 13439 | |5;imaging-gaussian-blur;111;111;111;111;111;111;111;111;111;113 12:18:19 INFO - PID 13439 | |6;imaging-darkroom;150;150;149;149;150;150;149;149;150;150 12:18:19 INFO - PID 13439 | |7;imaging-desaturate;94;94;99;97;94;94;94;94;97;95 12:18:19 INFO - PID 13439 | |8;json-parse-financial;46;47;44;45;46;44;44;48;47;46 12:18:19 INFO - PID 13439 | |9;json-stringify-tinderbox;36;36;36;36;36;36;36;35;36;35 12:18:19 INFO - PID 13439 | |10;stanford-crypto-aes;71;71;72;71;72;71;71;71;72;71 12:18:19 INFO - PID 13439 | |11;stanford-crypto-ccm;104;104;108;104;107;110;101;112;107;108 12:18:19 INFO - PID 13439 | |12;stanford-crypto-pbkdf2;151;154;153;156;148;160;151;150;153;158 12:18:19 INFO - PID 13439 | |13;stanford-crypto-sha256-iterative;61;61;57;59;57;61;59;59;58;59 12:18:19 INFO - PID 13439 | __end_tp_report 12:18:19 INFO - PID 13439 | __start_cc_report 12:18:19 INFO - PID 13439 | _x_x_mozilla_cycle_collect,697 12:18:19 INFO - PID 13439 | __end_cc_report 12:18:19 INFO - PID 13439 | __startTimestamp1506712699145__endTimestamp 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | ------- Summary: start ------- 12:18:19 INFO - PID 13439 | Number of tests: 14 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | [#0] ai-astar Cycles:10 Average:105.30 Median:105.50 stddev:1.77 (1.7%) stddev-sans-first:1.86 12:18:19 INFO - PID 13439 | Values: 106.0 105.0 104.0 104.0 104.0 106.0 109.0 105.0 103.0 107.0 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | [#1] audio-beat-detection Cycles:10 Average:115.70 Median:113.50 stddev:8.34 (7.3%) stddev-sans-first:8.82 12:18:19 INFO - PID 13439 | Values: 114.0 113.0 111.0 113.0 111.0 139.0 115.0 116.0 112.0 113.0 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 12:18:19 INFO - PID 13439 | Values: 162.0 164.0 161.0 162.0 162.0 162.0 163.0 162.0 160.0 164.0 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | [#3] audio-fft Cycles:10 Average:73.20 Median:73.00 stddev:1.23 (1.7%) stddev-sans-first:1.30 12:18:19 INFO - PID 13439 | Values: 73.0 73.0 73.0 72.0 73.0 72.0 76.0 72.0 74.0 74.0 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:77.50 stddev:1.17 (1.5%) stddev-sans-first:1.22 12:18:19 INFO - PID 13439 | Values: 77.0 78.0 77.0 80.0 77.0 76.0 77.0 77.0 79.0 78.0 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | [#5] imaging-gaussian-blur Cycles:10 Average:111.20 Median:111.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 12:18:19 INFO - PID 13439 | Values: 111.0 111.0 111.0 111.0 111.0 111.0 111.0 111.0 111.0 113.0 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 12:18:19 INFO - PID 13439 | Values: 150.0 150.0 149.0 149.0 150.0 150.0 149.0 149.0 150.0 150.0 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.50 stddev:1.81 (1.9%) stddev-sans-first:1.87 12:18:19 INFO - PID 13439 | Values: 94.0 94.0 99.0 97.0 94.0 94.0 94.0 94.0 97.0 95.0 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | [#8] json-parse-financial Cycles:10 Average:45.70 Median:46.00 stddev:1.42 (3.1%) stddev-sans-first:1.50 12:18:19 INFO - PID 13439 | Values: 46.0 47.0 44.0 45.0 46.0 44.0 44.0 48.0 47.0 46.0 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | [#9] json-stringify-tinderbox Cycles:10 Average:35.80 Median:36.00 stddev:0.42 (1.2%) stddev-sans-first:0.44 12:18:19 INFO - PID 13439 | Values: 36.0 36.0 36.0 36.0 36.0 36.0 36.0 35.0 36.0 35.0 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | [#10] stanford-crypto-aes Cycles:10 Average:71.30 Median:71.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 12:18:19 INFO - PID 13439 | Values: 71.0 71.0 72.0 71.0 72.0 71.0 71.0 71.0 72.0 71.0 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | [#11] stanford-crypto-ccm Cycles:10 Average:106.50 Median:107.50 stddev:3.27 (3.0%) stddev-sans-first:3.35 12:18:19 INFO - PID 13439 | Values: 104.0 104.0 108.0 104.0 107.0 110.0 101.0 112.0 107.0 108.0 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:153.50 stddev:3.72 (2.4%) stddev-sans-first:3.84 12:18:19 INFO - PID 13439 | Values: 151.0 154.0 153.0 156.0 148.0 160.0 151.0 150.0 153.0 158.0 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.10 Median:59.00 stddev:1.52 (2.6%) stddev-sans-first:1.45 12:18:19 INFO - PID 13439 | Values: 61.0 61.0 57.0 59.0 57.0 61.0 59.0 59.0 58.0 59.0 12:18:19 INFO - PID 13439 | -------- Summary: end -------- 12:18:19 INFO - PID 13439 | 12:18:19 INFO - PID 13439 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:18:19 INFO - TEST-INFO | 13439: exit 0 12:18:19 INFO - TEST-OK | kraken | took 59244ms 12:18:19 INFO - SUITE-END | took 1167s 12:18:19 INFO - Completed test suite (00:19:27) 12:18:19 INFO - javascript benchmark 12:18:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9130.230564767839, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3819.885403437898, 3823.9808800955993, 3824.9235015299714, 3830.7510011849226, 3888.0862997195663, 6106.3893610639025, 6136.9079463808075, 6167.599106058103, 6242.344553821846, 6244.500439964803, 6278.68606569672, 6337.588056776306, 6395.552311338208, 6402.8079157625225, 6422.9357706422925, 5617.775288988436, 5646.18130371096, 5667.0, 5735.483806457418, 5764.855878603047, 5597.552195824324, 5713.228714123603, 5721.342045664739, 5758.971205143989, 5784.855378615547, 5613.4386561343945, 5658.830235092953, 5671.829845104653, 5693.886122277573, 5738.340090889559, 5655.406182350876, 5693.715314234271, 5699.601027928046, 5699.886002279931, 5706.54347652191, 5580.414056524088, 5618.859528511779, 5684.7157642118145, 5729.713514324267, 5759.136129580555, 6219.346968568326, 6288.937110628926, 6299.6850157491945, 6317.368263173692, 6391.073294372336, 6772.593644381303, 6833.897491537631, 6836.931630683679, 6872.10662613857, 6972.442204623618, 6912.688928998207, 6999.160100787887, 7020.684069216846, 7021.192562855286, 7028.43772498204, 6150.50795936324, 6192.504599632019, 6200.565960382775, 6375.2349718033665, 6446.677666116675, 7053.188883278489, 7057.50597458173, 7063.89404158938, 7065.2228254891925, 7074.610896400747, 6683.365080317362, 6714.462842972551, 6748.595084294958, 6754.696038678271, 6759.391654751096, 6840.0, 6843.110395648534, 6848.486363522756, 6850.38346548813, 6854.383105520527, 6891.173059232824, 6896.724131034803, 6901.206361268418, 6904.3095690430555, 6908.378245957888, 6846.828829279308, 6847.520673552804, 6850.623215723183, 6931.792046238621, 6944.826379340456, 4935.802567897315, 4998.500149984972, 5006.499350065037, 5078.593712503065, 5089.134847076006, 4590.081983603292, 4607.976960115245, 4619.653525985565, 4631.745254011062, 4636.188666983265, 6277.466415354746, 6345.0, 6346.048092786119, 6346.174997250328, 6374.74501019954, 6751.054852320679, 6776.830579235559, 6779.220389655253, 6863.553868998499, 6872.656367181621, 6223.190985171898, 6279.654618995908, 6306.842328941813, 6344.555881088279, 6347.428731414195, 5433.538149257357, 5438.619296649275, 5447.918281225785, 5451.373092094381, 5466.699331536804, 6899.310068993061, 6931.029655848185, 6932.341427564374, 7007.789766307019, 7013.438924885997, 6601.603903765789, 6644.568103073285, 6700.229473610597, 6705.832354191184, 6713.328667133248, 7087.929120708934, 7092.219855815959, 7109.928900710926, 7148.499605027806, 7165.8925116122255, 6693.564918280296, 6712.463002959849, 6722.563033402813, 6734.764283250062, 6747.089142965833, 6668.233153187445, 6772.5936443813525, 6847.144106986627, 6848.2466928638805, 6850.075239842757, 6462.321456247027, 6471.06169605414, 6524.934750652433, 6557.672116394257, 6635.2037755469655, 6585.176852893388, 6599.571027883172, 6624.635645039569, 6627.37039981201, 6674.599524028574, 6438.742450301936, 6518.804435866931, 6536.379043990813, 6590.505712071518, 6601.768938087144, 6662.433693136138, 6745.730170793114, 6752.628605426552, 6757.087793147862, 6776.390124888783, 6474.5791523550815, 6506.544541882212, 6532.510061745293, 6547.050677651809, 6560.40956313934], "value": 6235.521860907281, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.5960817632067, 958.7986522830205, 984.0503913723255, 1281.1032277405818, 1301.4078594239622, 43135.35296970544, 44764.552354476444, 44843.103137937265, 44879.77560112203, 44918.55081449184, 44362.0, 44672.0, 44722.32916506247, 45068.774656126676, 45097.0, 8016.599170041503, 8019.799505012377, 8025.438219324649, 8035.437519373646, 8190.467619604737, 8164.265216130547, 8290.544020078893, 8325.708600198994, 8327.83344333116, 8356.415050946436, 8330.291925186337, 8338.291245244161, 8373.204545568162, 8421.115782842806, 8589.95705021474, 8504.744857654281, 8550.828983420328, 8555.272801811885, 8557.700480483154, 8561.0582835888, 8308.252257296812, 8396.496210227406, 8474.322054235647, 8485.32117430604, 8489.490630562124, 41319.7934010328, 41766.58233417657, 41846.790766045975, 41905.37141942873, 42014.36978445326, 3717.4795528626014, 3726.124360775216, 3742.064483879003, 3761.793101379423, 3790.6777923876502, 34291.0, 34341.31317373639, 34352.65647343519, 34457.82771086154, 34706.479402808975, 5305.840824775263, 5318.73406329682, 5330.973345133289, 5354.116570765819, 5380.91928621071, 228243.0, 228575.0, 228736.0, 228945.0, 230846.0, 54285.72857135689, 54667.0, 54685.179722304194, 54970.72514637481, 55012.0, 57877.0, 57993.8401231973, 58085.0, 58324.70837645785, 58591.70704146452, 15453.459128930434, 15509.224538773242, 15533.301001454962, 15593.844061559466, 15636.765448518281, 12525.31110788897, 12571.245725256515, 12572.811407828889, 12579.433925473375, 12593.433295501725, 15636.296366663528, 15802.0, 15979.360825566848, 15984.600384990235, 15989.440369587008, 5275.841724748264, 6403.167588213502, 6424.982946709077, 6434.420902118738, 6710.698018589175, 1100.5487750022612, 1113.2207454781685, 1122.3882983773863, 1122.960696375623, 1124.8200287954053, 25496.745032549807, 25684.614730779052, 25745.356366090622, 25780.613290800655, 25898.482030359664, 1187.5309252845077, 1192.4557697781395, 1204.175140029083, 1204.4158583087196, 1205.4093494187784, 13651.180929144084, 13700.177989320473, 13791.586252412444, 13894.166350019032, 13947.930260348634, 307543.0, 308841.0, 309815.0, 310493.0, 311173.0, 60322.39677603168, 60521.09218361728, 60816.69591652013, 60820.39179608236, 61027.38972610306, 1476.372541669786, 1492.0898252066231, 1503.6466430389069, 1512.3496896334461, 1534.1436861397833, 24977.126715496048, 25368.492630147663, 25666.0, 25698.35754106162, 25718.228453146436, 42333.0, 42413.0, 42430.36354454624, 42471.78764106159, 42515.149697006505, 240722.0, 241876.0, 243552.0, 244891.0, 244984.0, 32606.695732171396, 32777.50833737448, 32791.18022049468, 32794.83602581972, 32901.0, 41418.0, 42654.573454266305, 42986.785066074466, 43023.78488107539, 43197.352039720055, 31773.523397148598, 32607.510887336233, 32660.34679306448, 32674.50988235226, 32713.34573308473, 32344.676553234167, 32359.0, 32573.309395571327, 33190.834045829615, 33193.502097468074, 37952.43071353987, 38046.239075218895, 38124.237515248984, 38413.80793096129, 38482.42276365801, 31260.374792504477, 31497.685023149475, 31802.204944875637, 31812.84093579517, 32334.029979100666, 24259.272221833373, 24354.904029318368, 24441.87779061093, 25203.495930081663, 25211.11761088353], "value": 18655.965500419854, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.5541587764748, 627.2473032361167, 635.6481020225165, 644.8678021005688, 647.8866198415277, 22622.321330360115, 23022.769772302272, 23878.28365149044, 24079.39801504961, 24414.877925610348, 25926.22221333358, 26224.606630900504, 26273.21180364592, 26280.0, 26307.605385919225, 6698.966505167467, 6699.19609646843, 6727.966360168192, 6748.595084294933, 6789.5926244425245, 6883.621400822953, 6950.79147625572, 6962.651867406635, 6964.164300283973, 6969.930300697004, 6852.074969879077, 6908.0, 6921.411680007205, 6925.065116209297, 6925.37671609555, 6868.416184624338, 6926.307369263084, 6926.480513961473, 6934.063901373301, 6940.6529673516125, 6442.903356449657, 6447.709853056624, 6462.192225971754, 6464.353564643545, 6484.221893372778, 29222.0, 29980.57285180573, 30367.848160759055, 30451.847740761375, 30483.23791905198, 2126.415235810149, 2142.121730090671, 2152.87082775034, 2158.525124472629, 2159.8920053997394, 20025.399238022736, 20510.256628186624, 20535.38393848187, 20603.07286172111, 20669.0, 2538.289279001864, 2545.567253566898, 2626.0, 2637.235201791478, 2641.3528685472183, 141315.29342353327, 146999.0, 147498.0, 160382.0, 168541.0, 15832.366705331888, 16634.417795377103, 16670.0, 16728.41450549225, 17027.659446810994, 27117.72882271152, 27132.728672713416, 27169.184924452296, 27184.184474465797, 27252.0, 10690.572377104983, 10697.251192416456, 10768.138548916068, 10876.619318323821, 10888.29226100301, 9667.081627245401, 9689.0, 9771.234179894798, 9867.259955503367, 9885.110340069428, 9868.21054315653, 9997.600815722544, 10164.186865050779, 10270.589176432859, 10361.4301213434, 2957.9704202957696, 2969.8663560139844, 2998.4902566563737, 3026.334206474572, 3096.442640324763, 1037.5901518899993, 1042.5673345561659, 1053.8050460664801, 1057.9788404231872, 1061.3313612424124, 21233.256836010667, 21805.67291490629, 21808.672869906964, 21979.560408791735, 22120.557588848133, 1083.6911480228255, 1111.9388433636227, 1121.5962253588702, 1128.4132251229478, 1135.4436326200102, 11543.480543375568, 12081.0, 12102.757944841054, 12165.391730413445, 12198.695032624079, 573005.0, 584533.0, 590436.0, 590511.0, 627952.0, 129931.35034324956, 132306.33846830897, 132869.0, 134908.32545837207, 135210.32394837964, 1106.690126764507, 1146.6789298996293, 1213.7754515414676, 1217.8599461062092, 1261.8485781706254, 21749.73753936922, 22386.888065559568, 22432.775672243723, 22462.213822516132, 22559.323220303417, 61278.38721612905, 61535.38464615297, 62749.68625156845, 62953.68523157355, 63527.364726354, 74238.62880685562, 78189.21810781819, 78299.0, 78636.2136378629, 79871.60064199643, 15725.135117568643, 15728.60678483047, 15938.123403212934, 16138.838611613734, 16265.105419201584, 23757.0, 23919.52160956806, 23934.401639959142, 24060.51878962376, 24245.272641820775, 19103.235870565022, 19816.0, 19934.60130797347, 19980.0, 20009.599808004048, 17197.0, 17412.82587174112, 17566.190428613838, 17699.557511062325, 18137.81862181414, 18420.263189472273, 18702.53243668919, 19029.0, 19030.809691902905, 19036.619267614846, 15743.921280393524, 15745.13401762914, 15801.920990394974, 15823.525294240731, 15858.60353491172, 19414.320498782476, 19619.313324033592, 19634.60730785405, 19699.70450443273, 19919.0], "value": 12935.778901909702, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.6958403943154, 1507.6381668399574, 1515.6589767302364, 1534.2405509272912, 1537.262114185191, 16340.91829540852, 16999.74500382495, 17050.74423883641, 17065.744013839787, 17067.14664266785, 16579.17104144794, 16703.164841757894, 16819.327226910907, 16904.408345707903, 16935.237914293855, 2828.9292767680768, 2851.7290857368516, 2918.0953904289736, 2924.4004978979365, 2927.3267148555847, 2816.4648716743854, 2832.943341133176, 2835.4754370441533, 2856.9285767855763, 2863.26986618412, 2685.717999610042, 2823.237725814039, 2916.8833246670106, 2917.8249305041763, 2918.2412572731137, 2638.6833579970335, 2697.0695110186953, 2892.884284628623, 2929.9267518312, 2946.1014390610853, 2796.566532187514, 2868.6557613086356, 2885.0, 2888.79778415511, 2896.956545651817, 16413.097279649613, 16551.91724041384, 16562.58593535159, 16582.83417165825, 16608.086555239457, 8519.616617252239, 8741.7814554636, 8784.472931624123, 8786.428882122642, 8797.164269394398, 5814.360420353758, 5880.529557635422, 6048.213732214784, 6059.303180134253, 6137.631742095488, 2124.468882779305, 2130.4247853079582, 2131.5736852629534, 2195.6706494025866, 2200.9889950550305, 28764.280892977633, 28958.27604309909, 28963.85518072396, 29427.85286073556, 29475.115746527852, 7453.962730186315, 7513.511621744569, 7527.172011078777, 7646.197149299243, 7714.807129821799, 19888.204471821253, 19914.302999394953, 19986.300479483147, 20014.29949951745, 20069.39791806248, 8474.152584741476, 8686.478811271218, 8698.565071746387, 8701.869471957925, 8708.433951793113, 7816.257455541714, 7835.764927052198, 7897.644605992744, 7904.841903161904, 7987.720429784929, 5701.629394089371, 5812.883742325214, 5889.852753681106, 5923.585349025613, 5929.792457263975, 1680.5378520906847, 1711.8544923681377, 1714.1600615698467, 1740.6779745747078, 1763.2682436788846, 980.3137803537552, 1004.7638804880847, 1020.739711373595, 1025.379645314574, 1045.7019749371393, 8905.154010369004, 9003.954980225057, 9031.909680903238, 9078.182963533181, 9142.177204051668, 785.8899754034439, 796.2873228460495, 800.2477670989251, 809.6599428240153, 811.2090711556185, 5210.53105220532, 5446.8910621787345, 5806.477417032487, 6213.3581721549035, 6365.49076073913, 23995.28014159578, 24056.7594324058, 25060.248192554252, 25175.874120629647, 25198.118065867973, 23531.17640882561, 24433.511329773304, 24594.50810983806, 24676.506469870503, 24752.628710569355, 12474.501019959282, 12535.937320313522, 12833.422495987703, 12882.033847461478, 12896.742065158833, 9557.522123893916, 9590.712278631652, 9624.941256461643, 9639.132478077006, 9912.454814984956, 20164.193432262546, 20265.392038238875, 20657.0, 20769.026942440443, 21124.260650877146, 21096.789032109482, 21100.57798844045, 21409.0, 21601.459963501038, 21718.0, 12382.257064576153, 12475.251484910934, 12489.687757806127, 12509.374531273217, 12512.74974500523, 14790.186539739987, 14855.0, 14996.325165367367, 15168.469103581321, 15205.087694738351, 12330.260184388966, 12559.93720031394, 12764.744705106032, 12858.678533036375, 12992.350382481027, 11964.521419143484, 12031.097667674785, 12059.69850753703, 12292.446839892047, 12427.813582796085, 10694.358338499715, 10749.89250107489, 10816.621418250323, 10819.621313253998, 10828.079613232963, 8564.314854811475, 8647.092055334351, 8659.0, 8659.956700216459, 8737.03892571804, 8499.32005439551, 8551.401401901807, 8595.226429621363, 8630.136986301319, 8724.345674074342], "value": 7341.916267046079, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.6201383059517, 563.701238343678, 574.5604612471459, 597.354856754705, 614.0543562913114, 6120.632762034275, 6198.814035578935, 6291.811245662638, 6302.621842689437, 6309.6683302609335, 6204.751809927598, 6220.667249781332, 6245.437910588046, 6257.217847769029, 6267.498600111991, 5141.82003629873, 5151.072806894757, 5214.921776173361, 5214.983078299733, 5220.582353411718, 4925.38432695913, 5075.264086707425, 5084.313617661605, 5163.122269214243, 5163.173892177252, 4962.528559786814, 4989.600831933455, 5021.372328458942, 5035.924461133068, 5059.949400506003, 4962.3548938638105, 4968.950310496885, 4981.72600506972, 5019.0463811875625, 5028.949710502885, 4567.33773602829, 4592.908141837178, 4594.839180628695, 4663.533646635343, 4672.532746725335, 6154.599951003215, 6190.112015835169, 6202.224721909762, 6250.249970003583, 6250.312465628777, 5917.8816423671715, 5970.940290597082, 5981.671008094553, 5998.220231369937, 6006.309274433453, 6555.44278736308, 6626.73493060277, 6648.135742353512, 6654.837177917197, 6682.0, 4957.82647607332, 5116.386033675945, 5121.180611102206, 5128.1282182029145, 5133.743312834344, 6790.728370865159, 6824.556403833784, 6894.620795856226, 7017.649117544102, 7038.718451261943, 5297.125974214211, 5299.5230429261555, 5329.8934021319355, 5332.173513105475, 5338.439463856239, 5380.7309634518115, 5387.75755091014, 5393.352797664305, 5395.11741873605, 5410.648307860055, 5868.794592189253, 5880.295064270398, 5912.231409916683, 5983.491403230774, 6016.157737916695, 6757.966210169016, 6780.898286525706, 6782.796516104525, 6783.491238157059, 6786.287439818847, 1862.938125268584, 1864.1611274926338, 1868.392772348992, 1875.6998880179106, 1884.5759704066475, 1249.4377530111485, 1336.1916040795372, 1341.98009512771, 1349.1702602899147, 1353.1272329347516, 6097.390260973867, 6144.139820425144, 6158.306465721962, 6225.564210505312, 6246.219222597176, 6594.472442204612, 6643.169603799525, 6703.128593282842, 6706.429953453913, 6739.629320387327, 6131.724072416752, 6151.692415379213, 6163.599366041193, 6230.190075290183, 6270.843228919313, 3499.562554680665, 3531.6644918732677, 3539.309834582232, 3550.899221241423, 3557.8576856925433, 6946.2011868635755, 6999.51003429755, 7009.264027277062, 7034.577925324497, 7069.0, 6978.232394436608, 6988.475864310197, 6996.615186164708, 7001.404880585207, 7023.122109736283, 6903.792886213421, 6921.2732663069655, 6985.301469852974, 7015.614141222281, 7072.8939065914055, 6655.434288085373, 6723.663816809238, 6731.697073631601, 6750.561213521302, 6750.763723269662, 6632.303608121078, 6640.302768209269, 6643.833904152435, 6676.566023208476, 6711.161104861892, 6842.486813488908, 6886.965565172142, 6913.446924246149, 6931.376176144171, 6976.651167441709, 5228.215767634885, 5228.320318358741, 5228.660137091077, 5261.921071184011, 5269.104252277046, 6550.868982620416, 6591.439727623206, 6744.696488657924, 6746.392824645805, 6765.357291057342, 6154.76904619087, 6321.672448785623, 6418.903716444351, 6465.415973086436, 6470.6441145737435, 6386.68066596659, 6452.257990331172, 6507.316731743288, 6512.511561632802, 6548.377904099103, 6267.811965641038, 6352.682365881595, 6400.23197216337, 6415.1981002374705, 6466.805995820133, 6528.347165283433, 6531.412172904462, 6603.0, 6628.403443689898, 6673.866522669617, 6380.266269379081, 6382.44702119156, 6385.201849768779, 6400.615963042233, 6476.8704625906275], "value": 5209.732438472453, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [962.3696478806376, 969.980600387992, 992.7716625176209, 995.462450276851, 997.8154041502322, 20974.790252097475, 21505.0, 21507.139714411423, 21530.784692153073, 21537.353879383605, 19561.608767824637, 19743.70384444231, 19829.40511784645, 19883.30408435705, 19941.401757947286, 1047.7904419116169, 1065.8720953485592, 1066.1524088349781, 1066.5733706517378, 1066.6160182334354, 1040.6617849199004, 1072.2387105155349, 1077.1221454514546, 1080.9135269178446, 1081.816091264483, 1124.3254047571475, 1140.481081108098, 1141.4178768827874, 1141.9942900285487, 1144.1933436926947, 1133.18410744264, 1140.2531341971023, 1141.2981016674769, 1141.9086473082175, 1142.063507923503, 786.6774622404844, 812.808989887376, 813.5606772342928, 813.8372325534916, 817.8159914019358, 20879.686804697943, 20937.0, 20995.475113122142, 21021.264255750975, 21033.158673653037, 23693.289201323987, 23981.40046498834, 24554.631680524806, 24700.629490557476, 24734.876325618436, 18592.256309747594, 18665.62668746631, 18965.24139034437, 18994.0, 19029.80970190294, 3771.754835935683, 3780.7542509736777, 3794.3739283018267, 3797.2974999625158, 3797.620237976208, 170925.0, 170999.14500427543, 171339.0, 172980.0, 174180.12909935496, 18072.728909066376, 18346.63306733858, 18353.449396518125, 18387.356442524713, 18423.447296581126, 34101.82949085239, 35372.469412958824, 35883.82058089745, 36139.0, 36150.8192459036, 9012.459252444874, 9144.268458523302, 9149.268058555434, 9177.862332065024, 9187.908120918706, 4591.44902611682, 4744.169770290186, 4799.568038876518, 4814.614830813526, 4832.106060378841, 6152.600080994721, 6272.090546870678, 6273.65494897785, 6277.340879207709, 6280.497560195174, 1061.135174832509, 1097.7804439112049, 1099.1701265544623, 1109.7225693576606, 1113.9498722557505, 688.769262297126, 691.4813889582813, 697.292248367907, 701.435344547644, 705.4074577355046, 12728.6817829555, 13548.661283467993, 14016.509422170175, 14050.437982480586, 14216.857831421554, 736.4403053679135, 738.9593572353465, 739.0, 749.6476655971685, 755.9395248380116, 6227.314995350508, 6233.501319894398, 6235.563510554218, 6309.873802523924, 6315.842103947346, 155484.22257888637, 158912.20543897207, 159107.0, 160378.0, 164933.0, 137799.0, 138831.30584347012, 140232.0, 141511.0, 144580.27709861382, 117437.0, 118182.0, 119503.40248298876, 122474.0, 123978.38010809888, 11613.30320180792, 11659.358735269641, 11693.0, 11812.0, 11850.703732406759, 55338.72330638321, 56613.0, 56943.0, 56977.0, 57051.42948570461, 71877.64061179661, 73026.63486682532, 73242.0, 73869.26130738624, 74721.6263918677, 17324.480265592054, 17543.912280438515, 18014.2794288227, 18040.368587099387, 18101.637967240844, 19556.11997460146, 19588.510287242934, 19753.209871604973, 19795.0, 19848.30530931468, 17940.730889036415, 17948.641027179645, 17953.461396158134, 18005.819941800415, 18219.453416397, 17325.65348692994, 17654.558636034202, 17681.911590441967, 17683.911580442014, 17714.379996700052, 17559.736603951205, 17588.29646814164, 17688.469345919642, 17857.642847143245, 17876.463706088838, 12748.298843563693, 12836.422360993964, 12914.806277906027, 12952.158109722837, 12998.350082495648, 13796.379162937492, 13818.0, 13844.723105538034, 13853.515126970507, 13907.930460347634], "value": 10063.654958261463, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1361.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 104.0, 104.0, 104.0, 106.0, 109.0, 105.0, 103.0, 107.0], "value": 105.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 111.0, 113.0, 111.0, 139.0, 115.0, 116.0, 112.0, 113.0], "value": 115.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 162.0, 162.0, 162.0, 163.0, 162.0, 160.0, 164.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 72.0, 73.0, 72.0, 76.0, 72.0, 74.0, 74.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 80.0, 77.0, 76.0, 77.0, 77.0, 79.0, 78.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0, 113.0], "value": 111.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 149.0, 150.0, 150.0, 149.0, 149.0, 150.0, 150.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 99.0, 97.0, 94.0, 94.0, 94.0, 94.0, 97.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 47.0, 44.0, 45.0, 46.0, 44.0, 44.0, 48.0, 47.0, 46.0], "value": 45.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 36.0, 36.0, 36.0, 36.0, 36.0, 35.0, 36.0, 35.0], "value": 35.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 72.0, 71.0, 72.0, 71.0, 71.0, 71.0, 72.0, 71.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 104.0, 108.0, 104.0, 107.0, 110.0, 101.0, 112.0, 107.0, 108.0], "value": 106.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 154.0, 153.0, 156.0, 148.0, 160.0, 151.0, 150.0, 153.0, 158.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 57.0, 59.0, 57.0, 61.0, 59.0, 59.0, 58.0, 59.0], "value": 59.1, "unit": "score"}]}]} 12:18:19 INFO - Return code: 0 12:18:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:18:19 INFO - # TBPL SUCCESS # 12:18:19 INFO - Running post-action listener: _package_coverage_data 12:18:19 INFO - Running post-action listener: _resource_record_post_action 12:18:19 INFO - [mozharness: 2017-09-29 19:18:19.939001Z] Finished run-tests step (success) 12:18:19 INFO - Running post-run listener: _resource_record_post_run 12:18:20 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 49152; Write bytes: 323620864; Read time: 284; Write time: 247932 12:18:20 INFO - TinderboxPrint: CPU usage
13.1% 12:18:20 INFO - TinderboxPrint: I/O read bytes / time
49,152 / 284 12:18:20 INFO - TinderboxPrint: I/O write bytes / time
323,620,864 / 247,932 12:18:20 INFO - TinderboxPrint: CPU idle
8,210.8 (86.9%) 12:18:20 INFO - TinderboxPrint: CPU user
1,186.1 (12.6%) 12:18:20 INFO - TinderboxPrint: Swap in / out
0 / 0 12:18:20 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 11100160; Read time: 0; Write time: 2196 12:18:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:18:20 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 49152; Write bytes: 310513664; Read time: 284; Write time: 245652 12:18:20 INFO - Running post-run listener: _upload_blobber_files 12:18:20 INFO - Blob upload gear active. 12:18:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:18:20 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 12:18:20 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'] 12:18:20 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 12:18:21 INFO - (blobuploader) - INFO - Open directory for files ... 12:18:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:18:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:18:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:28 INFO - (blobuploader) - INFO - Done attempting. 12:18:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 12:18:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 12:18:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:29 INFO - (blobuploader) - INFO - Done attempting. 12:18:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:18:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:18:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:30 INFO - (blobuploader) - INFO - Done attempting. 12:18:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 12:18:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 12:18:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:31 INFO - (blobuploader) - INFO - Done attempting. 12:18:31 INFO - (blobuploader) - INFO - Iteration through files over. 12:18:31 INFO - Return code: 0 12:18:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:18:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:18:31 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c87474e27a8b8815e8554c7180c852674c91deda70106a9664f30cd1edc4f394e72f86401ba24887c72098db8f03995c0c2ee1c5c71fc1450f11a18a46f9cea0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1023721da0b7aae5652b4a2dc1afd0bbd6392096fd01de424bc2108a34f9d64ab194c72badf00454767d0a420df1b14d45fa31f05f08b9e8a295078a489b681", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc8cd35892dc7126c2f44998666ebb35ecb01267cd577db83ca80b55887e5ffa47624a2951c928bb3338e552c485160cb88ee0ee7f63f2fb65161c0b069b4b9e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f32731d5989efc7953eb05e7052f65453e3263073a56b5363d524f1744be34e0dbe6caea6ee4fdfc69221b502ead42022b24eaf3354e1b31b072f0732bb4a24"} 12:18:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:18:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:18:31 INFO - Contents: 12:18:31 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c87474e27a8b8815e8554c7180c852674c91deda70106a9664f30cd1edc4f394e72f86401ba24887c72098db8f03995c0c2ee1c5c71fc1450f11a18a46f9cea0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1023721da0b7aae5652b4a2dc1afd0bbd6392096fd01de424bc2108a34f9d64ab194c72badf00454767d0a420df1b14d45fa31f05f08b9e8a295078a489b681", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc8cd35892dc7126c2f44998666ebb35ecb01267cd577db83ca80b55887e5ffa47624a2951c928bb3338e552c485160cb88ee0ee7f63f2fb65161c0b069b4b9e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f32731d5989efc7953eb05e7052f65453e3263073a56b5363d524f1744be34e0dbe6caea6ee4fdfc69221b502ead42022b24eaf3354e1b31b072f0732bb4a24"} 12:18:31 INFO - Running post-run listener: copy_logs_to_upload_dir 12:18:31 INFO - Copying logs to upload dir... 12:18:31 INFO - mkdir: /builds/slave/test/build/upload/logs 12:18:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.035249 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-29 12:18:31.825965) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 12:18:31.834611) ========= 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=ea65d483da93c827905c2090000001f5-1506711229.656374-389775371 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/c87474e27a8b8815e8554c7180c852674c91deda70106a9664f30cd1edc4f394e72f86401ba24887c72098db8f03995c0c2ee1c5c71fc1450f11a18a46f9cea0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1023721da0b7aae5652b4a2dc1afd0bbd6392096fd01de424bc2108a34f9d64ab194c72badf00454767d0a420df1b14d45fa31f05f08b9e8a295078a489b681", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc8cd35892dc7126c2f44998666ebb35ecb01267cd577db83ca80b55887e5ffa47624a2951c928bb3338e552c485160cb88ee0ee7f63f2fb65161c0b069b4b9e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f32731d5989efc7953eb05e7052f65453e3263073a56b5363d524f1744be34e0dbe6caea6ee4fdfc69221b502ead42022b24eaf3354e1b31b072f0732bb4a24"} build_url:https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/MScxg4BDTPm8_f9NwFyN5Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c87474e27a8b8815e8554c7180c852674c91deda70106a9664f30cd1edc4f394e72f86401ba24887c72098db8f03995c0c2ee1c5c71fc1450f11a18a46f9cea0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1023721da0b7aae5652b4a2dc1afd0bbd6392096fd01de424bc2108a34f9d64ab194c72badf00454767d0a420df1b14d45fa31f05f08b9e8a295078a489b681", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc8cd35892dc7126c2f44998666ebb35ecb01267cd577db83ca80b55887e5ffa47624a2951c928bb3338e552c485160cb88ee0ee7f63f2fb65161c0b069b4b9e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f32731d5989efc7953eb05e7052f65453e3263073a56b5363d524f1744be34e0dbe6caea6ee4fdfc69221b502ead42022b24eaf3354e1b31b072f0732bb4a24"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 12:18:31.863133) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 12:18:31.863493) ========= 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=ea65d483da93c827905c2090000001f5-1506711229.656374-389775371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004630 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 12:18:31.947595) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 12:18:31.947952) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 12:18:31.948411) ========= ========= Total master_lag: 0.43 =========