builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-043 starttime: 1506364657.14 results: success (0) revision: 33b7b8e81b4befcba503c0e48cd5370aeb715085 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 11:37:37.137751) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 11:37:37.138228) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 11:37:37.138499) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 11:37:37.155931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 11:37:37.156248) ========= 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=d2a8c569965ab8367867b893000001a1-1506364656.295797-181348894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 11:37:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2017-09-25 11:37:37 (217 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.168691 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 11:37:37.340204) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 11:37:37.340565) ========= 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=d2a8c569965ab8367867b893000001a1-1506364656.295797-181348894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021468 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 11:37:37.389989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 11:37:37.390386) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 33b7b8e81b4befcba503c0e48cd5370aeb715085 --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 33b7b8e81b4befcba503c0e48cd5370aeb715085 --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=d2a8c569965ab8367867b893000001a1-1506364656.295797-181348894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 11:37:37,427 truncating revision to first 12 chars 2017-09-25 11:37:37,428 Setting DEBUG logging. 2017-09-25 11:37:37,428 attempt 1/10 2017-09-25 11:37:37,428 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/33b7b8e81b4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 11:37:38,720 unpacking tar archive at: mozilla-central-33b7b8e81b4b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.672731 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 11:37:39.151664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 11:37:39.152000) ========= script_repo_revision: 33b7b8e81b4befcba503c0e48cd5370aeb715085 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 11:37:39.152365) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 11:37:39.152628) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 11:37:39.166109) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-25 11:37:39.166457) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1506364656.295797-181348894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:37:39 INFO - MultiFileLogger online at 20170925 11:37:39 in /builds/slave/test 11:37:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:37:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:37:39 INFO - {'append_to_log': False, 11:37:39 INFO - 'base_work_dir': '/builds/slave/test', 11:37:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:37:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:37:39 INFO - 'branch': 'Firefox-Non-PGO', 11:37:39 INFO - 'buildbot_json_path': 'buildprops.json', 11:37:39 INFO - 'code_coverage': False, 11:37:39 INFO - 'config_files': ('talos/linux_config.py',), 11:37:39 INFO - 'default_actions': ('clobber', 11:37:39 INFO - 'read-buildbot-config', 11:37:39 INFO - 'download-and-extract', 11:37:39 INFO - 'populate-webroot', 11:37:39 INFO - 'create-virtualenv', 11:37:39 INFO - 'install', 11:37:39 INFO - 'setup-mitmproxy', 11:37:39 INFO - 'run-tests'), 11:37:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:37:39 INFO - 'disable_ccov_upload': False, 11:37:39 INFO - 'disable_stylo': False, 11:37:39 INFO - 'download_minidump_stackwalk': True, 11:37:39 INFO - 'download_symbols': 'ondemand', 11:37:39 INFO - 'enable_stylo': False, 11:37:39 INFO - 'enable_webrender': False, 11:37:39 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:37:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:37:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:37:39 INFO - 'gecko_profile': False, 11:37:39 INFO - 'gecko_profile_interval': 0, 11:37:39 INFO - 'installer_path': 'installer.exe', 11:37:39 INFO - 'log_level': 'info', 11:37:39 INFO - 'log_name': 'talos', 11:37:39 INFO - 'log_to_console': True, 11:37:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:37:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:37:39 INFO - 'opt_config_files': (), 11:37:39 INFO - 'pip_index': False, 11:37:39 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:37:39 INFO - 'system_bits': '32', 11:37:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:37:39 INFO - 'title': 'talos-linux64-ix-043', 11:37:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:37:39 INFO - 'use_talos_json': True, 11:37:39 INFO - 'verify': 'False', 11:37:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:37:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:37:39 INFO - 'work_dir': 'build'} 11:37:39 INFO - [mozharness: 2017-09-25 18:37:39.346515Z] Running clobber step. 11:37:39 INFO - Running pre-action listener: _resource_record_pre_action 11:37:39 INFO - Running main action method: clobber 11:37:39 INFO - rmtree: /builds/slave/test/build 11:37:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:37:40 INFO - Running post-action listener: _resource_record_post_action 11:37:40 INFO - [mozharness: 2017-09-25 18:37:40.868956Z] Finished clobber step (success) 11:37:40 INFO - [mozharness: 2017-09-25 18:37:40.869066Z] Running read-buildbot-config step. 11:37:40 INFO - Running pre-action listener: _resource_record_pre_action 11:37:40 INFO - Running main action method: read_buildbot_config 11:37:40 INFO - Using buildbot properties: 11:37:40 INFO - { 11:37:40 INFO - "project": "", 11:37:40 INFO - "product": "firefox", 11:37:40 INFO - "who": "ffxbld@noreply.mozilla.org", 11:37:40 INFO - "installer_path": "public/build/target.tar.bz2", 11:37:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:37:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:37:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 11:37:40 INFO - "stage_platform": "linux64", 11:37:40 INFO - "basedir": "/builds/slave/test", 11:37:40 INFO - "buildnumber": 40, 11:37:40 INFO - "platform": "ubuntu64_hw", 11:37:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:37:40 INFO - "slavebuilddir": "test", 11:37:40 INFO - "taskId": "eFSrUP7TQmOilVIA5t_srQ", 11:37:40 INFO - "branch": "mozilla-central", 11:37:40 INFO - "script_repo_revision": "production", 11:37:40 INFO - "revision": "33b7b8e81b4befcba503c0e48cd5370aeb715085", 11:37:40 INFO - "slavename": "talos-linux64-ix-043", 11:37:40 INFO - "repo_path": "mozilla-central" 11:37:40 INFO - } 11:37:40 INFO - Finding installer, test and symbols from parent task. 11:37:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eFSrUP7TQmOilVIA5t_srQ'}, attempt #1 11:37:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eFSrUP7TQmOilVIA5t_srQ'}, attempt #1 11:37:41 INFO - Task dependencies: DFwEF9UYSvOCRfO3WdTOSw 11:37:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw'}, attempt #1 11:37:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.tar.bz2 11:37:42 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.test_packages.json 11:37:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.crashreporter-symbols.zip 11:37:42 INFO - Running post-action listener: _resource_record_post_action 11:37:42 INFO - [mozharness: 2017-09-25 18:37:42.266712Z] Finished read-buildbot-config step (success) 11:37:42 INFO - [mozharness: 2017-09-25 18:37:42.266931Z] Running download-and-extract step. 11:37:42 INFO - Running pre-action listener: _resource_record_pre_action 11:37:42 INFO - Running main action method: download_and_extract 11:37:42 INFO - mkdir: /builds/slave/test/build/tests 11:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:42 INFO - trying https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.test_packages.json 11:37:42 INFO - Downloading https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:37:42 INFO - Downloaded 989 bytes. 11:37:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:37:42 INFO - Using the following test package requirements: 11:37:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:37:42 INFO - u'common': [u'target.common.tests.zip'], 11:37:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:37:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:37:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:37:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:37:42 INFO - u'mozbase': [u'target.common.tests.zip'], 11:37:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:37:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:37:42 INFO - u'web-platform': [u'target.common.tests.zip', 11:37:42 INFO - u'target.web-platform.tests.tar.gz'], 11:37:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:37:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:37:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.common.tests.zip 11:37:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:37:42 INFO - Fetch https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.common.tests.zip into memory 11:37:43 INFO - Content-Length response header: 54943884 11:37:43 INFO - Bytes received: 54943884 11:37:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.talos.tests.zip 11:37:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:37:54 INFO - Fetch https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.talos.tests.zip into memory 11:37:55 INFO - Content-Length response header: 14513823 11:37:55 INFO - Bytes received: 14513823 11:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:56 INFO - trying https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.tar.bz2 11:37:56 INFO - Downloading https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:37:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:37:57 INFO - Downloaded 61448177 bytes. 11:37:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.tar.bz2 11:37:57 INFO - mkdir: /builds/slave/test/properties 11:37:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:37:57 INFO - Writing to file /builds/slave/test/properties/build_url 11:37:57 INFO - Contents: 11:37:57 INFO - build_url:https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.tar.bz2 11:37:57 INFO - Running post-action listener: _resource_record_post_action 11:37:57 INFO - Running post-action listener: find_tests_for_verification 11:37:57 INFO - Running post-action listener: set_extra_try_arguments 11:37:57 INFO - [mozharness: 2017-09-25 18:37:57.209093Z] Finished download-and-extract step (success) 11:37:57 INFO - [mozharness: 2017-09-25 18:37:57.209253Z] Running populate-webroot step. 11:37:57 INFO - Running pre-action listener: _resource_record_pre_action 11:37:57 INFO - Running main action method: populate_webroot 11:37:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:37:57 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:37:57 INFO - 'tests': ['tresize', 11:37:57 INFO - 'tcanvasmark']}, 11:37:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:37:57 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:37:57 INFO - 'tests': ['dromaeo_css', 11:37:57 INFO - 'kraken']}, 11:37:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:37:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:57 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:37:57 INFO - 'talos_options': ['--disable-stylo'], 11:37:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:37:57 INFO - 'tests': ['damp', 'tps']}, 11:37:57 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:37:57 INFO - 'talos_options': ['--disable-stylo'], 11:37:57 INFO - 'tests': ['damp', 'tps']}, 11:37:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:37:57 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:37:57 INFO - 'tests': ['dromaeo_dom']}, 11:37:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:37:57 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:37:57 INFO - 'tests': ['basic_compositor_video', 11:37:57 INFO - 'glvideo']}, 11:37:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:37:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:37:57 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:37:57 INFO - 'talos_options': ['--disable-stylo'], 11:37:57 INFO - 'tests': ['ts_paint_webext', 11:37:57 INFO - 'tp5o_webext']}, 11:37:57 INFO - 'other-e10s': {'tests': ['a11yr', 11:37:57 INFO - 'ts_paint', 11:37:57 INFO - 'tpaint', 11:37:57 INFO - 'sessionrestore', 11:37:57 INFO - 'sessionrestore_many_windows', 11:37:57 INFO - 'sessionrestore_no_auto_restore', 11:37:57 INFO - 'tabpaint']}, 11:37:57 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:37:57 INFO - 'tests': ['a11yr', 11:37:57 INFO - 'ts_paint', 11:37:57 INFO - 'tpaint', 11:37:57 INFO - 'sessionrestore', 11:37:57 INFO - 'sessionrestore_many_windows', 11:37:57 INFO - 'sessionrestore_no_auto_restore', 11:37:57 INFO - 'tabpaint']}, 11:37:57 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:37:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:37:57 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:37:57 INFO - 'tests': ['perf_reftest_singletons']}, 11:37:57 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:37:57 INFO - 'tests': ['perf_reftest']}, 11:37:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:37:57 INFO - 'tsvgr_opacity', 11:37:57 INFO - 'tart', 11:37:57 INFO - 'tscrollx', 11:37:57 INFO - 'tsvg_static']}, 11:37:57 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:37:57 INFO - 'tests': ['tsvgx', 11:37:57 INFO - 'tsvgr_opacity', 11:37:57 INFO - 'tart', 11:37:57 INFO - 'tscrollx', 11:37:57 INFO - 'tsvg_static']}, 11:37:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:37:57 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:37:57 INFO - 'talos_options': ['--disable-stylo'], 11:37:57 INFO - 'tests': ['tp5o']}, 11:37:57 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:37:57 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:37:57 INFO - 'talos_options': ['--mitmproxy', 11:37:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:37:57 INFO - '--firstNonBlankPaint'], 11:37:57 INFO - 'tests': ['tp6_google', 11:37:57 INFO - 'tp6_youtube', 11:37:57 INFO - 'tp6_amazon', 11:37:57 INFO - 'tp6_facebook']}, 11:37:57 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:37:57 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:37:57 INFO - 'talos_options': ['--disable-stylo', 11:37:57 INFO - '--mitmproxy', 11:37:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:37:57 INFO - '--firstNonBlankPaint'], 11:37:57 INFO - 'tests': ['tp6_google', 11:37:57 INFO - 'tp6_youtube', 11:37:57 INFO - 'tp6_amazon', 11:37:57 INFO - 'tp6_facebook']}, 11:37:57 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:37:57 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:37:57 INFO - 'talos_options': ['--stylo-threads=1', 11:37:57 INFO - '--mitmproxy', 11:37:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:37:57 INFO - '--firstNonBlankPaint'], 11:37:57 INFO - 'tests': ['tp6_google', 11:37:57 INFO - 'tp6_youtube', 11:37:57 INFO - 'tp6_amazon', 11:37:57 INFO - 'tp6_facebook']}, 11:37:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:37:57 INFO - 'talos_options': ['--xperf_path', 11:37:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:57 INFO - 'tests': ['tp5n']}, 11:37:57 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:37:57 INFO - 'talos_options': ['--disable-stylo', 11:37:57 INFO - '--xperf_path', 11:37:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:57 INFO - 'tests': ['tp5n']}}} 11:37:57 INFO - Running post-action listener: _resource_record_post_action 11:37:57 INFO - [mozharness: 2017-09-25 18:37:57.229870Z] Finished populate-webroot step (success) 11:37:57 INFO - [mozharness: 2017-09-25 18:37:57.229964Z] Running create-virtualenv step. 11:37:57 INFO - Running pre-action listener: _resource_record_pre_action 11:37:57 INFO - Running main action method: create_virtualenv 11:37:57 INFO - Creating virtualenv /builds/slave/test/build/venv 11:37:57 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:37:57 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:37:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:37:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:37:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:37:58 INFO - Installing distribute.............................................................................................................................................................................................done. 11:37:58 INFO - Installing pip...............done. 11:37:58 INFO - Return code: 0 11:37:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:37:58 INFO - Reading from file tmpfile_stdout 11:37:58 INFO - Output received: 11:37:58 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:37:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:37: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:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37: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:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:58 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 0x11951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ffd60>, '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 0x1500a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1500ef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', '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:37:58 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:37:58 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:37:58 INFO - Using env: {'DISPLAY': ':0', 11:37:58 INFO - 'HOME': '/home/cltbld', 11:37:58 INFO - 'LANG': 'en_US.UTF-8', 11:37:58 INFO - 'LANGUAGE': 'en_US:en', 11:37:58 INFO - 'LOGNAME': 'cltbld', 11:37:58 INFO - 'MAIL': '/var/mail/cltbld', 11:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:58 INFO - 'MOZ_NO_REMOTE': '1', 11:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:58 INFO - 'NO_EM_RESTART': '1', 11:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:58 INFO - 'PWD': '/builds/slave/test', 11:37:58 INFO - 'SHELL': '/bin/bash', 11:37:58 INFO - 'SHLVL': '1', 11:37:58 INFO - 'TERM': 'linux', 11:37:58 INFO - 'TMOUT': '86400', 11:37:58 INFO - 'USER': 'cltbld', 11:37:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', 11:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:58 INFO - '_': '/tools/buildbot/bin/python'} 11:37:59 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:37:59 INFO - Downloading/unpacking pip>=1.5 11:37:59 INFO - Running setup.py egg_info for package pip 11:37:59 INFO - warning: no files found matching 'pip/cacert.pem' 11:37:59 INFO - warning: no files found matching '*.html' under directory 'docs' 11:37:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:37:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:37:59 INFO - Installing collected packages: pip 11:37:59 INFO - Found existing installation: pip 1.1 11:37:59 INFO - Uninstalling pip: 11:37:59 INFO - Successfully uninstalled pip 11:37:59 INFO - Running setup.py install for pip 11:37:59 INFO - warning: no files found matching 'pip/cacert.pem' 11:37:59 INFO - warning: no files found matching '*.html' under directory 'docs' 11:37:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:37:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:37:59 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:37:59 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:37:59 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:37:59 INFO - Successfully installed pip 11:37:59 INFO - Cleaning up... 11:37:59 INFO - Return code: 0 11:37:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:59 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 0x11951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ffd60>, '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 0x1500a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1500ef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', '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:37:59 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:37:59 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:37:59 INFO - Using env: {'DISPLAY': ':0', 11:37:59 INFO - 'HOME': '/home/cltbld', 11:37:59 INFO - 'LANG': 'en_US.UTF-8', 11:37:59 INFO - 'LANGUAGE': 'en_US:en', 11:37:59 INFO - 'LOGNAME': 'cltbld', 11:37:59 INFO - 'MAIL': '/var/mail/cltbld', 11:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:59 INFO - 'MOZ_NO_REMOTE': '1', 11:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:59 INFO - 'NO_EM_RESTART': '1', 11:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:59 INFO - 'PWD': '/builds/slave/test', 11:37:59 INFO - 'SHELL': '/bin/bash', 11:37:59 INFO - 'SHLVL': '1', 11:37:59 INFO - 'TERM': 'linux', 11:37:59 INFO - 'TMOUT': '86400', 11:37:59 INFO - 'USER': 'cltbld', 11:37:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', 11:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:59 INFO - '_': '/tools/buildbot/bin/python'} 11:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:59 INFO - Downloading/unpacking psutil>=3.1.1 11:37:59 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:37:59 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:37:59 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:37:59 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:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:38:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:38:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:38:01 INFO - Installing collected packages: psutil 11:38:01 INFO - Running setup.py install for psutil 11:38:01 INFO - building 'psutil._psutil_linux' extension 11:38:01 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:38:01 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:38:01 INFO - building 'psutil._psutil_posix' extension 11:38:01 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:38:01 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:38:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:38:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:38:01 INFO - Successfully installed psutil 11:38:01 INFO - Cleaning up... 11:38:01 INFO - Return code: 0 11:38:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:38:01 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:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:01 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:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:01 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 0x11951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ffd60>, '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 0x1500a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1500ef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', '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:38:01 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:38:01 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:38:01 INFO - Using env: {'DISPLAY': ':0', 11:38:01 INFO - 'HOME': '/home/cltbld', 11:38:01 INFO - 'LANG': 'en_US.UTF-8', 11:38:01 INFO - 'LANGUAGE': 'en_US:en', 11:38:01 INFO - 'LOGNAME': 'cltbld', 11:38:01 INFO - 'MAIL': '/var/mail/cltbld', 11:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:01 INFO - 'MOZ_NO_REMOTE': '1', 11:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:01 INFO - 'NO_EM_RESTART': '1', 11:38:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:01 INFO - 'PWD': '/builds/slave/test', 11:38:01 INFO - 'SHELL': '/bin/bash', 11:38:01 INFO - 'SHLVL': '1', 11:38:01 INFO - 'TERM': 'linux', 11:38:01 INFO - 'TMOUT': '86400', 11:38:01 INFO - 'USER': 'cltbld', 11:38:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', 11:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:01 INFO - '_': '/tools/buildbot/bin/python'} 11:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:38:01 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:38:01 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:38:01 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:38:01 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:38:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:38:03 INFO - Installing collected packages: mozsystemmonitor 11:38:03 INFO - Running setup.py install for mozsystemmonitor 11:38:03 INFO - Successfully installed mozsystemmonitor 11:38:03 INFO - Cleaning up... 11:38:03 INFO - Return code: 0 11:38:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:38:03 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:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:03 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:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:03 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 0x11951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ffd60>, '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 0x1500a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1500ef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', '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:38:03 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:38:03 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:38:03 INFO - Using env: {'DISPLAY': ':0', 11:38:03 INFO - 'HOME': '/home/cltbld', 11:38:03 INFO - 'LANG': 'en_US.UTF-8', 11:38:03 INFO - 'LANGUAGE': 'en_US:en', 11:38:03 INFO - 'LOGNAME': 'cltbld', 11:38:03 INFO - 'MAIL': '/var/mail/cltbld', 11:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:03 INFO - 'MOZ_NO_REMOTE': '1', 11:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:03 INFO - 'NO_EM_RESTART': '1', 11:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:03 INFO - 'PWD': '/builds/slave/test', 11:38:03 INFO - 'SHELL': '/bin/bash', 11:38:03 INFO - 'SHLVL': '1', 11:38:03 INFO - 'TERM': 'linux', 11:38:03 INFO - 'TMOUT': '86400', 11:38:03 INFO - 'USER': 'cltbld', 11:38:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', 11:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:03 INFO - '_': '/tools/buildbot/bin/python'} 11:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:04 INFO - Downloading/unpacking jsonschema==2.5.1 11:38:04 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:38:04 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:38:04 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:38:04 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:38:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:38:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:38:06 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:38:06 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:38:06 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:38:06 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:38:06 INFO - Downloading functools32-3.2.3-2.tar.gz 11:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:38:06 INFO - warning: no files found matching '*.txt' 11:38:06 INFO - no previously-included directories found matching 'build' 11:38:06 INFO - no previously-included directories found matching 'dist' 11:38:06 INFO - no previously-included directories found matching '.git*' 11:38:06 INFO - Installing collected packages: jsonschema, functools32 11:38:06 INFO - Running setup.py install for functools32 11:38:06 INFO - warning: no files found matching '*.txt' 11:38:06 INFO - no previously-included directories found matching 'build' 11:38:06 INFO - no previously-included directories found matching 'dist' 11:38:06 INFO - no previously-included directories found matching '.git*' 11:38:07 INFO - Successfully installed jsonschema functools32 11:38:07 INFO - Cleaning up... 11:38:07 INFO - Return code: 0 11:38:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ffd60>, '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 0x1500a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1500ef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', '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:38:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:38:07 INFO - Using env: {'DISPLAY': ':0', 11:38:07 INFO - 'HOME': '/home/cltbld', 11:38:07 INFO - 'LANG': 'en_US.UTF-8', 11:38:07 INFO - 'LANGUAGE': 'en_US:en', 11:38:07 INFO - 'LOGNAME': 'cltbld', 11:38:07 INFO - 'MAIL': '/var/mail/cltbld', 11:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:07 INFO - 'MOZ_NO_REMOTE': '1', 11:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:07 INFO - 'NO_EM_RESTART': '1', 11:38:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:07 INFO - 'PWD': '/builds/slave/test', 11:38:07 INFO - 'SHELL': '/bin/bash', 11:38:07 INFO - 'SHLVL': '1', 11:38:07 INFO - 'TERM': 'linux', 11:38:07 INFO - 'TMOUT': '86400', 11:38:07 INFO - 'USER': 'cltbld', 11:38:07 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', 11:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:07 INFO - '_': '/tools/buildbot/bin/python'} 11:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:38:07 INFO - Cleaning up... 11:38:07 INFO - Return code: 0 11:38:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ffd60>, '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 0x1500a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1500ef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', '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:38:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:38:07 INFO - Using env: {'DISPLAY': ':0', 11:38:07 INFO - 'HOME': '/home/cltbld', 11:38:07 INFO - 'LANG': 'en_US.UTF-8', 11:38:07 INFO - 'LANGUAGE': 'en_US:en', 11:38:07 INFO - 'LOGNAME': 'cltbld', 11:38:07 INFO - 'MAIL': '/var/mail/cltbld', 11:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:07 INFO - 'MOZ_NO_REMOTE': '1', 11:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:07 INFO - 'NO_EM_RESTART': '1', 11:38:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:07 INFO - 'PWD': '/builds/slave/test', 11:38:07 INFO - 'SHELL': '/bin/bash', 11:38:07 INFO - 'SHLVL': '1', 11:38:07 INFO - 'TERM': 'linux', 11:38:07 INFO - 'TMOUT': '86400', 11:38:07 INFO - 'USER': 'cltbld', 11:38:07 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', 11:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:07 INFO - '_': '/tools/buildbot/bin/python'} 11:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:07 INFO - Downloading/unpacking blobuploader==1.2.4 11:38:07 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:38:07 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:38:07 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:38:07 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:38:08 INFO - Downloading blobuploader-1.2.4.tar.gz 11:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:38:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:38:08 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:38:08 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:38:08 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:38:08 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:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:38:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:38:08 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:38:08 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:38:08 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:38:08 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:38:09 INFO - Downloading docopt-0.6.1.tar.gz 11:38:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:38:09 INFO - Installing collected packages: blobuploader, requests, docopt 11:38:09 INFO - Running setup.py install for blobuploader 11:38:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:38:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:38:09 INFO - Running setup.py install for requests 11:38:09 INFO - Running setup.py install for docopt 11:38:09 INFO - Successfully installed blobuploader requests docopt 11:38:09 INFO - Cleaning up... 11:38:09 INFO - Return code: 0 11:38:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:38:09 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:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:09 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:38:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:09 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 0x11951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ffd60>, '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 0x1500a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1500ef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', '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:38:09 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:38:09 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:38:09 INFO - Using env: {'DISPLAY': ':0', 11:38:09 INFO - 'HOME': '/home/cltbld', 11:38:09 INFO - 'LANG': 'en_US.UTF-8', 11:38:09 INFO - 'LANGUAGE': 'en_US:en', 11:38:09 INFO - 'LOGNAME': 'cltbld', 11:38:09 INFO - 'MAIL': '/var/mail/cltbld', 11:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:09 INFO - 'MOZ_NO_REMOTE': '1', 11:38:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:09 INFO - 'NO_EM_RESTART': '1', 11:38:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:09 INFO - 'PWD': '/builds/slave/test', 11:38:09 INFO - 'SHELL': '/bin/bash', 11:38:09 INFO - 'SHLVL': '1', 11:38:09 INFO - 'TERM': 'linux', 11:38:09 INFO - 'TMOUT': '86400', 11:38:09 INFO - 'USER': 'cltbld', 11:38:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', 11:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:09 INFO - '_': '/tools/buildbot/bin/python'} 11:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:38:09 INFO - Running setup.py (path:/tmp/pip-DQ8aFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:38:10 INFO - Running setup.py (path:/tmp/pip-mXnS1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:38:10 INFO - Running setup.py (path:/tmp/pip-q0PEm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:38:10 INFO - Running setup.py (path:/tmp/pip-AJWLJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:38:10 INFO - Running setup.py (path:/tmp/pip-8oSdV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:38:10 INFO - Running setup.py (path:/tmp/pip-ZEemWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:38:10 INFO - Running setup.py (path:/tmp/pip-4fK2tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:38:10 INFO - Running setup.py (path:/tmp/pip-miy9uE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:38:10 INFO - Running setup.py (path:/tmp/pip-qOSTtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:38:10 INFO - Running setup.py (path:/tmp/pip-NWsc4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:38:10 INFO - Running setup.py (path:/tmp/pip-3IdmG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:38:10 INFO - Running setup.py (path:/tmp/pip-DbO5kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:38:10 INFO - Running setup.py (path:/tmp/pip-0rBxMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:38:10 INFO - Running setup.py (path:/tmp/pip-46gMkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:38:10 INFO - Running setup.py (path:/tmp/pip-JNBOka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:38:11 INFO - Running setup.py (path:/tmp/pip-WU7G4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:38:11 INFO - Running setup.py (path:/tmp/pip-OEtgBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:38:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:38:11 INFO - Running setup.py install for manifestparser 11:38:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:38:11 INFO - Running setup.py install for mozcrash 11:38:11 INFO - Running setup.py install for mozdebug 11:38:11 INFO - Running setup.py install for mozdevice 11:38:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:38:11 INFO - Running setup.py install for mozfile 11:38:11 INFO - Running setup.py install for mozhttpd 11:38:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:38:11 INFO - Running setup.py install for mozinfo 11:38:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:38:11 INFO - Running setup.py install for mozInstall 11:38:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:38:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:38:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:38:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:38:11 INFO - Running setup.py install for mozleak 11:38:12 INFO - Running setup.py install for mozlog 11:38:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:38:12 INFO - Running setup.py install for moznetwork 11:38:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:38:12 INFO - Running setup.py install for mozprocess 11:38:12 INFO - Running setup.py install for mozprofile 11:38:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:38:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:38:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:38:12 INFO - Running setup.py install for mozrunner 11:38:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:38:12 INFO - Running setup.py install for mozscreenshot 11:38:12 INFO - Running setup.py install for moztest 11:38:12 INFO - Running setup.py install for mozversion 11:38:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:38:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:38:12 INFO - Cleaning up... 11:38:12 INFO - Return code: 0 11:38:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:12 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 0x11951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ffd60>, '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 0x1500a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1500ef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', '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:38:12 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:38:12 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:38:12 INFO - Using env: {'DISPLAY': ':0', 11:38:12 INFO - 'HOME': '/home/cltbld', 11:38:12 INFO - 'LANG': 'en_US.UTF-8', 11:38:12 INFO - 'LANGUAGE': 'en_US:en', 11:38:12 INFO - 'LOGNAME': 'cltbld', 11:38:12 INFO - 'MAIL': '/var/mail/cltbld', 11:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:12 INFO - 'MOZ_NO_REMOTE': '1', 11:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:12 INFO - 'NO_EM_RESTART': '1', 11:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:12 INFO - 'PWD': '/builds/slave/test', 11:38:12 INFO - 'SHELL': '/bin/bash', 11:38:12 INFO - 'SHLVL': '1', 11:38:12 INFO - 'TERM': 'linux', 11:38:12 INFO - 'TMOUT': '86400', 11:38:12 INFO - 'USER': 'cltbld', 11:38:12 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', 11:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:12 INFO - '_': '/tools/buildbot/bin/python'} 11:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:38:13 INFO - Running setup.py (path:/tmp/pip-lFAHaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:38:13 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:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:38:13 INFO - Running setup.py (path:/tmp/pip-sgvp4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:38:13 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:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:38:13 INFO - Running setup.py (path:/tmp/pip-FjuobL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:38:13 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:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:38:13 INFO - Running setup.py (path:/tmp/pip-kntG1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:38:13 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:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:38:13 INFO - Running setup.py (path:/tmp/pip-YuTPfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:38:13 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:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:38:13 INFO - Running setup.py (path:/tmp/pip-gytpCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:38:13 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:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:38:13 INFO - Running setup.py (path:/tmp/pip-MpnkpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:38:13 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:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:38:13 INFO - Running setup.py (path:/tmp/pip-S4vRGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:38:13 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:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:38:13 INFO - Running setup.py (path:/tmp/pip-u6EiLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:38:13 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:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:38:13 INFO - Running setup.py (path:/tmp/pip-wozQ7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:38:13 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:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:38:13 INFO - Running setup.py (path:/tmp/pip-1YANqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:38:13 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:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:38:13 INFO - Running setup.py (path:/tmp/pip-sEozAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:38:14 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:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:38:14 INFO - Running setup.py (path:/tmp/pip-xnmG1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:38:14 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:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:38:14 INFO - Running setup.py (path:/tmp/pip-fsvvN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:38:14 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:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:38:14 INFO - Running setup.py (path:/tmp/pip-q7AqsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:38:14 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:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:38:14 INFO - Running setup.py (path:/tmp/pip-FbtbYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:38:14 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:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:38:14 INFO - Running setup.py (path:/tmp/pip-687KBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:38:14 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:38:14 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:38:14 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:38:14 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:38:14 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:38:14 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:38:14 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:38:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:38:14 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:38:14 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:38:14 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:38:14 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:38:15 INFO - Downloading blessings-1.6.tar.gz 11:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:38:15 INFO - Installing collected packages: blessings 11:38:15 INFO - Running setup.py install for blessings 11:38:15 INFO - Successfully installed blessings 11:38:15 INFO - Cleaning up... 11:38:15 INFO - Return code: 0 11:38:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:38:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:38:15 INFO - Reading from file tmpfile_stdout 11:38:15 INFO - Current package versions: 11:38:15 INFO - argparse == 1.2.1 11:38:15 INFO - blessings == 1.6 11:38:15 INFO - blobuploader == 1.2.4 11:38:15 INFO - docopt == 0.6.1 11:38:15 INFO - functools32 == 3.2.3-2 11:38:15 INFO - jsonschema == 2.5.1 11:38:15 INFO - manifestparser == 1.1 11:38:15 INFO - mozInstall == 1.13 11:38:15 INFO - mozcrash == 1.0 11:38:15 INFO - mozdebug == 0.1 11:38:15 INFO - mozdevice == 0.51 11:38:15 INFO - mozfile == 1.2 11:38:15 INFO - mozhttpd == 0.7 11:38:15 INFO - mozinfo == 0.10 11:38:15 INFO - mozleak == 0.1 11:38:15 INFO - mozlog == 3.5 11:38:15 INFO - moznetwork == 0.27 11:38:15 INFO - mozprocess == 0.25 11:38:15 INFO - mozprofile == 0.28 11:38:15 INFO - mozrunner == 6.13 11:38:15 INFO - mozscreenshot == 0.1 11:38:15 INFO - mozsystemmonitor == 0.3 11:38:15 INFO - moztest == 0.8 11:38:15 INFO - mozversion == 1.4 11:38:15 INFO - psutil == 3.1.1 11:38:15 INFO - requests == 1.2.3 11:38:15 INFO - wsgiref == 0.1.2 11:38:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:38: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:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38: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:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:15 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 0x11951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ffd60>, '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 0x1500a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1500ef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', '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:38:15 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:38:15 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:38:15 INFO - Using env: {'DISPLAY': ':0', 11:38:15 INFO - 'HOME': '/home/cltbld', 11:38:15 INFO - 'LANG': 'en_US.UTF-8', 11:38:15 INFO - 'LANGUAGE': 'en_US:en', 11:38:15 INFO - 'LOGNAME': 'cltbld', 11:38:15 INFO - 'MAIL': '/var/mail/cltbld', 11:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:15 INFO - 'MOZ_NO_REMOTE': '1', 11:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:15 INFO - 'NO_EM_RESTART': '1', 11:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:15 INFO - 'PWD': '/builds/slave/test', 11:38:15 INFO - 'SHELL': '/bin/bash', 11:38:15 INFO - 'SHLVL': '1', 11:38:15 INFO - 'TERM': 'linux', 11:38:15 INFO - 'TMOUT': '86400', 11:38:15 INFO - 'USER': 'cltbld', 11:38:15 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', 11:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:15 INFO - '_': '/tools/buildbot/bin/python'} 11:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:16 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:38:16 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:38:16 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:38:16 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:38:16 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:38:16 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:38:16 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:38:16 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:38:16 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:38:16 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:38: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:38: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:38: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:38: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:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:38:17 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:38:17 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:38:17 INFO - Installing collected packages: simplejson 11:38:17 INFO - Running setup.py install for simplejson 11:38:17 INFO - building 'simplejson._speedups' extension 11:38:17 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:38:18 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:38:18 INFO - Successfully installed simplejson 11:38:18 INFO - Cleaning up... 11:38:18 INFO - Return code: 0 11:38:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:38: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:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38: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:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15029c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ffd60>, '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 0x1500a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1500ef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', '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:38: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', 'jsonschema'] in /builds/slave/test/build 11:38: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 jsonschema 11:38:18 INFO - Using env: {'DISPLAY': ':0', 11:38:18 INFO - 'HOME': '/home/cltbld', 11:38:18 INFO - 'LANG': 'en_US.UTF-8', 11:38:18 INFO - 'LANGUAGE': 'en_US:en', 11:38:18 INFO - 'LOGNAME': 'cltbld', 11:38:18 INFO - 'MAIL': '/var/mail/cltbld', 11:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:18 INFO - 'MOZ_NO_REMOTE': '1', 11:38:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:18 INFO - 'NO_EM_RESTART': '1', 11:38:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:18 INFO - 'PWD': '/builds/slave/test', 11:38:18 INFO - 'SHELL': '/bin/bash', 11:38:18 INFO - 'SHLVL': '1', 11:38:18 INFO - 'TERM': 'linux', 11:38:18 INFO - 'TMOUT': '86400', 11:38:18 INFO - 'USER': 'cltbld', 11:38:18 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', 11:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:18 INFO - '_': '/tools/buildbot/bin/python'} 11:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:38:18 INFO - Cleaning up... 11:38:18 INFO - Return code: 0 11:38:18 INFO - Running post-action listener: _resource_record_post_action 11:38:18 INFO - Running post-action listener: _start_resource_monitoring 11:38:18 INFO - Starting resource monitoring. 11:38:18 INFO - [mozharness: 2017-09-25 18:38:18.652683Z] Finished create-virtualenv step (success) 11:38:18 INFO - [mozharness: 2017-09-25 18:38:18.653283Z] Running install step. 11:38:18 INFO - Running pre-action listener: _resource_record_pre_action 11:38:18 INFO - Running main action method: install 11:38:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:38:18 INFO - Reading from file tmpfile_stdout 11:38:18 INFO - Detecting whether we're running mozinstall >=1.0... 11:38:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:38:19 INFO - Reading from file tmpfile_stdout 11:38:19 INFO - Output received: 11:38:19 INFO - Usage: mozinstall [options] installer 11:38:19 INFO - Options: 11:38:19 INFO - -h, --help show this help message and exit 11:38:19 INFO - -d DEST, --destination=DEST 11:38:19 INFO - Directory to install application into. [default: 11:38:19 INFO - "/builds/slave/test"] 11:38:19 INFO - --app=APP Application being installed. [default: firefox] 11:38:19 INFO - mkdir: /builds/slave/test/build/application 11:38:19 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:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:38:36 INFO - Reading from file tmpfile_stdout 11:38:36 INFO - Output received: 11:38:36 INFO - /builds/slave/test/build/application/firefox/firefox 11:38:36 INFO - Running post-action listener: _resource_record_post_action 11:38:36 INFO - [mozharness: 2017-09-25 18:38:36.775250Z] Finished install step (success) 11:38:36 INFO - [mozharness: 2017-09-25 18:38:36.775592Z] Running setup-mitmproxy step. 11:38:36 INFO - Running pre-action listener: _resource_record_pre_action 11:38:36 INFO - Running main action method: setup_mitmproxy 11:38:36 INFO - Skipping: mitmproxy is not required 11:38:36 INFO - Running post-action listener: _resource_record_post_action 11:38:36 INFO - [mozharness: 2017-09-25 18:38:36.777355Z] Finished setup-mitmproxy step (success) 11:38:36 INFO - [mozharness: 2017-09-25 18:38:36.777668Z] Running run-tests step. 11:38:36 INFO - Running pre-action listener: _resource_record_pre_action 11:38:36 INFO - Running pre-action listener: _set_gcov_prefix 11:38:36 INFO - Running main action method: run_tests 11:38:36 WARNING - Try message not found. 11:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:38:36 INFO - Python 2.7.3 11:38:36 INFO - Return code: 0 11:38:36 INFO - grabbing minidump binary from tooltool 11:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:36 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 0x14ffd60>, '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 0x1500a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1500ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:38:36 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:38:36 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:38:36 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:38:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:38:36 INFO - Return code: 0 11:38:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:38:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:38:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:38:36 INFO - ENV: RUST_BACKTRACE is now full 11:38:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:38:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-043 --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:38:36 INFO - Using env: {'DISPLAY': ':0', 11:38:36 INFO - 'HOME': '/home/cltbld', 11:38:36 INFO - 'LANG': 'en_US.UTF-8', 11:38:36 INFO - 'LANGUAGE': 'en_US:en', 11:38:36 INFO - 'LOGNAME': 'cltbld', 11:38:36 INFO - 'MAIL': '/var/mail/cltbld', 11:38:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:38:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:36 INFO - 'MOZ_NO_REMOTE': '1', 11:38:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:36 INFO - 'NO_EM_RESTART': '1', 11:38:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:36 INFO - 'PWD': '/builds/slave/test', 11:38:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:38:36 INFO - 'RUST_BACKTRACE': 'full', 11:38:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:38:36 INFO - 'SHELL': '/bin/bash', 11:38:36 INFO - 'SHLVL': '1', 11:38:36 INFO - 'TERM': 'linux', 11:38:36 INFO - 'TMOUT': '86400', 11:38:36 INFO - 'USER': 'cltbld', 11:38:36 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', 11:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:36 INFO - '_': '/tools/buildbot/bin/python'} 11:38:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:38:37 INFO - mozversion application_buildid: 20170925174106 11:38:37 INFO - mozversion application_changeset: 33b7b8e81b4befcba503c0e48cd5370aeb715085 11:38:37 INFO - mozversion application_display_name: Nightly 11:38:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:38:37 INFO - mozversion application_name: Firefox 11:38:37 INFO - mozversion application_remotingname: firefox 11:38:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:38:37 INFO - mozversion application_vendor: Mozilla 11:38:37 INFO - mozversion application_version: 58.0a1 11:38:37 INFO - mozversion platform_buildid: 20170925174106 11:38:37 INFO - mozversion platform_changeset: 33b7b8e81b4befcba503c0e48cd5370aeb715085 11:38:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:38:37 INFO - mozversion platform_version: 58.0a1 11:38:37 INFO - using testdate: 1506364717 11:38:37 INFO - actual date: 1506364717 11:38:37 INFO - starting webserver on 'localhost:47138' 11:38:37 INFO - SUITE-START | Running 2 tests 11:38:37 INFO - TEST-START | dromaeo_css 11:38:37 INFO - Initialising browser for dromaeo_css test... 11:38:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47138/getInfo.html -profile /tmp/tmpvwOSz1/profile 11:38:37 INFO - TEST-INFO | started process 28048 (/builds/slave/test/build/application/firefox/firefox http://localhost:47138/getInfo.html) 11:38:42 INFO - TEST-INFO | 28048: exit 0 11:38:42 INFO - Browser initialized. 11:38:42 INFO - Running cycle 1/1 for dromaeo_css test... 11:38:42 INFO - Using env: {'DISPLAY': ':0', 11:38:42 INFO - 'HOME': '/home/cltbld', 11:38:42 INFO - 'JSGC_DISABLE_POISONING': '1', 11:38:42 INFO - 'LANG': 'en_US.UTF-8', 11:38:42 INFO - 'LANGUAGE': 'en_US:en', 11:38:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:38:42 INFO - 'LOGNAME': 'cltbld', 11:38:42 INFO - 'MAIL': '/var/mail/cltbld', 11:38:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:38:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:38:42 INFO - 'MOZ_CRASHREPORTER': '1', 11:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:38:42 INFO - 'MOZ_NO_REMOTE': '1', 11:38:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:42 INFO - 'NO_EM_RESTART': '1', 11:38:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:42 INFO - 'PWD': '/builds/slave/test', 11:38:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:38:42 INFO - 'RUST_BACKTRACE': 'full', 11:38:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:38:42 INFO - 'SHELL': '/bin/bash', 11:38:42 INFO - 'SHLVL': '1', 11:38:42 INFO - 'STYLO_FORCE_DISABLED': '1', 11:38:42 INFO - 'TERM': 'linux', 11:38:42 INFO - 'TMOUT': '86400', 11:38:42 INFO - 'USER': 'cltbld', 11:38:42 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', 11:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:42 INFO - '_': '/tools/buildbot/bin/python'} 11:38:42 INFO - TEST-INFO | started process 28280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvwOSz1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:43 INFO - PID 28280 | 11:38:43 INFO - PID 28280 | (/builds/slave/test/build/application/firefox/firefox:28329): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:38:43 INFO - PID 28280 | 11:38:54 INFO - PID 28280 | RSS: Main: 153444352 11:38:54 INFO - PID 28280 | 11:41:51 INFO - PID 28280 | Cycle 1(1): loaded http://localhost:47138/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47138/tests/dromaeo/cssquery-ext.html) 11:41:52 INFO - PID 28280 | RSS: Main: 154128384 11:41:52 INFO - PID 28280 | 11:44:54 INFO - PID 28280 | Cycle 1(1): loaded http://localhost:47138/tests/dromaeo/cssquery-ext.html (next: http://localhost:47138/tests/dromaeo/cssquery-jquery.html) 11:44:55 INFO - PID 28280 | RSS: Main: 154533888 11:44:55 INFO - PID 28280 | 11:47:57 INFO - PID 28280 | Cycle 1(1): loaded http://localhost:47138/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47138/tests/dromaeo/cssquery-mootools.html) 11:47:57 INFO - PID 28280 | RSS: Main: 155881472 11:47:57 INFO - PID 28280 | 11:50:59 INFO - PID 28280 | Cycle 1(1): loaded http://localhost:47138/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47138/tests/dromaeo/cssquery-prototype.html) 11:51:00 INFO - PID 28280 | RSS: Main: 154935296 11:51:00 INFO - PID 28280 | 11:54:03 INFO - PID 28280 | Cycle 1(1): loaded http://localhost:47138/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47138/tests/dromaeo/cssquery-yui.html) 11:54:04 INFO - PID 28280 | RSS: Main: 156422144 11:54:04 INFO - PID 28280 | 11:57:05 INFO - PID 28280 | Cycle 1(1): loaded http://localhost:47138/tests/dromaeo/cssquery-yui.html (next: http://localhost:47138/tests/dromaeo/cssquery-dojo.html) 11:57:05 INFO - PID 28280 | RSS: Main: 158273536 11:57:05 INFO - PID 28280 | 11:57:05 INFO - PID 28280 | __start_tp_report 11:57:05 INFO - PID 28280 | _x_x_mozilla_page_load 11:57:05 INFO - PID 28280 | _x_x_mozilla_page_load_details 11:57:05 INFO - PID 28280 | |i|pagename|runs| 11:57:05 INFO - PID 28280 | |0;dojo.html;3151.4169878572466;3169.3978144152616;3170.0489853044082;3175.1427114679022;3179.968200317998;6259.405356491137;6353.491720662348;6362.968185159073;6382.170317858678;6479.384458476443;6240.251169859612;6240.43836054755;6243.125962365272;6297.18136642237;6316.715747791349;5818.476337129658;5836.037053886103;5863.237779088712;5869.031609784381;5880.794172203974;5855.941440585582;5863.237779088712;5879.941200588003;5935.673537955411;6004.429579189992;5795.304563452391;5868.2664666916635;5882.411758824105;5885.20549725788;5925.259342582177;5685.40303268155;5870.823875283749;5873.148393482942;5924.348321684612;5987.9101813472835;5726.083826587767;5738.913916291259;5751.396103409165;5831.912521312183;5874.089516125007;6318.115463835067;6334.3032266450655;6351.809445716636;6402.199725034371;6434.903476447857;6584.637844918528;6665.233498147727;6783.694733736994;6789.796306110825;6864.485163612699;6864.450843932474;6881;6904.482163837682;6946.513744037919;6951.131108611424;6166.537509686791;6285.748570057147;6347.206599175103;6430.485561155143;6432.839179020562;6974.0585021022525;7046.154461464657;7069.823254418578;7140.714371425085;7144.249853765384;6731.798046058626;6737.52837301394;6794.694238759268;6832.521723479309;6833.93166068333;6651;6736.2590115087305;6774.153230846145;6831.897521537181;6924.376806087476;6805.489588280899;6808.9659551701925;6819.590824550443;6821.113255276881;6826.317368263233;6847.1783385994;6854.794356169323;6859.828504287333;6864;6868.210155832044;5247.7113758743635;5350.545203657655;5384.6769193848495;5395.865103372447;5406.837794866082;4567.269236922077;4665.813367465331;4711;4724.267738500538;4728.881777955578;5727.656340619576;5806;5847.970760146172;5851.648901065864;5865.208196893364;6848.938414545753;6854.10896583441;6907.7236910524025;6936.583804971718;6941.479389045841;5806.332271788714;5828.242328497353;5881.264841894763;5886.970565147232;5907.911381329283;5810.912836307459;5817.825465236049;5850.619709718854;5880.647161170344;5896.174535565025;6574.638394888231;6651.201855777241;6687.732490700415;6716.966415167893;6722.394984451423;6730.663466826737;6833.897491537531;6918.273581273894;6925.480588955747;6935.063766391472;6606.8678626426245;6620.337966203534;6709.094272273181;6723.125993620798;6730.32696730323;6598.670066496752;6671.33286671329;6698.531102822755;6772.93227067723;6792.9470932005615;6836.794896153124;6929.272426395156;6943;6948.583085014915;6958;6423.42189202974;6480.060391243149;6535.150430444012;6586.242582103119;6617.735290588323;6629.171353580802;6668.3331666834865;6674.43267322283;6696.531242812956;6699.9665001674675;6381.202349706286;6482.611043337226;6483.902741458787;6514.348565143448;6579.17760279965;6548.607083575001;6560.868782624416;6612.735490580323;6620.073189753534;6643.966780166068;6271.278802937538;6298.1812364392335;6347.682615869096;6351.71417286214;6412.39082287182 11:57:05 INFO - PID 28280 | |1;ext.html;860.3676297921028;879.9868001979976;880.8238352329531;882.2765332427408;883.0418995390004;38302.23395532091;41754;41944.37083443743;41986.58013419869;42018.15963680724;38796.224075518476;39291.803540982255;39597.60402395975;39703.80148099255;39724.40413393801;7171.7489887853935;7269.127704675447;7319.59742214178;7327.523710958771;7341.045664063664;7200.927990720104;7344.853102937938;7353.227911069341;7363.595002274873;7374.262573742636;7305.598192099433;7329.5602263864075;7336;7908.44640875139;8076.434649574532;7936.5238085714755;8018.719344822904;8029.558374289411;8045;8051.154628763954;7849.136594974549;7942;7973.760787176394;7974.920250797534;7977.56123413212;38406.423903641466;39328;39362.80318598417;39377.40933885994;39473;3519.560054993126;3546.5744110706623;3558.857645694169;3565.750397472178;3566.3937130687586;32622.184445389055;32760.836195819105;32843;32919.17702057444;32939.6706032939;5161.767720452551;5169;5186.0665080285535;5192.636515443921;5247.134222853225;188565;190348;190624;191106;192443;43955;44604.330935036;49449.50550494521;49951.75024124929;50750;53237.7338113307;53268;53405.465945340824;53490.46509534855;53499.46500535023;15208.543743687485;15224;15263.236838158047;15301.9234903827;15339.539813805604;12246.387680615933;12254.20347677398;12276.38618069093;12290.938545307396;12360.134790564754;14396.28018599066;14527.636809079857;14609.342579583732;14618.926905365404;14755.631109222355;5966.522678185735;5981.590493418709;6021;6032.366601506867;6046.969765151234;980.9509524523745;1004.7086344960026;1006.3207335048813;1021.5964693945998;1023.4064242739342;22862.885685571797;23184.884075579852;23437.06251749945;23517;23703.7629623705;1100.6863044032411;1120.6301920366423;1120.8991190792867;1138.4478527913955;1140.9087273018138;12389.256644601353;12482.50069997208;12543.56097536582;12577.559785407468;12665.620031398888;233844;235100;235693;235902;235982;52888.471115288354;53288.46711532913;53410.73294633502;53569;53680;1394.268009295108;1460.2990564528873;1462.166565057928;1469.955901322962;1477.534576608365;22864.542709146055;22896.885515572983;23035.308940731804;23131.07475700953;23530.294091177293;38006.23987520179;38006.80996594999;38035.809820950715;38079.619203807604;38095;192533;193524;193961;194227;194891;30710.539341910335;30962;31083.689163108986;34646.13384665403;34961.82519087388;43312.783436083875;43333.78333108441;43902.12195756131;44139.55860441354;44701.32948005848;32108.518372223967;32175.35649287048;32256.516152258206;32345;32604.51093233556;31793.841030794698;31950.68049319477;32207.51688724718;32286.35427291488;32339.35321293608;35626.28747425089;35676.28647426985;35784.46323305101;36035.099122522144;36083.63916360803;30877.69122308748;31380.215494612818;31533.211669708442;31576.842115789274;32067.35865282728;23325.650115248623;23432;23454.179103731287;23737.388887222045;23885.402864928517 11:57:05 INFO - PID 28280 | |2;jquery.html;588.4321629627411;593.427342614377;599.847039005054;611.7614130489109;613.6655522740106;21736.782632173672;22385.664215036788;22410.775892241094;22473.438164045907;22510.099596016138;23336;24003.279901602935;24980;25062;25145.119920802776;6501.8374540636505;6695.3304669533145;6696.8995465068065;6703.765368212114;6705.329467053304;6465.74137034518;6587.341265873422;6669.666516674171;6693.364130407628;6777.0173324867865;6690;6701.664916754167;6705;6706.195256569218;6714.529982901199;6653.53425260232;6676;6693.263740988487;6706;6733.696983635748;6047.516198704093;6277.089821975834;6283.59156654816;6300.968495157541;6307.432331090224;29302.974395896254;29747.70252297471;29774.255643608867;29781.553276700866;29834.850825745732;2080.157536197842;2101.5796840631933;2105.1789801977243;2106.220698341608;2113.355426594888;19383.709244361347;19828.504287392785;20012.69980950287;20153.39539813808;20174.899125504424;2187.62810322244;2233.419310979141;2237.9328620141423;2245.247841972941;2255.5939930812447;119356.20965685522;127223;136444;144323;145353.27323363422;14654.43717923787;14724;15185.696286074217;15189;15851;23928.641070383957;23948.640770388458;23993.760062399153;24059.639105413433;24095.156669516484;9849.310548261696;9990.200783937267;10030.398176109456;10076;10157.542910569042;8874.911250887408;8950.552472376356;8957;9058.275337972946;9072.228860546928;9149.54252287383;9244.90755092454;9269.119433653792;9395.671151509665;9583.616655333848;2644.140654287326;2670.145553422925;2731.6995130535624;2796.51061064317;2800.1879454958244;940.1820416237916;967.351874244258;972.0862389354126;975.882894052704;976.6825781621002;18899.149538270813;19174.424767257005;19221.231150753814;19489;19671.606567868563;1030.855680204772;1041.578160844859;1044.159451641436;1045.2839804733783;1046.0899017854363;10693.732656683489;10743;10750.569977200981;10860.72848178786;10977.725556861142;456636;463269;466261;467380;470266;109887.45056274667;110058;110442;110653;112059;1046.6232156423682;1107.180686292138;1162.738383863624;1165.9533618655328;1217.4460620417865;19998.70001950001;20096;20257.29099481511;20313.187472501526;20447.38657840267;52638;56225.718871407014;56236.71881640566;57028.144577830535;57286.7135664319;64994;67093;67176;67449.66275168593;68045.65977170083;14237.786433203717;14478.927605361905;14514.274286285854;14521.709565808836;14533.418663253775;21697.34907952764;21907.561848762616;21991.450213744145;22214.111435542396;22250.666240006736;17643.20605572778;17726.734098988785;17978.190981405605;18095.914245145334;18126.093695315445;15018.474353397578;15550.61123471877;16042.67914641724;16446.917765411097;16469.83530164731;16597.25312360971;17716.734248986533;17732.734008989617;18032.729509057637;18040.09799509993;14221.217833018869;14275;14279.42882284697;14352.856471435152;14357.282135892954;17472.563185920455;17507;17718;17889.552761180556;18003.909980450015 11:57:05 INFO - PID 28280 | |3;mootools.html;1329.9867001329987;1369.9794503082449;1376.7177728565646;1381.7443772902009;1385.425048604829;15222.238888055594;15940.84059159408;15981.360745570179;16009.119498427583;16010.43963461279;15602.21988900556;15623.531294061168;15732.449364272254;15751.84248157518;15779.842201577982;2644.233172380012;2779.749822515973;2780.152053623644;2781.276868014321;2784.373515958903;2658.1493921944984;2711.6068170115323;2727.5226835303843;2729.8089133760645;2730.2901245676167;2382.4758553118286;2472.0606169655507;2477.331120597438;2729.5359788835945;2839.460502504528;2748.7663548598393;2786.317352248702;2792.511310520661;2802.873870675804;2806.4387122575363;2734.248081777507;2744.6157537944705;2762.406082692211;2762.6270453488723;2766.543520319145;15332.310046047955;15561.922190388976;15568.61078473036;15569.844301556952;15586;7887.881681774778;8137.30832879206;8202.917970820276;8203.261706446448;8218.342532597379;5386.973065134688;5499.202615620713;5526.696031718254;5740.540756739492;5783.363829978699;2020.7474065741783;2029.3810387831707;2029.776724560312;2059.4027731957713;2064.865783724068;28285.85857070722;28318.150455486368;28321.575176372164;28407;28422.28944276389;7351.22812104732;7361.852762944711;7473.813154671177;7717.305442510201;7731.884021739678;20969.895150524455;20990.370288891358;21024.579508409744;21041.15835366599;21057.578848422945;8647.481151130953;8663.913360866436;8666.523341216294;8670.219680228809;8670.566471676391;7574.621268936531;7589.241075892477;7749.7287594933905;7758.495697779626;7817;5703.857403564861;5824.301083869963;5875.441833025941;6033.78881739137;6146.969265153735;1622.318626176985;1740.781452982917;1746.938857139994;1773.671870703924;1775.902325372117;758.829263415727;903.223228023899;917.821024900138;927.8149956851652;941.9481928493861;8773.166549177819;8817.250533704579;8884.37809353352;8916;8933.106689331145;970.6651205334149;1003.4280460137652;1003.8243307421318;1004.5027711282816;1006.3911333643186;4765.356676848581;4802.975985120052;4864.294677271847;4885.169521181408;4896.706197628154;21699.13203471875;22342.66486002711;22482.651040937595;22595.774042259694;22816.771832281465;21982.89008554979;22031.449213769465;22220;22468.32595022152;22792.772072279397;11510.654680359603;11601.883981160248;11680.299182049104;11685.883141168479;11692.415379231004;8748.47509149453;8794.164554367326;8795;8839.779005524913;8846;18832.152553134867;18898.14958326851;19375.90312048431;19462.221511139964;19619.70570441473;18586.349477768214;19548.706769398756;19618.803811961698;19715;19722.30971915976;12092.334921579397;12311.69220769488;12415.875841241834;12417.379131043232;12423.378831058591;14145.151290922578;14182.078164919247;14306.356213970188;14317.85682143207;14441.855581444472;11275.210735248455;11392.54429822831;11609.709757255798;11702.414879255834;11784.469698863742;11148.108151347711;11253.71865703364;11418.31490110596;11558.364289964133;11570.479328430409;9505.477198754135;10293.71328583927;10300.639477618248;10325.63860264887;10331.94834025825;7445.4415918805225;7512.774616761506;7517.812054698677;7523.699052038076;7524.736634217776;7420.674516064787;7460.664270107966;7530.134034586093;7563.130240022468;7672.578008209602 11:57:05 INFO - PID 28280 | |4;prototype.html;488.1506179248109;521.395181589356;532.7496076843883;539.6276569167275;554.8668319603294;6129.141920131179;6170.598911070783;6202.286737025243;6242.656653884034;6278.811635650926;6137.508999280047;6183.196184496021;6215.658138802364;6216.658083805389;6226.40849119333;5166.844994650148;5169.793208271664;5182.274481572564;5190.896182076375;5195.792168313263;4919.311296418504;5113.258577506259;5153.742312884359;5157.226416037587;5188.184135552545;4989.276554899556;5049.444561098277;5050.595952323805;5061.228570000507;5062.2406639004075;4935.629827762897;4963.932754457773;5009.764795788392;5043.193089105744;5071.3153724247495;4513.842015529441;4516.096780643851;4524.705894116872;4536;4543.659225558096;6088.4215999479975;6158.907616385758;6184.288806787232;6192.411720886554;6270.65511396873;5803.941960580382;5814.592978491507;5829.387914268983;5831.650100993911;5853.619514731528;6525.380088891595;6545.214574251073;6559.2128944526485;6606.834829129262;6610.8016759497295;4894.388201474816;4933.55597996182;4964.404271487409;4981.27771473138;4987.476314986947;6529.771457998947;6647.268800431901;6898.344657257552;6908.792736217922;7016.36852683261;5011.248312753116;5022.397312322545;5085.64400491962;5087.338645976073;5122.078025955289;5075.365579302587;5145.588352931756;5155.32980712505;5180.119379705459;5191.299174611455;5744.597878148489;5756.366799652035;5765.971170144207;5801.216835727123;5807.738651760681;6658.833529161713;6683.522040233055;6697.497687673444;6699.564528305645;6700.262971073178;1777.5644966982914;1777.6889044417176;1790.7761529808774;1791.937282195117;1798.3615816385256;1169.9824502632466;1243.5771837575269;1250.693580072888;1259.5843371687322;1262.4760724299497;5735.684537350486;5757.424257574209;5780.710964451845;5805.332386775491;5868.706564671749;6846.281140480278;6846.315368463213;6854.451643868479;6860.622665753432;6920.792376228721;5708.65748055118;5738.68437235956;5760;5765.135229715576;5804.506616937523;3554.8400321985573;3561.982190089033;3584.1577229351083;3586.497890295361;3600.2979419013564;5999.790007349722;6501.187351581052;6501.44737697301;6531.804045878631;6583.341665833378;6721.4958878084335;6803.353681400259;6821.249662537117;6854.280300568368;6931.405776671293;6355.330761080358;6380.330065343165;6543.869122617521;6589.472842172615;6607.768728094686;6760.512687208806;6812.318768123148;6813.7955861324235;6830.726770929107;6839.1451068616425;6664.900556324742;6707.9267317229005;6712;6712.765053223114;6714.959181326903;6539.509536784665;6562.407848899563;6572.539922205399;6584.934150658432;6622.337766223339;5059.367579052619;5065.480355893291;5080.568151707146;5090.338256026693;5111.974440127776;6374.681265936777;6636.336366363325;6655.833604159741;6787.423069039187;6820.829479263058;6327.873442531031;6400.967995160181;6459.321771213955;6516.436055346778;6576.210854697467;6428.517861160525;6510.860599395181;6524.804255872332;6529.379708927644;6543.738250470118;6329.461995730415;6351.777687780906;6426.614403135827;6465.870682586228;6506.4469520091325;6457.257415397102;6462.933615953315;6506.772262970773;6512.251091124582;6563.310852360433;6332.905006424815;6407.8398040047505;6412.839679008062;6450.387213214737;6455.193100862392 11:57:05 INFO - PID 28280 | |5;yui.html;915.0803442540248;929.8186853563558;931.4085555672146;934.5140526925994;939.7932454859929;20308.492287692796;20387.796122038777;20763.584728305425;20780.16879324829;20780.792192078075;17534.29862805486;17892.642147157083;17894.5526361841;17898.552536186602;17926.103694815272;971.2375785008769;989.712983234861;993.3741742702124;998.1665309466604;999;934.2759361494828;1003.2575893838543;1015.7663737340416;1017.9796404071914;1021.9131373833196;1065.8720953485554;1068.1241382066708;1069.3637285814928;1070.9946450267737;1072.1155047086147;989.915857152143;1031.283258135596;1061.6231237910508;1063.6224140430152;1064.0795711709393;760.444875241077;765.1659690936906;765.6210175962879;765.8621448139332;766.0768773627765;20851.374458766262;21087.894560527253;21105.15579376823;21202.787972120237;21205.469863253387;21628.243011494524;22714.886425567933;22796;22802.999999999833;22917.083316667315;17770.644587108185;18428.90785546064;18460.53848653781;18610.44168674942;18636.906815465973;3688.5758137814228;3724.2737666155112;3730.7015438764834;3739.7943113128767;3740.682042026431;142139;143693;143946;144508.2774586131;146742;16635.251413686412;16862.57843553921;17127.657446850993;17132;17246;32892.50661240083;33526.3294734104;33577.160570985434;33618.15954601154;33627;9089.863652045224;9251.167394934353;9348.532573371303;9444.433333999981;9451.621935122655;4327.5239723630375;4438.889027774267;4441;4442.8667139985855;4444.511103778582;5417.51242388187;5420.566354691615;5463.808766693147;5489.231507588941;5568.053430916673;1007.6976906928039;1022.3405903192399;1037.5745944162857;1040.2977989856815;1042.7341028037802;650.9283978762332;664.6676661669165;670.3865962644223;679.2358596578849;682.7849227493324;11479.081673466102;11497.770044599229;12073.57742479009;12587.992960563133;12885.162464439782;657.7796438193163;664.7839452178061;671.1241829412663;672.9697163627551;681.2676372899153;5488.615796894179;5501.504864562128;5514.062609356419;5537.1140617501005;5588.524975377139;124062.37968810098;124796;126724;127668.36165819112;130516;109205;110078.44960775145;110608;112111;114140.42929785464;94355.52822235982;95200;95256.52371738236;97121;98353.50823245838;12547;13042.869571304545;13324.000699947348;13416.932915335361;13657.673507332347;43416.13167736691;43610.345844811716;43801;44426.333604996595;44842;58022.7098864503;58253.708731457766;58778.412215877295;59510.70244648749;59699.10451343146;18562.350317738816;18739.718904216174;18766.906165469085;18826.52933676669;18852;20984;21110.261140859995;21248.78751212468;21255.36233912985;21375.251866184608;19723.901380493007;19820.20719171217;19960.3013894513;19991.800081998994;19991.900040499706;18708.158132884324;18994.620107597493;19100;19121.04394780283;19157.61684766325;17872.374466893598;17996.10019499046;18028.909855450638;18032.098395080455;18162.27350905949;13269.203847769164;13311.201327920357;13625.591232263048;13832.792508112185;13854.584362469142;14014;14214.147151170962;14293.57119286423;14304.642383940485;14358.353874075483 11:57:05 INFO - PID 28280 | __end_tp_report 11:57:05 INFO - PID 28280 | __start_cc_report 11:57:05 INFO - PID 28280 | _x_x_mozilla_cycle_collect,276 11:57:05 INFO - PID 28280 | __end_cc_report 11:57:05 INFO - PID 28280 | __startTimestamp1506365825895__endTimestamp 11:57:05 INFO - PID 28280 | 11:57:05 INFO - PID 28280 | ------- Summary: start ------- 11:57:05 INFO - PID 28280 | Number of tests: 6 11:57:05 INFO - PID 28280 | 11:57:05 INFO - PID 28280 | [#0] dojo.html Cycles:165 Average:6263.51 Median:6480.06 stddev:762.10 (11.8%) stddev-sans-first:724.27 11:57:05 INFO - PID 28280 | Values: 3151.4 3169.4 3170.0 3175.1 3180.0 6259.4 6353.5 6363.0 6382.2 6479.4 6240.3 6240.4 6243.1 6297.2 6316.7 5818.5 5836.0 5863.2 5869.0 5880.8 5855.9 5863.2 5879.9 5935.7 6004.4 5795.3 5868.3 5882.4 5885.2 5925.3 5685.4 5870.8 5873.1 5924.3 5987.9 5726.1 5738.9 5751.4 5831.9 5874.1 6318.1 6334.3 6351.8 6402.2 6434.9 6584.6 6665.2 6783.7 6789.8 6864.5 6864.5 6881.0 6904.5 6946.5 6951.1 6166.5 6285.7 6347.2 6430.5 6432.8 6974.1 7046.2 7069.8 7140.7 7144.2 6731.8 6737.5 6794.7 6832.5 6833.9 6651.0 6736.3 6774.2 6831.9 6924.4 6805.5 6809.0 6819.6 6821.1 6826.3 6847.2 6854.8 6859.8 6864.0 6868.2 5247.7 5350.5 5384.7 5395.9 5406.8 4567.3 4665.8 4711.0 4724.3 4728.9 5727.7 5806.0 5848.0 5851.6 5865.2 6848.9 6854.1 6907.7 6936.6 6941.5 5806.3 5828.2 5881.3 5887.0 5907.9 5810.9 5817.8 5850.6 5880.6 5896.2 6574.6 6651.2 6687.7 6717.0 6722.4 6730.7 6833.9 6918.3 6925.5 6935.1 6606.9 6620.3 6709.1 6723.1 6730.3 6598.7 6671.3 6698.5 6772.9 6792.9 6836.8 6929.3 6943.0 6948.6 6958.0 6423.4 6480.1 6535.2 6586.2 6617.7 6629.2 6668.3 6674.4 6696.5 6700.0 6381.2 6482.6 6483.9 6514.3 6579.2 6548.6 6560.9 6612.7 6620.1 6644.0 6271.3 6298.2 6347.7 6351.7 6412.4 11:57:05 INFO - PID 28280 | 11:57:05 INFO - PID 28280 | [#1] ext.html Cycles:180 Average:37640.28 Median:3552.72 stddev:53811.25 (1514.7%) stddev-sans-first:53891.33 11:57:05 INFO - PID 28280 | Values: 860.4 880.0 880.8 882.3 883.0 38302.2 41754.0 41944.4 41986.6 42018.2 38796.2 39291.8 39597.6 39703.8 39724.4 7171.7 7269.1 7319.6 7327.5 7341.0 7200.9 7344.9 7353.2 7363.6 7374.3 7305.6 7329.6 7336.0 7908.4 8076.4 7936.5 8018.7 8029.6 8045.0 8051.2 7849.1 7942.0 7973.8 7974.9 7977.6 38406.4 39328.0 39362.8 39377.4 39473.0 3519.6 3546.6 3558.9 3565.8 3566.4 32622.2 32760.8 32843.0 32919.2 32939.7 5161.8 5169.0 5186.1 5192.6 5247.1 188565.0 190348.0 190624.0 191106.0 192443.0 43955.0 44604.3 49449.5 49951.8 50750.0 53237.7 53268.0 53405.5 53490.5 53499.5 15208.5 15224.0 15263.2 15301.9 15339.5 12246.4 12254.2 12276.4 12290.9 12360.1 14396.3 14527.6 14609.3 14618.9 14755.6 5966.5 5981.6 6021.0 6032.4 6047.0 981.0 1004.7 1006.3 1021.6 1023.4 22862.9 23184.9 23437.1 23517.0 23703.8 1100.7 1120.6 1120.9 1138.4 1140.9 12389.3 12482.5 12543.6 12577.6 12665.6 233844.0 235100.0 235693.0 235902.0 235982.0 52888.5 53288.5 53410.7 53569.0 53680.0 1394.3 1460.3 1462.2 1470.0 1477.5 22864.5 22896.9 23035.3 23131.1 23530.3 38006.2 38006.8 38035.8 38079.6 38095.0 192533.0 193524.0 193961.0 194227.0 194891.0 30710.5 30962.0 31083.7 34646.1 34961.8 43312.8 43333.8 43902.1 44139.6 44701.3 32108.5 32175.4 32256.5 32345.0 32604.5 31793.8 31950.7 32207.5 32286.4 32339.4 35626.3 35676.3 35784.5 36035.1 36083.6 30877.7 31380.2 31533.2 31576.8 32067.4 23325.7 23432.0 23454.2 23737.4 23885.4 11:57:05 INFO - PID 28280 | 11:57:05 INFO - PID 28280 | [#2] jquery.html Cycles:180 Average:33628.31 Median:2235.68 stddev:78399.63 (3506.8%) stddev-sans-first:78580.31 11:57:05 INFO - PID 28280 | Values: 588.4 593.4 599.8 611.8 613.7 21736.8 22385.7 22410.8 22473.4 22510.1 23336.0 24003.3 24980.0 25062.0 25145.1 6501.8 6695.3 6696.9 6703.8 6705.3 6465.7 6587.3 6669.7 6693.4 6777.0 6690.0 6701.7 6705.0 6706.2 6714.5 6653.5 6676.0 6693.3 6706.0 6733.7 6047.5 6277.1 6283.6 6301.0 6307.4 29303.0 29747.7 29774.3 29781.6 29834.9 2080.2 2101.6 2105.2 2106.2 2113.4 19383.7 19828.5 20012.7 20153.4 20174.9 2187.6 2233.4 2237.9 2245.2 2255.6 119356.2 127223.0 136444.0 144323.0 145353.3 14654.4 14724.0 15185.7 15189.0 15851.0 23928.6 23948.6 23993.8 24059.6 24095.2 9849.3 9990.2 10030.4 10076.0 10157.5 8874.9 8950.6 8957.0 9058.3 9072.2 9149.5 9244.9 9269.1 9395.7 9583.6 2644.1 2670.1 2731.7 2796.5 2800.2 940.2 967.4 972.1 975.9 976.7 18899.1 19174.4 19221.2 19489.0 19671.6 1030.9 1041.6 1044.2 1045.3 1046.1 10693.7 10743.0 10750.6 10860.7 10977.7 456636.0 463269.0 466261.0 467380.0 470266.0 109887.5 110058.0 110442.0 110653.0 112059.0 1046.6 1107.2 1162.7 1166.0 1217.4 19998.7 20096.0 20257.3 20313.2 20447.4 52638.0 56225.7 56236.7 57028.1 57286.7 64994.0 67093.0 67176.0 67449.7 68045.7 14237.8 14478.9 14514.3 14521.7 14533.4 21697.3 21907.6 21991.5 22214.1 22250.7 17643.2 17726.7 17978.2 18095.9 18126.1 15018.5 15550.6 16042.7 16446.9 16469.8 16597.3 17716.7 17732.7 18032.7 18040.1 14221.2 14275.0 14279.4 14352.9 14357.3 17472.6 17507.0 17718.0 17889.6 18003.9 11:57:05 INFO - PID 28280 | 11:57:05 INFO - PID 28280 | [#3] mootools.html Cycles:180 Average:9800.27 Median:2560.78 stddev:7079.99 (276.5%) stddev-sans-first:7071.25 11:57:05 INFO - PID 28280 | Values: 1330.0 1370.0 1376.7 1381.7 1385.4 15222.2 15940.8 15981.4 16009.1 16010.4 15602.2 15623.5 15732.4 15751.8 15779.8 2644.2 2779.7 2780.2 2781.3 2784.4 2658.1 2711.6 2727.5 2729.8 2730.3 2382.5 2472.1 2477.3 2729.5 2839.5 2748.8 2786.3 2792.5 2802.9 2806.4 2734.2 2744.6 2762.4 2762.6 2766.5 15332.3 15561.9 15568.6 15569.8 15586.0 7887.9 8137.3 8202.9 8203.3 8218.3 5387.0 5499.2 5526.7 5740.5 5783.4 2020.7 2029.4 2029.8 2059.4 2064.9 28285.9 28318.2 28321.6 28407.0 28422.3 7351.2 7361.9 7473.8 7717.3 7731.9 20969.9 20990.4 21024.6 21041.2 21057.6 8647.5 8663.9 8666.5 8670.2 8670.6 7574.6 7589.2 7749.7 7758.5 7817.0 5703.9 5824.3 5875.4 6033.8 6147.0 1622.3 1740.8 1746.9 1773.7 1775.9 758.8 903.2 917.8 927.8 941.9 8773.2 8817.3 8884.4 8916.0 8933.1 970.7 1003.4 1003.8 1004.5 1006.4 4765.4 4803.0 4864.3 4885.2 4896.7 21699.1 22342.7 22482.7 22595.8 22816.8 21982.9 22031.4 22220.0 22468.3 22792.8 11510.7 11601.9 11680.3 11685.9 11692.4 8748.5 8794.2 8795.0 8839.8 8846.0 18832.2 18898.1 19375.9 19462.2 19619.7 18586.3 19548.7 19618.8 19715.0 19722.3 12092.3 12311.7 12415.9 12417.4 12423.4 14145.2 14182.1 14306.4 14317.9 14441.9 11275.2 11392.5 11609.7 11702.4 11784.5 11148.1 11253.7 11418.3 11558.4 11570.5 9505.5 10293.7 10300.6 10325.6 10331.9 7445.4 7512.8 7517.8 7523.7 7524.7 7420.7 7460.7 7530.1 7563.1 7672.6 11:57:05 INFO - PID 28280 | 11:57:05 INFO - PID 28280 | [#4] prototype.html Cycles:180 Average:5546.45 Median:6176.90 stddev:1537.81 (24.9%) stddev-sans-first:1494.53 11:57:05 INFO - PID 28280 | Values: 488.2 521.4 532.7 539.6 554.9 6129.1 6170.6 6202.3 6242.7 6278.8 6137.5 6183.2 6215.7 6216.7 6226.4 5166.8 5169.8 5182.3 5190.9 5195.8 4919.3 5113.3 5153.7 5157.2 5188.2 4989.3 5049.4 5050.6 5061.2 5062.2 4935.6 4963.9 5009.8 5043.2 5071.3 4513.8 4516.1 4524.7 4536.0 4543.7 6088.4 6158.9 6184.3 6192.4 6270.7 5803.9 5814.6 5829.4 5831.7 5853.6 6525.4 6545.2 6559.2 6606.8 6610.8 4894.4 4933.6 4964.4 4981.3 4987.5 6529.8 6647.3 6898.3 6908.8 7016.4 5011.2 5022.4 5085.6 5087.3 5122.1 5075.4 5145.6 5155.3 5180.1 5191.3 5744.6 5756.4 5766.0 5801.2 5807.7 6658.8 6683.5 6697.5 6699.6 6700.3 1777.6 1777.7 1790.8 1791.9 1798.4 1170.0 1243.6 1250.7 1259.6 1262.5 5735.7 5757.4 5780.7 5805.3 5868.7 6846.3 6846.3 6854.5 6860.6 6920.8 5708.7 5738.7 5760.0 5765.1 5804.5 3554.8 3562.0 3584.2 3586.5 3600.3 5999.8 6501.2 6501.4 6531.8 6583.3 6721.5 6803.4 6821.2 6854.3 6931.4 6355.3 6380.3 6543.9 6589.5 6607.8 6760.5 6812.3 6813.8 6830.7 6839.1 6664.9 6707.9 6712.0 6712.8 6715.0 6539.5 6562.4 6572.5 6584.9 6622.3 5059.4 5065.5 5080.6 5090.3 5112.0 6374.7 6636.3 6655.8 6787.4 6820.8 6327.9 6401.0 6459.3 6516.4 6576.2 6428.5 6510.9 6524.8 6529.4 6543.7 6329.5 6351.8 6426.6 6465.9 6506.4 6457.3 6462.9 6506.8 6512.3 6563.3 6332.9 6407.8 6412.8 6450.4 6455.2 11:57:05 INFO - PID 28280 | 11:57:05 INFO - PID 28280 | [#5] yui.html Cycles:180 Average:25518.36 Median:20771.88 stddev:36100.05 (173.8%) stddev-sans-first:36154.05 11:57:05 INFO - PID 28280 | Values: 915.1 929.8 931.4 934.5 939.8 20308.5 20387.8 20763.6 20780.2 20780.8 17534.3 17892.6 17894.6 17898.6 17926.1 971.2 989.7 993.4 998.2 999.0 934.3 1003.3 1015.8 1018.0 1021.9 1065.9 1068.1 1069.4 1071.0 1072.1 989.9 1031.3 1061.6 1063.6 1064.1 760.4 765.2 765.6 765.9 766.1 20851.4 21087.9 21105.2 21202.8 21205.5 21628.2 22714.9 22796.0 22803.0 22917.1 17770.6 18428.9 18460.5 18610.4 18636.9 3688.6 3724.3 3730.7 3739.8 3740.7 142139.0 143693.0 143946.0 144508.3 146742.0 16635.3 16862.6 17127.7 17132.0 17246.0 32892.5 33526.3 33577.2 33618.2 33627.0 9089.9 9251.2 9348.5 9444.4 9451.6 4327.5 4438.9 4441.0 4442.9 4444.5 5417.5 5420.6 5463.8 5489.2 5568.1 1007.7 1022.3 1037.6 1040.3 1042.7 650.9 664.7 670.4 679.2 682.8 11479.1 11497.8 12073.6 12588.0 12885.2 657.8 664.8 671.1 673.0 681.3 5488.6 5501.5 5514.1 5537.1 5588.5 124062.4 124796.0 126724.0 127668.4 130516.0 109205.0 110078.4 110608.0 112111.0 114140.4 94355.5 95200.0 95256.5 97121.0 98353.5 12547.0 13042.9 13324.0 13416.9 13657.7 43416.1 43610.3 43801.0 44426.3 44842.0 58022.7 58253.7 58778.4 59510.7 59699.1 18562.4 18739.7 18766.9 18826.5 18852.0 20984.0 21110.3 21248.8 21255.4 21375.3 19723.9 19820.2 19960.3 19991.8 19991.9 18708.2 18994.6 19100.0 19121.0 19157.6 17872.4 17996.1 18028.9 18032.1 18162.3 13269.2 13311.2 13625.6 13832.8 13854.6 14014.0 14214.1 14293.6 14304.6 14358.4 11:57:05 INFO - PID 28280 | -------- Summary: end -------- 11:57:05 INFO - PID 28280 | 11:57:06 INFO - TEST-INFO | 28280: exit 0 11:57:06 INFO - TEST-OK | dromaeo_css | took 1109410ms 11:57:06 INFO - TEST-START | kraken 11:57:06 INFO - Initialising browser for kraken test... 11:57:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47138/getInfo.html -profile /tmp/tmpU3L5sI/profile 11:57:06 INFO - TEST-INFO | started process 28649 (/builds/slave/test/build/application/firefox/firefox http://localhost:47138/getInfo.html) 11:57:12 INFO - TEST-INFO | 28649: exit 0 11:57:12 INFO - Browser initialized. 11:57:12 INFO - Running cycle 1/1 for kraken test... 11:57:12 INFO - Using env: {'DISPLAY': ':0', 11:57:12 INFO - 'HOME': '/home/cltbld', 11:57:12 INFO - 'JSGC_DISABLE_POISONING': '1', 11:57:12 INFO - 'LANG': 'en_US.UTF-8', 11:57:12 INFO - 'LANGUAGE': 'en_US:en', 11:57:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:57:12 INFO - 'LOGNAME': 'cltbld', 11:57:12 INFO - 'MAIL': '/var/mail/cltbld', 11:57:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:57:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:57:12 INFO - 'MOZ_CRASHREPORTER': '1', 11:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:57:12 INFO - 'MOZ_NO_REMOTE': '1', 11:57:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:12 INFO - 'NO_EM_RESTART': '1', 11:57:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:12 INFO - 'PWD': '/builds/slave/test', 11:57:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:57:12 INFO - 'RUST_BACKTRACE': 'full', 11:57:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:57:12 INFO - 'SHELL': '/bin/bash', 11:57:12 INFO - 'SHLVL': '1', 11:57:12 INFO - 'STYLO_FORCE_DISABLED': '1', 11:57:12 INFO - 'TERM': 'linux', 11:57:12 INFO - 'TMOUT': '86400', 11:57:12 INFO - 'USER': 'cltbld', 11:57:12 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506364656.295797-181348894', 11:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:12 INFO - '_': '/tools/buildbot/bin/python'} 11:57:12 INFO - TEST-INFO | started process 28882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU3L5sI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:57:13 INFO - PID 28882 | 11:57:13 INFO - PID 28882 | (/builds/slave/test/build/application/firefox/firefox:28931): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:57:13 INFO - PID 28882 | 11:57:23 INFO - PID 28882 | RSS: Main: 151441408 11:57:23 INFO - PID 28882 | 11:57:26 INFO - PID 28882 | Cycle 1(1): loaded http://localhost:47138/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47138/tests/kraken/driver.html?testName=audio-beat-detection) 11:57:27 INFO - PID 28882 | RSS: Main: 158343168 11:57:27 INFO - PID 28882 | 11:57:30 INFO - PID 28882 | Cycle 1(1): loaded http://localhost:47138/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47138/tests/kraken/driver.html?testName=audio-dft) 11:57:30 INFO - PID 28882 | RSS: Main: 158564352 11:57:30 INFO - PID 28882 | 11:57:33 INFO - PID 28882 | Cycle 1(1): loaded http://localhost:47138/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47138/tests/kraken/driver.html?testName=audio-fft) 11:57:34 INFO - PID 28882 | RSS: Main: 154599424 11:57:34 INFO - PID 28882 | 11:57:36 INFO - PID 28882 | Cycle 1(1): loaded http://localhost:47138/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47138/tests/kraken/driver.html?testName=audio-oscillator) 11:57:36 INFO - PID 28882 | RSS: Main: 155459584 11:57:36 INFO - PID 28882 | 11:57:39 INFO - PID 28882 | Cycle 1(1): loaded http://localhost:47138/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47138/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:57:39 INFO - PID 28882 | RSS: Main: 155324416 11:57:39 INFO - PID 28882 | 11:57:42 INFO - PID 28882 | Cycle 1(1): loaded http://localhost:47138/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47138/tests/kraken/driver.html?testName=imaging-darkroom) 11:57:43 INFO - PID 28882 | RSS: Main: 157630464 11:57:43 INFO - PID 28882 | 11:57:47 INFO - PID 28882 | Cycle 1(1): loaded http://localhost:47138/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47138/tests/kraken/driver.html?testName=imaging-desaturate) 11:57:47 INFO - PID 28882 | RSS: Main: 157978624 11:57:47 INFO - PID 28882 | 11:57:50 INFO - PID 28882 | Cycle 1(1): loaded http://localhost:47138/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47138/tests/kraken/driver.html?testName=json-parse-financial) 11:57:51 INFO - PID 28882 | RSS: Main: 158543872 11:57:51 INFO - PID 28882 | 11:57:53 INFO - PID 28882 | Cycle 1(1): loaded http://localhost:47138/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47138/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:57:53 INFO - PID 28882 | RSS: Main: 158289920 11:57:53 INFO - PID 28882 | 11:57:55 INFO - PID 28882 | Cycle 1(1): loaded http://localhost:47138/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47138/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:57:55 INFO - PID 28882 | RSS: Main: 158445568 11:57:55 INFO - PID 28882 | 11:57:57 INFO - PID 28882 | Cycle 1(1): loaded http://localhost:47138/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47138/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:57:58 INFO - PID 28882 | RSS: Main: 155271168 11:57:58 INFO - PID 28882 | 11:58:01 INFO - PID 28882 | Cycle 1(1): loaded http://localhost:47138/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:58:01 INFO - PID 28882 | RSS: Main: 155652096 11:58:01 INFO - PID 28882 | 11:58:04 INFO - PID 28882 | Cycle 1(1): loaded http://localhost:47138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:58:05 INFO - PID 28882 | RSS: Main: 155934720 11:58:05 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | Cycle 1(1): loaded http://localhost:47138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47138/tests/kraken/driver.html?testName=ai-astar) 11:58:07 INFO - PID 28882 | RSS: Main: 157057024 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | __start_tp_report 11:58:07 INFO - PID 28882 | _x_x_mozilla_page_load 11:58:07 INFO - PID 28882 | _x_x_mozilla_page_load_details 11:58:07 INFO - PID 28882 | |i|pagename|runs| 11:58:07 INFO - PID 28882 | |0;ai-astar;108;107;107;107;107;110;108;107;107;106 11:58:07 INFO - PID 28882 | |1;audio-beat-detection;118;118;116;116;116;116;124;119;120;121 11:58:07 INFO - PID 28882 | |2;audio-dft;165;163;163;162;163;163;163;168;171;168 11:58:07 INFO - PID 28882 | |3;audio-fft;74;75;74;74;76;75;74;75;78;76 11:58:07 INFO - PID 28882 | |4;audio-oscillator;81;80;79;79;79;79;79;80;87;77 11:58:07 INFO - PID 28882 | |5;imaging-gaussian-blur;114;113;115;113;114;113;114;115;114;115 11:58:07 INFO - PID 28882 | |6;imaging-darkroom;153;147;148;148;150;148;149;151;149;147 11:58:07 INFO - PID 28882 | |7;imaging-desaturate;94;94;94;94;94;94;94;95;95;95 11:58:07 INFO - PID 28882 | |8;json-parse-financial;53;54;54;55;55;54;55;53;55;58 11:58:07 INFO - PID 28882 | |9;json-stringify-tinderbox;38;38;38;39;38;39;38;40;39;39 11:58:07 INFO - PID 28882 | |10;stanford-crypto-aes;88;75;75;77;77;72;73;78;71;74 11:58:07 INFO - PID 28882 | |11;stanford-crypto-ccm;120;110;113;112;119;110;112;117;118;125 11:58:07 INFO - PID 28882 | |12;stanford-crypto-pbkdf2;167;164;165;166;165;170;166;168;171;174 11:58:07 INFO - PID 28882 | |13;stanford-crypto-sha256-iterative;69;65;74;64;66;69;64;66;69;71 11:58:07 INFO - PID 28882 | __end_tp_report 11:58:07 INFO - PID 28882 | __start_cc_report 11:58:07 INFO - PID 28882 | _x_x_mozilla_cycle_collect,776 11:58:07 INFO - PID 28882 | __end_cc_report 11:58:07 INFO - PID 28882 | __startTimestamp1506365887374__endTimestamp 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | ------- Summary: start ------- 11:58:07 INFO - PID 28882 | Number of tests: 14 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | [#0] ai-astar Cycles:10 Average:107.40 Median:107.00 stddev:1.07 (1.0%) stddev-sans-first:1.12 11:58:07 INFO - PID 28882 | Values: 108.0 107.0 107.0 107.0 107.0 110.0 108.0 107.0 107.0 106.0 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | [#1] audio-beat-detection Cycles:10 Average:118.40 Median:118.50 stddev:2.67 (2.3%) stddev-sans-first:2.83 11:58:07 INFO - PID 28882 | Values: 118.0 118.0 116.0 116.0 116.0 116.0 124.0 119.0 120.0 121.0 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:3.03 (1.9%) stddev-sans-first:3.22 11:58:07 INFO - PID 28882 | Values: 165.0 163.0 163.0 162.0 163.0 163.0 163.0 168.0 171.0 168.0 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | [#3] audio-fft Cycles:10 Average:75.10 Median:75.00 stddev:1.29 (1.7%) stddev-sans-first:1.30 11:58:07 INFO - PID 28882 | Values: 74.0 75.0 74.0 74.0 76.0 75.0 74.0 75.0 78.0 76.0 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | [#4] audio-oscillator Cycles:10 Average:80.00 Median:79.50 stddev:2.67 (3.4%) stddev-sans-first:2.80 11:58:07 INFO - PID 28882 | Values: 81.0 80.0 79.0 79.0 79.0 79.0 79.0 80.0 87.0 77.0 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 11:58:07 INFO - PID 28882 | Values: 114.0 113.0 115.0 113.0 114.0 113.0 114.0 115.0 114.0 115.0 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.89 (1.3%) stddev-sans-first:1.33 11:58:07 INFO - PID 28882 | Values: 153.0 147.0 148.0 148.0 150.0 148.0 149.0 151.0 149.0 147.0 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:58:07 INFO - PID 28882 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.43 (2.6%) stddev-sans-first:1.39 11:58:07 INFO - PID 28882 | Values: 53.0 54.0 54.0 55.0 55.0 54.0 55.0 53.0 55.0 58.0 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | [#9] json-stringify-tinderbox Cycles:10 Average:38.60 Median:39.00 stddev:0.70 (1.8%) stddev-sans-first:0.71 11:58:07 INFO - PID 28882 | Values: 38.0 38.0 38.0 39.0 38.0 39.0 38.0 40.0 39.0 39.0 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.00 stddev:4.78 (6.3%) stddev-sans-first:2.40 11:58:07 INFO - PID 28882 | Values: 88.0 75.0 75.0 77.0 77.0 72.0 73.0 78.0 71.0 74.0 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | [#11] stanford-crypto-ccm Cycles:10 Average:115.60 Median:117.50 stddev:4.97 (4.2%) stddev-sans-first:5.01 11:58:07 INFO - PID 28882 | Values: 120.0 110.0 113.0 112.0 119.0 110.0 112.0 117.0 118.0 125.0 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.60 Median:167.50 stddev:3.17 (1.9%) stddev-sans-first:3.35 11:58:07 INFO - PID 28882 | Values: 167.0 164.0 165.0 166.0 165.0 170.0 166.0 168.0 171.0 174.0 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:69.00 stddev:3.27 (4.7%) stddev-sans-first:3.43 11:58:07 INFO - PID 28882 | Values: 69.0 65.0 74.0 64.0 66.0 69.0 64.0 66.0 69.0 71.0 11:58:07 INFO - PID 28882 | -------- Summary: end -------- 11:58:07 INFO - PID 28882 | 11:58:07 INFO - PID 28882 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:58:07 INFO - TEST-INFO | 28882: exit 0 11:58:07 INFO - TEST-OK | kraken | took 61446ms 11:58:07 INFO - SUITE-END | took 1170s 11:58:08 INFO - Completed test suite (00:19:30) 11:58:08 INFO - javascript benchmark 11:58:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8667.254707111584, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3151.4169878572466, 3169.3978144152616, 3170.0489853044082, 3175.1427114679022, 3179.968200317998, 6259.405356491137, 6353.491720662348, 6362.968185159073, 6382.170317858678, 6479.384458476443, 6240.251169859612, 6240.43836054755, 6243.125962365272, 6297.18136642237, 6316.715747791349, 5818.476337129658, 5836.037053886103, 5863.237779088712, 5869.031609784381, 5880.794172203974, 5855.941440585582, 5863.237779088712, 5879.941200588003, 5935.673537955411, 6004.429579189992, 5795.304563452391, 5868.2664666916635, 5882.411758824105, 5885.20549725788, 5925.259342582177, 5685.40303268155, 5870.823875283749, 5873.148393482942, 5924.348321684612, 5987.9101813472835, 5726.083826587767, 5738.913916291259, 5751.396103409165, 5831.912521312183, 5874.089516125007, 6318.115463835067, 6334.3032266450655, 6351.809445716636, 6402.199725034371, 6434.903476447857, 6584.637844918528, 6665.233498147727, 6783.694733736994, 6789.796306110825, 6864.485163612699, 6864.450843932474, 6881.0, 6904.482163837682, 6946.513744037919, 6951.131108611424, 6166.537509686791, 6285.748570057147, 6347.206599175103, 6430.485561155143, 6432.839179020562, 6974.0585021022525, 7046.154461464657, 7069.823254418578, 7140.714371425085, 7144.249853765384, 6731.798046058626, 6737.52837301394, 6794.694238759268, 6832.521723479309, 6833.93166068333, 6651.0, 6736.2590115087305, 6774.153230846145, 6831.897521537181, 6924.376806087476, 6805.489588280899, 6808.9659551701925, 6819.590824550443, 6821.113255276881, 6826.317368263233, 6847.1783385994, 6854.794356169323, 6859.828504287333, 6864.0, 6868.210155832044, 5247.7113758743635, 5350.545203657655, 5384.6769193848495, 5395.865103372447, 5406.837794866082, 4567.269236922077, 4665.813367465331, 4711.0, 4724.267738500538, 4728.881777955578, 5727.656340619576, 5806.0, 5847.970760146172, 5851.648901065864, 5865.208196893364, 6848.938414545753, 6854.10896583441, 6907.7236910524025, 6936.583804971718, 6941.479389045841, 5806.332271788714, 5828.242328497353, 5881.264841894763, 5886.970565147232, 5907.911381329283, 5810.912836307459, 5817.825465236049, 5850.619709718854, 5880.647161170344, 5896.174535565025, 6574.638394888231, 6651.201855777241, 6687.732490700415, 6716.966415167893, 6722.394984451423, 6730.663466826737, 6833.897491537531, 6918.273581273894, 6925.480588955747, 6935.063766391472, 6606.8678626426245, 6620.337966203534, 6709.094272273181, 6723.125993620798, 6730.32696730323, 6598.670066496752, 6671.33286671329, 6698.531102822755, 6772.93227067723, 6792.9470932005615, 6836.794896153124, 6929.272426395156, 6943.0, 6948.583085014915, 6958.0, 6423.42189202974, 6480.060391243149, 6535.150430444012, 6586.242582103119, 6617.735290588323, 6629.171353580802, 6668.3331666834865, 6674.43267322283, 6696.531242812956, 6699.9665001674675, 6381.202349706286, 6482.611043337226, 6483.902741458787, 6514.348565143448, 6579.17760279965, 6548.607083575001, 6560.868782624416, 6612.735490580323, 6620.073189753534, 6643.966780166068, 6271.278802937538, 6298.1812364392335, 6347.682615869096, 6351.71417286214, 6412.39082287182], "value": 6204.618907042203, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [860.3676297921028, 879.9868001979976, 880.8238352329531, 882.2765332427408, 883.0418995390004, 38302.23395532091, 41754.0, 41944.37083443743, 41986.58013419869, 42018.15963680724, 38796.224075518476, 39291.803540982255, 39597.60402395975, 39703.80148099255, 39724.40413393801, 7171.7489887853935, 7269.127704675447, 7319.59742214178, 7327.523710958771, 7341.045664063664, 7200.927990720104, 7344.853102937938, 7353.227911069341, 7363.595002274873, 7374.262573742636, 7305.598192099433, 7329.5602263864075, 7336.0, 7908.44640875139, 8076.434649574532, 7936.5238085714755, 8018.719344822904, 8029.558374289411, 8045.0, 8051.154628763954, 7849.136594974549, 7942.0, 7973.760787176394, 7974.920250797534, 7977.56123413212, 38406.423903641466, 39328.0, 39362.80318598417, 39377.40933885994, 39473.0, 3519.560054993126, 3546.5744110706623, 3558.857645694169, 3565.750397472178, 3566.3937130687586, 32622.184445389055, 32760.836195819105, 32843.0, 32919.17702057444, 32939.6706032939, 5161.767720452551, 5169.0, 5186.0665080285535, 5192.636515443921, 5247.134222853225, 188565.0, 190348.0, 190624.0, 191106.0, 192443.0, 43955.0, 44604.330935036, 49449.50550494521, 49951.75024124929, 50750.0, 53237.7338113307, 53268.0, 53405.465945340824, 53490.46509534855, 53499.46500535023, 15208.543743687485, 15224.0, 15263.236838158047, 15301.9234903827, 15339.539813805604, 12246.387680615933, 12254.20347677398, 12276.38618069093, 12290.938545307396, 12360.134790564754, 14396.28018599066, 14527.636809079857, 14609.342579583732, 14618.926905365404, 14755.631109222355, 5966.522678185735, 5981.590493418709, 6021.0, 6032.366601506867, 6046.969765151234, 980.9509524523745, 1004.7086344960026, 1006.3207335048813, 1021.5964693945998, 1023.4064242739342, 22862.885685571797, 23184.884075579852, 23437.06251749945, 23517.0, 23703.7629623705, 1100.6863044032411, 1120.6301920366423, 1120.8991190792867, 1138.4478527913955, 1140.9087273018138, 12389.256644601353, 12482.50069997208, 12543.56097536582, 12577.559785407468, 12665.620031398888, 233844.0, 235100.0, 235693.0, 235902.0, 235982.0, 52888.471115288354, 53288.46711532913, 53410.73294633502, 53569.0, 53680.0, 1394.268009295108, 1460.2990564528873, 1462.166565057928, 1469.955901322962, 1477.534576608365, 22864.542709146055, 22896.885515572983, 23035.308940731804, 23131.07475700953, 23530.294091177293, 38006.23987520179, 38006.80996594999, 38035.809820950715, 38079.619203807604, 38095.0, 192533.0, 193524.0, 193961.0, 194227.0, 194891.0, 30710.539341910335, 30962.0, 31083.689163108986, 34646.13384665403, 34961.82519087388, 43312.783436083875, 43333.78333108441, 43902.12195756131, 44139.55860441354, 44701.32948005848, 32108.518372223967, 32175.35649287048, 32256.516152258206, 32345.0, 32604.51093233556, 31793.841030794698, 31950.68049319477, 32207.51688724718, 32286.35427291488, 32339.35321293608, 35626.28747425089, 35676.28647426985, 35784.46323305101, 36035.099122522144, 36083.63916360803, 30877.69122308748, 31380.215494612818, 31533.211669708442, 31576.842115789274, 32067.35865282728, 23325.650115248623, 23432.0, 23454.179103731287, 23737.388887222045, 23885.402864928517], "value": 17169.555496970228, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.4321629627411, 593.427342614377, 599.847039005054, 611.7614130489109, 613.6655522740106, 21736.782632173672, 22385.664215036788, 22410.775892241094, 22473.438164045907, 22510.099596016138, 23336.0, 24003.279901602935, 24980.0, 25062.0, 25145.119920802776, 6501.8374540636505, 6695.3304669533145, 6696.8995465068065, 6703.765368212114, 6705.329467053304, 6465.74137034518, 6587.341265873422, 6669.666516674171, 6693.364130407628, 6777.0173324867865, 6690.0, 6701.664916754167, 6705.0, 6706.195256569218, 6714.529982901199, 6653.53425260232, 6676.0, 6693.263740988487, 6706.0, 6733.696983635748, 6047.516198704093, 6277.089821975834, 6283.59156654816, 6300.968495157541, 6307.432331090224, 29302.974395896254, 29747.70252297471, 29774.255643608867, 29781.553276700866, 29834.850825745732, 2080.157536197842, 2101.5796840631933, 2105.1789801977243, 2106.220698341608, 2113.355426594888, 19383.709244361347, 19828.504287392785, 20012.69980950287, 20153.39539813808, 20174.899125504424, 2187.62810322244, 2233.419310979141, 2237.9328620141423, 2245.247841972941, 2255.5939930812447, 119356.20965685522, 127223.0, 136444.0, 144323.0, 145353.27323363422, 14654.43717923787, 14724.0, 15185.696286074217, 15189.0, 15851.0, 23928.641070383957, 23948.640770388458, 23993.760062399153, 24059.639105413433, 24095.156669516484, 9849.310548261696, 9990.200783937267, 10030.398176109456, 10076.0, 10157.542910569042, 8874.911250887408, 8950.552472376356, 8957.0, 9058.275337972946, 9072.228860546928, 9149.54252287383, 9244.90755092454, 9269.119433653792, 9395.671151509665, 9583.616655333848, 2644.140654287326, 2670.145553422925, 2731.6995130535624, 2796.51061064317, 2800.1879454958244, 940.1820416237916, 967.351874244258, 972.0862389354126, 975.882894052704, 976.6825781621002, 18899.149538270813, 19174.424767257005, 19221.231150753814, 19489.0, 19671.606567868563, 1030.855680204772, 1041.578160844859, 1044.159451641436, 1045.2839804733783, 1046.0899017854363, 10693.732656683489, 10743.0, 10750.569977200981, 10860.72848178786, 10977.725556861142, 456636.0, 463269.0, 466261.0, 467380.0, 470266.0, 109887.45056274667, 110058.0, 110442.0, 110653.0, 112059.0, 1046.6232156423682, 1107.180686292138, 1162.738383863624, 1165.9533618655328, 1217.4460620417865, 19998.70001950001, 20096.0, 20257.29099481511, 20313.187472501526, 20447.38657840267, 52638.0, 56225.718871407014, 56236.71881640566, 57028.144577830535, 57286.7135664319, 64994.0, 67093.0, 67176.0, 67449.66275168593, 68045.65977170083, 14237.786433203717, 14478.927605361905, 14514.274286285854, 14521.709565808836, 14533.418663253775, 21697.34907952764, 21907.561848762616, 21991.450213744145, 22214.111435542396, 22250.666240006736, 17643.20605572778, 17726.734098988785, 17978.190981405605, 18095.914245145334, 18126.093695315445, 15018.474353397578, 15550.61123471877, 16042.67914641724, 16446.917765411097, 16469.83530164731, 16597.25312360971, 17716.734248986533, 17732.734008989617, 18032.729509057637, 18040.09799509993, 14221.217833018869, 14275.0, 14279.42882284697, 14352.856471435152, 14357.282135892954, 17472.563185920455, 17507.0, 17718.0, 17889.552761180556, 18003.909980450015], "value": 11869.362078582242, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.9867001329987, 1369.9794503082449, 1376.7177728565646, 1381.7443772902009, 1385.425048604829, 15222.238888055594, 15940.84059159408, 15981.360745570179, 16009.119498427583, 16010.43963461279, 15602.21988900556, 15623.531294061168, 15732.449364272254, 15751.84248157518, 15779.842201577982, 2644.233172380012, 2779.749822515973, 2780.152053623644, 2781.276868014321, 2784.373515958903, 2658.1493921944984, 2711.6068170115323, 2727.5226835303843, 2729.8089133760645, 2730.2901245676167, 2382.4758553118286, 2472.0606169655507, 2477.331120597438, 2729.5359788835945, 2839.460502504528, 2748.7663548598393, 2786.317352248702, 2792.511310520661, 2802.873870675804, 2806.4387122575363, 2734.248081777507, 2744.6157537944705, 2762.406082692211, 2762.6270453488723, 2766.543520319145, 15332.310046047955, 15561.922190388976, 15568.61078473036, 15569.844301556952, 15586.0, 7887.881681774778, 8137.30832879206, 8202.917970820276, 8203.261706446448, 8218.342532597379, 5386.973065134688, 5499.202615620713, 5526.696031718254, 5740.540756739492, 5783.363829978699, 2020.7474065741783, 2029.3810387831707, 2029.776724560312, 2059.4027731957713, 2064.865783724068, 28285.85857070722, 28318.150455486368, 28321.575176372164, 28407.0, 28422.28944276389, 7351.22812104732, 7361.852762944711, 7473.813154671177, 7717.305442510201, 7731.884021739678, 20969.895150524455, 20990.370288891358, 21024.579508409744, 21041.15835366599, 21057.578848422945, 8647.481151130953, 8663.913360866436, 8666.523341216294, 8670.219680228809, 8670.566471676391, 7574.621268936531, 7589.241075892477, 7749.7287594933905, 7758.495697779626, 7817.0, 5703.857403564861, 5824.301083869963, 5875.441833025941, 6033.78881739137, 6146.969265153735, 1622.318626176985, 1740.781452982917, 1746.938857139994, 1773.671870703924, 1775.902325372117, 758.829263415727, 903.223228023899, 917.821024900138, 927.8149956851652, 941.9481928493861, 8773.166549177819, 8817.250533704579, 8884.37809353352, 8916.0, 8933.106689331145, 970.6651205334149, 1003.4280460137652, 1003.8243307421318, 1004.5027711282816, 1006.3911333643186, 4765.356676848581, 4802.975985120052, 4864.294677271847, 4885.169521181408, 4896.706197628154, 21699.13203471875, 22342.66486002711, 22482.651040937595, 22595.774042259694, 22816.771832281465, 21982.89008554979, 22031.449213769465, 22220.0, 22468.32595022152, 22792.772072279397, 11510.654680359603, 11601.883981160248, 11680.299182049104, 11685.883141168479, 11692.415379231004, 8748.47509149453, 8794.164554367326, 8795.0, 8839.779005524913, 8846.0, 18832.152553134867, 18898.14958326851, 19375.90312048431, 19462.221511139964, 19619.70570441473, 18586.349477768214, 19548.706769398756, 19618.803811961698, 19715.0, 19722.30971915976, 12092.334921579397, 12311.69220769488, 12415.875841241834, 12417.379131043232, 12423.378831058591, 14145.151290922578, 14182.078164919247, 14306.356213970188, 14317.85682143207, 14441.855581444472, 11275.210735248455, 11392.54429822831, 11609.709757255798, 11702.414879255834, 11784.469698863742, 11148.108151347711, 11253.71865703364, 11418.31490110596, 11558.364289964133, 11570.479328430409, 9505.477198754135, 10293.71328583927, 10300.639477618248, 10325.63860264887, 10331.94834025825, 7445.4415918805225, 7512.774616761506, 7517.812054698677, 7523.699052038076, 7524.736634217776, 7420.674516064787, 7460.664270107966, 7530.134034586093, 7563.130240022468, 7672.578008209602], "value": 6959.987083904502, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.1506179248109, 521.395181589356, 532.7496076843883, 539.6276569167275, 554.8668319603294, 6129.141920131179, 6170.598911070783, 6202.286737025243, 6242.656653884034, 6278.811635650926, 6137.508999280047, 6183.196184496021, 6215.658138802364, 6216.658083805389, 6226.40849119333, 5166.844994650148, 5169.793208271664, 5182.274481572564, 5190.896182076375, 5195.792168313263, 4919.311296418504, 5113.258577506259, 5153.742312884359, 5157.226416037587, 5188.184135552545, 4989.276554899556, 5049.444561098277, 5050.595952323805, 5061.228570000507, 5062.2406639004075, 4935.629827762897, 4963.932754457773, 5009.764795788392, 5043.193089105744, 5071.3153724247495, 4513.842015529441, 4516.096780643851, 4524.705894116872, 4536.0, 4543.659225558096, 6088.4215999479975, 6158.907616385758, 6184.288806787232, 6192.411720886554, 6270.65511396873, 5803.941960580382, 5814.592978491507, 5829.387914268983, 5831.650100993911, 5853.619514731528, 6525.380088891595, 6545.214574251073, 6559.2128944526485, 6606.834829129262, 6610.8016759497295, 4894.388201474816, 4933.55597996182, 4964.404271487409, 4981.27771473138, 4987.476314986947, 6529.771457998947, 6647.268800431901, 6898.344657257552, 6908.792736217922, 7016.36852683261, 5011.248312753116, 5022.397312322545, 5085.64400491962, 5087.338645976073, 5122.078025955289, 5075.365579302587, 5145.588352931756, 5155.32980712505, 5180.119379705459, 5191.299174611455, 5744.597878148489, 5756.366799652035, 5765.971170144207, 5801.216835727123, 5807.738651760681, 6658.833529161713, 6683.522040233055, 6697.497687673444, 6699.564528305645, 6700.262971073178, 1777.5644966982914, 1777.6889044417176, 1790.7761529808774, 1791.937282195117, 1798.3615816385256, 1169.9824502632466, 1243.5771837575269, 1250.693580072888, 1259.5843371687322, 1262.4760724299497, 5735.684537350486, 5757.424257574209, 5780.710964451845, 5805.332386775491, 5868.706564671749, 6846.281140480278, 6846.315368463213, 6854.451643868479, 6860.622665753432, 6920.792376228721, 5708.65748055118, 5738.68437235956, 5760.0, 5765.135229715576, 5804.506616937523, 3554.8400321985573, 3561.982190089033, 3584.1577229351083, 3586.497890295361, 3600.2979419013564, 5999.790007349722, 6501.187351581052, 6501.44737697301, 6531.804045878631, 6583.341665833378, 6721.4958878084335, 6803.353681400259, 6821.249662537117, 6854.280300568368, 6931.405776671293, 6355.330761080358, 6380.330065343165, 6543.869122617521, 6589.472842172615, 6607.768728094686, 6760.512687208806, 6812.318768123148, 6813.7955861324235, 6830.726770929107, 6839.1451068616425, 6664.900556324742, 6707.9267317229005, 6712.0, 6712.765053223114, 6714.959181326903, 6539.509536784665, 6562.407848899563, 6572.539922205399, 6584.934150658432, 6622.337766223339, 5059.367579052619, 5065.480355893291, 5080.568151707146, 5090.338256026693, 5111.974440127776, 6374.681265936777, 6636.336366363325, 6655.833604159741, 6787.423069039187, 6820.829479263058, 6327.873442531031, 6400.967995160181, 6459.321771213955, 6516.436055346778, 6576.210854697467, 6428.517861160525, 6510.860599395181, 6524.804255872332, 6529.379708927644, 6543.738250470118, 6329.461995730415, 6351.777687780906, 6426.614403135827, 6465.870682586228, 6506.4469520091325, 6457.257415397102, 6462.933615953315, 6506.772262970773, 6512.251091124582, 6563.310852360433, 6332.905006424815, 6407.8398040047505, 6412.839679008062, 6450.387213214737, 6455.193100862392], "value": 5096.549561786987, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [915.0803442540248, 929.8186853563558, 931.4085555672146, 934.5140526925994, 939.7932454859929, 20308.492287692796, 20387.796122038777, 20763.584728305425, 20780.16879324829, 20780.792192078075, 17534.29862805486, 17892.642147157083, 17894.5526361841, 17898.552536186602, 17926.103694815272, 971.2375785008769, 989.712983234861, 993.3741742702124, 998.1665309466604, 999.0, 934.2759361494828, 1003.2575893838543, 1015.7663737340416, 1017.9796404071914, 1021.9131373833196, 1065.8720953485554, 1068.1241382066708, 1069.3637285814928, 1070.9946450267737, 1072.1155047086147, 989.915857152143, 1031.283258135596, 1061.6231237910508, 1063.6224140430152, 1064.0795711709393, 760.444875241077, 765.1659690936906, 765.6210175962879, 765.8621448139332, 766.0768773627765, 20851.374458766262, 21087.894560527253, 21105.15579376823, 21202.787972120237, 21205.469863253387, 21628.243011494524, 22714.886425567933, 22796.0, 22802.999999999833, 22917.083316667315, 17770.644587108185, 18428.90785546064, 18460.53848653781, 18610.44168674942, 18636.906815465973, 3688.5758137814228, 3724.2737666155112, 3730.7015438764834, 3739.7943113128767, 3740.682042026431, 142139.0, 143693.0, 143946.0, 144508.2774586131, 146742.0, 16635.251413686412, 16862.57843553921, 17127.657446850993, 17132.0, 17246.0, 32892.50661240083, 33526.3294734104, 33577.160570985434, 33618.15954601154, 33627.0, 9089.863652045224, 9251.167394934353, 9348.532573371303, 9444.433333999981, 9451.621935122655, 4327.5239723630375, 4438.889027774267, 4441.0, 4442.8667139985855, 4444.511103778582, 5417.51242388187, 5420.566354691615, 5463.808766693147, 5489.231507588941, 5568.053430916673, 1007.6976906928039, 1022.3405903192399, 1037.5745944162857, 1040.2977989856815, 1042.7341028037802, 650.9283978762332, 664.6676661669165, 670.3865962644223, 679.2358596578849, 682.7849227493324, 11479.081673466102, 11497.770044599229, 12073.57742479009, 12587.992960563133, 12885.162464439782, 657.7796438193163, 664.7839452178061, 671.1241829412663, 672.9697163627551, 681.2676372899153, 5488.615796894179, 5501.504864562128, 5514.062609356419, 5537.1140617501005, 5588.524975377139, 124062.37968810098, 124796.0, 126724.0, 127668.36165819112, 130516.0, 109205.0, 110078.44960775145, 110608.0, 112111.0, 114140.42929785464, 94355.52822235982, 95200.0, 95256.52371738236, 97121.0, 98353.50823245838, 12547.0, 13042.869571304545, 13324.000699947348, 13416.932915335361, 13657.673507332347, 43416.13167736691, 43610.345844811716, 43801.0, 44426.333604996595, 44842.0, 58022.7098864503, 58253.708731457766, 58778.412215877295, 59510.70244648749, 59699.10451343146, 18562.350317738816, 18739.718904216174, 18766.906165469085, 18826.52933676669, 18852.0, 20984.0, 21110.261140859995, 21248.78751212468, 21255.36233912985, 21375.251866184608, 19723.901380493007, 19820.20719171217, 19960.3013894513, 19991.800081998994, 19991.900040499706, 18708.158132884324, 18994.620107597493, 19100.0, 19121.04394780283, 19157.61684766325, 17872.374466893598, 17996.10019499046, 18028.909855450638, 18032.098395080455, 18162.27350905949, 13269.203847769164, 13311.201327920357, 13625.591232263048, 13832.792508112185, 13854.584362469142, 14014.0, 14214.147151170962, 14293.57119286423, 14304.642383940485, 14358.353874075483], "value": 9451.012475561223, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1423.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 107.0, 107.0, 107.0, 107.0, 110.0, 108.0, 107.0, 107.0, 106.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 116.0, 116.0, 116.0, 116.0, 124.0, 119.0, 120.0, 121.0], "value": 118.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 162.0, 163.0, 163.0, 163.0, 168.0, 171.0, 168.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 74.0, 76.0, 75.0, 74.0, 75.0, 78.0, 76.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 79.0, 79.0, 79.0, 79.0, 80.0, 87.0, 77.0], "value": 80.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 113.0, 114.0, 113.0, 114.0, 115.0, 114.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 147.0, 148.0, 148.0, 150.0, 148.0, 149.0, 151.0, 149.0, 147.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 55.0, 55.0, 54.0, 55.0, 53.0, 55.0, 58.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 39.0, 38.0, 39.0, 38.0, 40.0, 39.0, 39.0], "value": 38.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 75.0, 75.0, 77.0, 77.0, 72.0, 73.0, 78.0, 71.0, 74.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 110.0, 113.0, 112.0, 119.0, 110.0, 112.0, 117.0, 118.0, 125.0], "value": 115.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 165.0, 166.0, 165.0, 170.0, 166.0, 168.0, 171.0, 174.0], "value": 167.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 74.0, 64.0, 66.0, 69.0, 64.0, 66.0, 69.0, 71.0], "value": 67.7, "unit": "score"}]}]} 11:58:08 INFO - Return code: 0 11:58:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:58:08 INFO - # TBPL SUCCESS # 11:58:08 INFO - Running post-action listener: _package_coverage_data 11:58:08 INFO - Running post-action listener: _resource_record_post_action 11:58:08 INFO - [mozharness: 2017-09-25 18:58:08.153890Z] Finished run-tests step (success) 11:58:08 INFO - Running post-run listener: _resource_record_post_run 11:58:08 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 28672; Write bytes: 344571904; Read time: 236; Write time: 213196 11:58:08 INFO - TinderboxPrint: CPU usage
13.1% 11:58:08 INFO - TinderboxPrint: I/O read bytes / time
28,672 / 236 11:58:08 INFO - TinderboxPrint: I/O write bytes / time
344,571,904 / 213,196 11:58:08 INFO - TinderboxPrint: CPU idle
8,234.9 (86.9%) 11:58:08 INFO - TinderboxPrint: CPU user
1,194.4 (12.6%) 11:58:08 INFO - TinderboxPrint: Swap in / out
0 / 0 11:58:08 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13443072; Read time: 0; Write time: 1036 11:58:08 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:58:08 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 24576; Write bytes: 331128832; Read time: 220; Write time: 212160 11:58:08 INFO - Running post-run listener: _upload_blobber_files 11:58:08 INFO - Blob upload gear active. 11:58:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:58:08 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 11:58:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:58:09 INFO - (blobuploader) - INFO - Open directory for files ... 11:58:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 11:58:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 11:58:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:10 INFO - (blobuploader) - INFO - Done attempting. 11:58:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:58:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:58:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:11 INFO - (blobuploader) - INFO - Done attempting. 11:58:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:58:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:58:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:17 INFO - (blobuploader) - INFO - Done attempting. 11:58:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 11:58:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 11:58:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:18 INFO - (blobuploader) - INFO - Done attempting. 11:58:18 INFO - (blobuploader) - INFO - Iteration through files over. 11:58:18 INFO - Return code: 0 11:58:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:58:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:58:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0ad186c34b7d9b24e82dcc5c5874245ccb494bc78a1afdcba1a32d28d8473f4dd8279e2eb06a5af1235e9e6c0c2b09b63d315293c62e7f259f9755b9a579a2c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee432d675951f2961600297dc1fe1083e3f592de4c0c77377536d2827acbb2aeb458b16c4727019d819715653690f0797763f6171bed33b88fd53566cd6dd87b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5a63239c2e6741b0758b2d49a4728c7c1cd82622c6040ea88b58db142b2554c64e257094d0cae18db321fc1e85810dc76007f4a9ebd41e2a5a4e5c1caf6ef31", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b3210560d636333aabc03ec27bb4e660a636df9e7323600523578ed4555dd48b83a595887f639b0a4422f4fcf3986b2e22213a477b3f2dfbe2de01decb735a64"} 11:58:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:58:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:58:18 INFO - Contents: 11:58:18 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0ad186c34b7d9b24e82dcc5c5874245ccb494bc78a1afdcba1a32d28d8473f4dd8279e2eb06a5af1235e9e6c0c2b09b63d315293c62e7f259f9755b9a579a2c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee432d675951f2961600297dc1fe1083e3f592de4c0c77377536d2827acbb2aeb458b16c4727019d819715653690f0797763f6171bed33b88fd53566cd6dd87b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5a63239c2e6741b0758b2d49a4728c7c1cd82622c6040ea88b58db142b2554c64e257094d0cae18db321fc1e85810dc76007f4a9ebd41e2a5a4e5c1caf6ef31", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b3210560d636333aabc03ec27bb4e660a636df9e7323600523578ed4555dd48b83a595887f639b0a4422f4fcf3986b2e22213a477b3f2dfbe2de01decb735a64"} 11:58:18 INFO - Running post-run listener: copy_logs_to_upload_dir 11:58:18 INFO - Copying logs to upload dir... 11:58:18 INFO - mkdir: /builds/slave/test/build/upload/logs 11:58:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.097635 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-25 11:58:18.297665) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 11:58:18.301254) ========= 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=d2a8c569965ab8367867b893000001a1-1506364656.295797-181348894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0ad186c34b7d9b24e82dcc5c5874245ccb494bc78a1afdcba1a32d28d8473f4dd8279e2eb06a5af1235e9e6c0c2b09b63d315293c62e7f259f9755b9a579a2c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee432d675951f2961600297dc1fe1083e3f592de4c0c77377536d2827acbb2aeb458b16c4727019d819715653690f0797763f6171bed33b88fd53566cd6dd87b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5a63239c2e6741b0758b2d49a4728c7c1cd82622c6040ea88b58db142b2554c64e257094d0cae18db321fc1e85810dc76007f4a9ebd41e2a5a4e5c1caf6ef31", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b3210560d636333aabc03ec27bb4e660a636df9e7323600523578ed4555dd48b83a595887f639b0a4422f4fcf3986b2e22213a477b3f2dfbe2de01decb735a64"} build_url:https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011462 build_url: 'https://queue.taskcluster.net/v1/task/DFwEF9UYSvOCRfO3WdTOSw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0ad186c34b7d9b24e82dcc5c5874245ccb494bc78a1afdcba1a32d28d8473f4dd8279e2eb06a5af1235e9e6c0c2b09b63d315293c62e7f259f9755b9a579a2c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee432d675951f2961600297dc1fe1083e3f592de4c0c77377536d2827acbb2aeb458b16c4727019d819715653690f0797763f6171bed33b88fd53566cd6dd87b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5a63239c2e6741b0758b2d49a4728c7c1cd82622c6040ea88b58db142b2554c64e257094d0cae18db321fc1e85810dc76007f4a9ebd41e2a5a4e5c1caf6ef31", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b3210560d636333aabc03ec27bb4e660a636df9e7323600523578ed4555dd48b83a595887f639b0a4422f4fcf3986b2e22213a477b3f2dfbe2de01decb735a64"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 11:58:18.329389) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 11:58:18.329712) ========= 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=d2a8c569965ab8367867b893000001a1-1506364656.295797-181348894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 11:58:18.414940) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 11:58:18.415247) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 11:58:18.416659) ========= ========= Total master_lag: 0.26 =========