builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-088 starttime: 1504958711.62 results: success (0) revision: 2a9cffb19ab58a7875aee5492c565c549c037511 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 05:05:11.621852) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 05:05:11.622338) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 05:05:11.622618) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 05:05:11.652544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 05:05:11.652948) ========= 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=9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-09 05:05:11-- 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% 226M=0s 2017-09-09 05:05:11 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.202069 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 05:05:11.883953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 05:05:11.884283) ========= 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=9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.044525 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 05:05:11.943961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 05:05:11.944294) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2a9cffb19ab58a7875aee5492c565c549c037511 --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 2a9cffb19ab58a7875aee5492c565c549c037511 --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=9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-09 05:05:11,924 truncating revision to first 12 chars 2017-09-09 05:05:11,924 Setting DEBUG logging. 2017-09-09 05:05:11,924 attempt 1/10 2017-09-09 05:05:11,924 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2a9cffb19ab5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-09 05:05:12,345 unpacking tar archive at: mozilla-central-2a9cffb19ab5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695800 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 05:05:12.659616) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 05:05:12.663002) ========= script_repo_revision: 2a9cffb19ab58a7875aee5492c565c549c037511 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 05:05:12.663451) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 05:05:12.663715) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 05:05:12.677215) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-09 05:05:12.677595) ========= /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=9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:05:12 INFO - MultiFileLogger online at 20170909 05:05:12 in /builds/slave/test 05:05:12 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 05:05:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:05:12 INFO - {'append_to_log': False, 05:05:12 INFO - 'base_work_dir': '/builds/slave/test', 05:05:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:05:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:05:12 INFO - 'branch': 'Firefox-Non-PGO', 05:05:12 INFO - 'buildbot_json_path': 'buildprops.json', 05:05:12 INFO - 'code_coverage': False, 05:05:12 INFO - 'config_files': ('talos/linux_config.py',), 05:05:12 INFO - 'default_actions': ('clobber', 05:05:12 INFO - 'read-buildbot-config', 05:05:12 INFO - 'download-and-extract', 05:05:12 INFO - 'populate-webroot', 05:05:12 INFO - 'create-virtualenv', 05:05:12 INFO - 'install', 05:05:12 INFO - 'setup-mitmproxy', 05:05:12 INFO - 'run-tests'), 05:05:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:05:12 INFO - 'disable_ccov_upload': False, 05:05:12 INFO - 'disable_stylo': False, 05:05:12 INFO - 'download_minidump_stackwalk': True, 05:05:12 INFO - 'download_symbols': 'ondemand', 05:05:12 INFO - 'enable_stylo': False, 05:05:12 INFO - 'enable_webrender': False, 05:05:12 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:05:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:05:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:05:12 INFO - 'gecko_profile': False, 05:05:12 INFO - 'gecko_profile_interval': 0, 05:05:12 INFO - 'installer_path': 'installer.exe', 05:05:12 INFO - 'log_level': 'info', 05:05:12 INFO - 'log_name': 'talos', 05:05:12 INFO - 'log_to_console': True, 05:05:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:05:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:05:12 INFO - 'opt_config_files': (), 05:05:12 INFO - 'pip_index': False, 05:05:12 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 05:05:12 INFO - 'system_bits': '32', 05:05:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:05:12 INFO - 'title': 'talos-linux64-ix-088', 05:05:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:05:12 INFO - 'use_talos_json': True, 05:05:12 INFO - 'verify': 'False', 05:05:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:05:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:05:12 INFO - 'work_dir': 'build'} 05:05:12 INFO - [mozharness: 2017-09-09 12:05:12.935541Z] Running clobber step. 05:05:12 INFO - Running pre-action listener: _resource_record_pre_action 05:05:12 INFO - Running main action method: clobber 05:05:12 INFO - rmtree: /builds/slave/test/build 05:05:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:05:13 INFO - Running post-action listener: _resource_record_post_action 05:05:13 INFO - [mozharness: 2017-09-09 12:05:13.916796Z] Finished clobber step (success) 05:05:13 INFO - [mozharness: 2017-09-09 12:05:13.916892Z] Running read-buildbot-config step. 05:05:13 INFO - Running pre-action listener: _resource_record_pre_action 05:05:13 INFO - Running main action method: read_buildbot_config 05:05:13 INFO - Using buildbot properties: 05:05:13 INFO - { 05:05:13 INFO - "project": "", 05:05:13 INFO - "product": "firefox", 05:05:13 INFO - "who": "archaeopteryx@coole-files.de", 05:05:13 INFO - "installer_path": "public/build/target.tar.bz2", 05:05:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 05:05:13 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:05:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 05:05:13 INFO - "stage_platform": "linux64", 05:05:13 INFO - "basedir": "/builds/slave/test", 05:05:13 INFO - "buildnumber": 5, 05:05:13 INFO - "platform": "ubuntu64_hw", 05:05:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:05:13 INFO - "slavebuilddir": "test", 05:05:13 INFO - "taskId": "P1tNTQDORyaqVGOMUiOYNQ", 05:05:13 INFO - "branch": "mozilla-central", 05:05:13 INFO - "script_repo_revision": "production", 05:05:13 INFO - "revision": "2a9cffb19ab58a7875aee5492c565c549c037511", 05:05:13 INFO - "slavename": "talos-linux64-ix-088", 05:05:13 INFO - "repo_path": "mozilla-central" 05:05:13 INFO - } 05:05:13 INFO - Finding installer, test and symbols from parent task. 05:05:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P1tNTQDORyaqVGOMUiOYNQ'}, attempt #1 05:05:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P1tNTQDORyaqVGOMUiOYNQ'}, attempt #1 05:05:14 INFO - Task dependencies: dkh--l4YT16D-V81XBCmig 05:05:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig'}, attempt #1 05:05:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.tar.bz2 05:05:15 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.test_packages.json 05:05:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.crashreporter-symbols.zip 05:05:15 INFO - Running post-action listener: _resource_record_post_action 05:05:15 INFO - [mozharness: 2017-09-09 12:05:15.292773Z] Finished read-buildbot-config step (success) 05:05:15 INFO - [mozharness: 2017-09-09 12:05:15.292990Z] Running download-and-extract step. 05:05:15 INFO - Running pre-action listener: _resource_record_pre_action 05:05:15 INFO - Running main action method: download_and_extract 05:05:15 INFO - mkdir: /builds/slave/test/build/tests 05:05: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')]} 05:05:15 INFO - trying https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.test_packages.json 05:05:15 INFO - Downloading https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:05:15 INFO - Downloaded 989 bytes. 05:05:15 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:05:15 INFO - Using the following test package requirements: 05:05:15 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:05:15 INFO - u'common': [u'target.common.tests.zip'], 05:05:15 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:05:15 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:05:15 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:05:15 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:05:15 INFO - u'mozbase': [u'target.common.tests.zip'], 05:05:15 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:05:15 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:05:15 INFO - u'web-platform': [u'target.common.tests.zip', 05:05:15 INFO - u'target.web-platform.tests.tar.gz'], 05:05:15 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:05:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 05:05:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.common.tests.zip 05:05:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:05:15 INFO - Fetch https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.common.tests.zip into memory 05:05:16 INFO - Content-Length response header: 55024817 05:05:16 INFO - Bytes received: 55024817 05:05:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.talos.tests.zip 05:05:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:05:27 INFO - Fetch https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.talos.tests.zip into memory 05:05:28 INFO - Content-Length response header: 14497963 05:05:28 INFO - Bytes received: 14497963 05:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:28 INFO - trying https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.tar.bz2 05:05:28 INFO - Downloading https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:05:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:05:29 INFO - Downloaded 62941160 bytes. 05:05:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.tar.bz2 05:05:29 INFO - mkdir: /builds/slave/test/properties 05:05:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:05:29 INFO - Writing to file /builds/slave/test/properties/build_url 05:05:29 INFO - Contents: 05:05:29 INFO - build_url:https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.tar.bz2 05:05:29 INFO - Running post-action listener: _resource_record_post_action 05:05:29 INFO - Running post-action listener: find_tests_for_verification 05:05:29 INFO - Running post-action listener: set_extra_try_arguments 05:05:29 INFO - [mozharness: 2017-09-09 12:05:29.847736Z] Finished download-and-extract step (success) 05:05:29 INFO - [mozharness: 2017-09-09 12:05:29.847851Z] Running populate-webroot step. 05:05:29 INFO - Running pre-action listener: _resource_record_pre_action 05:05:29 INFO - Running main action method: populate_webroot 05:05:29 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:05:29 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:05:29 INFO - 'tests': ['tresize', 05:05:29 INFO - 'tcanvasmark']}, 05:05:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:05:29 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:05:29 INFO - 'tests': ['dromaeo_css', 05:05:29 INFO - 'kraken']}, 05:05:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:05:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:29 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:05:29 INFO - 'talos_options': ['--disable-stylo'], 05:05:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:05:29 INFO - 'tests': ['damp', 'tps']}, 05:05:29 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:05:29 INFO - 'talos_options': ['--disable-stylo'], 05:05:29 INFO - 'tests': ['damp', 'tps']}, 05:05:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:05:29 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:05:29 INFO - 'tests': ['dromaeo_dom']}, 05:05:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:05:29 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:05:29 INFO - 'tests': ['basic_compositor_video', 05:05:29 INFO - 'glvideo']}, 05:05:29 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:05:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:05:29 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:05:29 INFO - 'talos_options': ['--disable-stylo'], 05:05:29 INFO - 'tests': ['ts_paint_webext', 05:05:29 INFO - 'tp5o_webext']}, 05:05:29 INFO - 'other-e10s': {'tests': ['a11yr', 05:05:29 INFO - 'ts_paint', 05:05:29 INFO - 'tpaint', 05:05:29 INFO - 'sessionrestore', 05:05:29 INFO - 'sessionrestore_many_windows', 05:05:29 INFO - 'sessionrestore_no_auto_restore', 05:05:29 INFO - 'tabpaint']}, 05:05:29 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:05:29 INFO - 'tests': ['a11yr', 05:05:29 INFO - 'ts_paint', 05:05:29 INFO - 'tpaint', 05:05:29 INFO - 'sessionrestore', 05:05:29 INFO - 'sessionrestore_many_windows', 05:05:29 INFO - 'sessionrestore_no_auto_restore', 05:05:29 INFO - 'tabpaint']}, 05:05:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:05:29 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:05:29 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:05:29 INFO - 'tests': ['bloom_basic_singleton']}, 05:05:29 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:05:29 INFO - 'tests': ['bloom_basic']}, 05:05:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:05:29 INFO - 'tsvgr_opacity', 05:05:29 INFO - 'tart', 05:05:29 INFO - 'tscrollx', 05:05:29 INFO - 'tsvg_static']}, 05:05:29 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:05:29 INFO - 'tests': ['tsvgx', 05:05:29 INFO - 'tsvgr_opacity', 05:05:29 INFO - 'tart', 05:05:29 INFO - 'tscrollx', 05:05:29 INFO - 'tsvg_static']}, 05:05:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:05:29 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:05:29 INFO - 'talos_options': ['--disable-stylo'], 05:05:29 INFO - 'tests': ['tp5o']}, 05:05:29 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:05:29 INFO - 'talos_options': ['--mitmproxy', 05:05:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:05:29 INFO - '--firstNonBlankPaint'], 05:05:29 INFO - 'tests': ['tp6_google', 05:05:29 INFO - 'tp6_youtube', 05:05:29 INFO - 'tp6_amazon', 05:05:29 INFO - 'tp6_facebook']}, 05:05:29 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:05:29 INFO - 'talos_options': ['--disable-stylo', 05:05:29 INFO - '--mitmproxy', 05:05:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:05:29 INFO - '--firstNonBlankPaint'], 05:05:29 INFO - 'tests': ['tp6_google', 05:05:29 INFO - 'tp6_youtube', 05:05:29 INFO - 'tp6_amazon', 05:05:29 INFO - 'tp6_facebook']}, 05:05:29 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:05:29 INFO - 'talos_options': ['--stylo-threads=1', 05:05:29 INFO - '--mitmproxy', 05:05:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:05:29 INFO - '--firstNonBlankPaint'], 05:05:29 INFO - 'tests': ['tp6_google', 05:05:29 INFO - 'tp6_youtube', 05:05:29 INFO - 'tp6_amazon', 05:05:29 INFO - 'tp6_facebook']}, 05:05:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:05:29 INFO - 'talos_options': ['--xperf_path', 05:05:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:29 INFO - 'tests': ['tp5n']}, 05:05:29 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:05:29 INFO - 'talos_options': ['--disable-stylo', 05:05:29 INFO - '--xperf_path', 05:05:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:29 INFO - 'tests': ['tp5n']}}} 05:05:29 INFO - Running post-action listener: _resource_record_post_action 05:05:29 INFO - [mozharness: 2017-09-09 12:05:29.862836Z] Finished populate-webroot step (success) 05:05:29 INFO - [mozharness: 2017-09-09 12:05:29.862925Z] Running create-virtualenv step. 05:05:29 INFO - Running pre-action listener: _resource_record_pre_action 05:05:29 INFO - Running main action method: create_virtualenv 05:05:29 INFO - Creating virtualenv /builds/slave/test/build/venv 05:05:29 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:05:29 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:05:29 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:05:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:05:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:05:30 INFO - Installing distribute.............................................................................................................................................................................................done. 05:05:31 INFO - Installing pip...............done. 05:05:31 INFO - Return code: 0 05:05:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:05:31 INFO - Reading from file tmpfile_stdout 05:05:31 INFO - Output received: 05:05:31 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:05:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:31 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 0x1b5c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc090>, '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 0x1eccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', '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 05:05:31 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 05:05:31 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 05:05:31 INFO - Using env: {'DISPLAY': ':0', 05:05:31 INFO - 'HOME': '/home/cltbld', 05:05:31 INFO - 'LANG': 'en_US.UTF-8', 05:05:31 INFO - 'LANGUAGE': 'en_US:en', 05:05:31 INFO - 'LOGNAME': 'cltbld', 05:05:31 INFO - 'MAIL': '/var/mail/cltbld', 05:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:31 INFO - 'MOZ_NO_REMOTE': '1', 05:05:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:31 INFO - 'NO_EM_RESTART': '1', 05:05:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:31 INFO - 'PWD': '/builds/slave/test', 05:05:31 INFO - 'SHELL': '/bin/bash', 05:05:31 INFO - 'SHLVL': '1', 05:05:31 INFO - 'TERM': 'linux', 05:05:31 INFO - 'TMOUT': '86400', 05:05:31 INFO - 'USER': 'cltbld', 05:05:31 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', 05:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:31 INFO - '_': '/tools/buildbot/bin/python'} 05:05:32 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:05:32 INFO - Downloading/unpacking pip>=1.5 05:05:32 INFO - Running setup.py egg_info for package pip 05:05:32 INFO - warning: no files found matching 'pip/cacert.pem' 05:05:32 INFO - warning: no files found matching '*.html' under directory 'docs' 05:05:32 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:05:32 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:05:32 INFO - Installing collected packages: pip 05:05:32 INFO - Found existing installation: pip 1.1 05:05:32 INFO - Uninstalling pip: 05:05:32 INFO - Successfully uninstalled pip 05:05:32 INFO - Running setup.py install for pip 05:05:32 INFO - warning: no files found matching 'pip/cacert.pem' 05:05:32 INFO - warning: no files found matching '*.html' under directory 'docs' 05:05:32 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:05:32 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:05:32 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Successfully installed pip 05:05:32 INFO - Cleaning up... 05:05:32 INFO - Return code: 0 05:05:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:05:32 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')]} 05:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:32 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')]} 05:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:32 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 0x1b5c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc090>, '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 0x1eccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', '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 05:05:32 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 05:05:32 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 05:05:32 INFO - Using env: {'DISPLAY': ':0', 05:05:32 INFO - 'HOME': '/home/cltbld', 05:05:32 INFO - 'LANG': 'en_US.UTF-8', 05:05:32 INFO - 'LANGUAGE': 'en_US:en', 05:05:32 INFO - 'LOGNAME': 'cltbld', 05:05:32 INFO - 'MAIL': '/var/mail/cltbld', 05:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:32 INFO - 'MOZ_NO_REMOTE': '1', 05:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:32 INFO - 'NO_EM_RESTART': '1', 05:05:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:32 INFO - 'PWD': '/builds/slave/test', 05:05:32 INFO - 'SHELL': '/bin/bash', 05:05:32 INFO - 'SHLVL': '1', 05:05:32 INFO - 'TERM': 'linux', 05:05:32 INFO - 'TMOUT': '86400', 05:05:32 INFO - 'USER': 'cltbld', 05:05:32 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', 05:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:32 INFO - '_': '/tools/buildbot/bin/python'} 05:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:32 INFO - Downloading/unpacking psutil>=3.1.1 05:05:32 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 05:05:32 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 05:05:32 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 05:05:32 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 05:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:05:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:34 INFO - Installing collected packages: psutil 05:05:34 INFO - Running setup.py install for psutil 05:05:34 INFO - building 'psutil._psutil_linux' extension 05:05:34 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 05:05:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:05:36 INFO - building 'psutil._psutil_posix' extension 05:05:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:05:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:05:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:36 INFO - Successfully installed psutil 05:05:36 INFO - Cleaning up... 05:05:37 INFO - Return code: 0 05:05:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:05:37 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')]} 05:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:37 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')]} 05:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:37 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 0x1b5c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc090>, '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 0x1eccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', '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 05:05:37 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 05:05:37 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 05:05:37 INFO - Using env: {'DISPLAY': ':0', 05:05:37 INFO - 'HOME': '/home/cltbld', 05:05:37 INFO - 'LANG': 'en_US.UTF-8', 05:05:37 INFO - 'LANGUAGE': 'en_US:en', 05:05:37 INFO - 'LOGNAME': 'cltbld', 05:05:37 INFO - 'MAIL': '/var/mail/cltbld', 05:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:37 INFO - 'MOZ_NO_REMOTE': '1', 05:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:37 INFO - 'NO_EM_RESTART': '1', 05:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:37 INFO - 'PWD': '/builds/slave/test', 05:05:37 INFO - 'SHELL': '/bin/bash', 05:05:37 INFO - 'SHLVL': '1', 05:05:37 INFO - 'TERM': 'linux', 05:05:37 INFO - 'TMOUT': '86400', 05:05:37 INFO - 'USER': 'cltbld', 05:05:37 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', 05:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:37 INFO - '_': '/tools/buildbot/bin/python'} 05:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:05:37 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 05:05:37 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 05:05:37 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 05:05:37 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 05:05:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:05:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:05:38 INFO - Installing collected packages: mozsystemmonitor 05:05:38 INFO - Running setup.py install for mozsystemmonitor 05:05:38 INFO - Successfully installed mozsystemmonitor 05:05:38 INFO - Cleaning up... 05:05:38 INFO - Return code: 0 05:05:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:05:38 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')]} 05:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:38 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')]} 05:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:38 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 0x1b5c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc090>, '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 0x1eccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', '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 05:05:38 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 05:05:38 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 05:05:38 INFO - Using env: {'DISPLAY': ':0', 05:05:38 INFO - 'HOME': '/home/cltbld', 05:05:38 INFO - 'LANG': 'en_US.UTF-8', 05:05:38 INFO - 'LANGUAGE': 'en_US:en', 05:05:38 INFO - 'LOGNAME': 'cltbld', 05:05:38 INFO - 'MAIL': '/var/mail/cltbld', 05:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:38 INFO - 'MOZ_NO_REMOTE': '1', 05:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:38 INFO - 'NO_EM_RESTART': '1', 05:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:38 INFO - 'PWD': '/builds/slave/test', 05:05:38 INFO - 'SHELL': '/bin/bash', 05:05:38 INFO - 'SHLVL': '1', 05:05:38 INFO - 'TERM': 'linux', 05:05:38 INFO - 'TMOUT': '86400', 05:05:38 INFO - 'USER': 'cltbld', 05:05:38 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', 05:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:38 INFO - '_': '/tools/buildbot/bin/python'} 05:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:38 INFO - Downloading/unpacking jsonschema==2.5.1 05:05:38 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 05:05:38 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 05:05:38 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 05:05:38 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 05:05:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:05:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:39 INFO - Downloading functools32-3.2.3-2.tar.gz 05:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:05:40 INFO - warning: no files found matching '*.txt' 05:05:40 INFO - no previously-included directories found matching 'build' 05:05:40 INFO - no previously-included directories found matching 'dist' 05:05:40 INFO - no previously-included directories found matching '.git*' 05:05:40 INFO - Installing collected packages: jsonschema, functools32 05:05:40 INFO - Running setup.py install for functools32 05:05:40 INFO - warning: no files found matching '*.txt' 05:05:40 INFO - no previously-included directories found matching 'build' 05:05:40 INFO - no previously-included directories found matching 'dist' 05:05:40 INFO - no previously-included directories found matching '.git*' 05:05:40 INFO - Successfully installed jsonschema functools32 05:05:40 INFO - Cleaning up... 05:05:40 INFO - Return code: 0 05:05:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b5c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc090>, '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 0x1eccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', '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 05:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:05:40 INFO - Using env: {'DISPLAY': ':0', 05:05:40 INFO - 'HOME': '/home/cltbld', 05:05:40 INFO - 'LANG': 'en_US.UTF-8', 05:05:40 INFO - 'LANGUAGE': 'en_US:en', 05:05:40 INFO - 'LOGNAME': 'cltbld', 05:05:40 INFO - 'MAIL': '/var/mail/cltbld', 05:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:40 INFO - 'MOZ_NO_REMOTE': '1', 05:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:40 INFO - 'NO_EM_RESTART': '1', 05:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:40 INFO - 'PWD': '/builds/slave/test', 05:05:40 INFO - 'SHELL': '/bin/bash', 05:05:40 INFO - 'SHLVL': '1', 05:05:40 INFO - 'TERM': 'linux', 05:05:40 INFO - 'TMOUT': '86400', 05:05:40 INFO - 'USER': 'cltbld', 05:05:40 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', 05:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:40 INFO - '_': '/tools/buildbot/bin/python'} 05:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:05:40 INFO - Cleaning up... 05:05:40 INFO - Return code: 0 05:05:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b5c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc090>, '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 0x1eccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', '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 05:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:05:40 INFO - Using env: {'DISPLAY': ':0', 05:05:40 INFO - 'HOME': '/home/cltbld', 05:05:40 INFO - 'LANG': 'en_US.UTF-8', 05:05:40 INFO - 'LANGUAGE': 'en_US:en', 05:05:40 INFO - 'LOGNAME': 'cltbld', 05:05:40 INFO - 'MAIL': '/var/mail/cltbld', 05:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:40 INFO - 'MOZ_NO_REMOTE': '1', 05:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:40 INFO - 'NO_EM_RESTART': '1', 05:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:40 INFO - 'PWD': '/builds/slave/test', 05:05:40 INFO - 'SHELL': '/bin/bash', 05:05:40 INFO - 'SHLVL': '1', 05:05:40 INFO - 'TERM': 'linux', 05:05:40 INFO - 'TMOUT': '86400', 05:05:40 INFO - 'USER': 'cltbld', 05:05:40 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', 05:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:40 INFO - '_': '/tools/buildbot/bin/python'} 05:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:40 INFO - Downloading/unpacking blobuploader==1.2.4 05:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:41 INFO - Downloading blobuploader-1.2.4.tar.gz 05:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:05:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:05:41 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 05:05:41 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 05:05:41 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 05:05:41 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 05:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:05:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:42 INFO - Downloading docopt-0.6.1.tar.gz 05:05:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:05:42 INFO - Installing collected packages: blobuploader, requests, docopt 05:05:42 INFO - Running setup.py install for blobuploader 05:05:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:05:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:05:42 INFO - Running setup.py install for requests 05:05:42 INFO - Running setup.py install for docopt 05:05:42 INFO - Successfully installed blobuploader requests docopt 05:05:42 INFO - Cleaning up... 05:05:42 INFO - Return code: 0 05:05:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05: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')]} 05:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05: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')]} 05:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:42 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 0x1b5c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc090>, '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 0x1eccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', '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 05:05:42 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 05:05:42 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 05:05:42 INFO - Using env: {'DISPLAY': ':0', 05:05:42 INFO - 'HOME': '/home/cltbld', 05:05:42 INFO - 'LANG': 'en_US.UTF-8', 05:05:42 INFO - 'LANGUAGE': 'en_US:en', 05:05:42 INFO - 'LOGNAME': 'cltbld', 05:05:42 INFO - 'MAIL': '/var/mail/cltbld', 05:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:42 INFO - 'MOZ_NO_REMOTE': '1', 05:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:42 INFO - 'NO_EM_RESTART': '1', 05:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:42 INFO - 'PWD': '/builds/slave/test', 05:05:42 INFO - 'SHELL': '/bin/bash', 05:05:42 INFO - 'SHLVL': '1', 05:05:42 INFO - 'TERM': 'linux', 05:05:42 INFO - 'TMOUT': '86400', 05:05:42 INFO - 'USER': 'cltbld', 05:05:42 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', 05:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:42 INFO - '_': '/tools/buildbot/bin/python'} 05:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:43 INFO - Running setup.py (path:/tmp/pip-vIiCRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:43 INFO - Running setup.py (path:/tmp/pip-xqCBa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:43 INFO - Running setup.py (path:/tmp/pip-lvKW3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:43 INFO - Running setup.py (path:/tmp/pip-TrAM71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:43 INFO - Running setup.py (path:/tmp/pip-X6jc1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:43 INFO - Running setup.py (path:/tmp/pip-0iwsug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:43 INFO - Running setup.py (path:/tmp/pip-Kjaleh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:43 INFO - Running setup.py (path:/tmp/pip-PQjwEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:43 INFO - Running setup.py (path:/tmp/pip-7YaX7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:43 INFO - Running setup.py (path:/tmp/pip-S5am8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:43 INFO - Running setup.py (path:/tmp/pip-NAoc0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:43 INFO - Running setup.py (path:/tmp/pip-GF5XXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:43 INFO - Running setup.py (path:/tmp/pip-3uX7Q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:44 INFO - Running setup.py (path:/tmp/pip-TYd6Uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:44 INFO - Running setup.py (path:/tmp/pip-qpAewB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:44 INFO - Running setup.py (path:/tmp/pip-g5K3ZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:44 INFO - Running setup.py (path:/tmp/pip-KgEOnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:05:44 INFO - Running setup.py install for manifestparser 05:05:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:05:44 INFO - Running setup.py install for mozcrash 05:05:44 INFO - Running setup.py install for mozdebug 05:05:44 INFO - Running setup.py install for mozdevice 05:05:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:05:44 INFO - Running setup.py install for mozfile 05:05:44 INFO - Running setup.py install for mozhttpd 05:05:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:05:44 INFO - Running setup.py install for mozinfo 05:05:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:05:45 INFO - Running setup.py install for mozInstall 05:05:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:05:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:05:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:05:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:05:45 INFO - Running setup.py install for mozleak 05:05:45 INFO - Running setup.py install for mozlog 05:05:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:05:45 INFO - Running setup.py install for moznetwork 05:05:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:05:45 INFO - Running setup.py install for mozprocess 05:05:45 INFO - Running setup.py install for mozprofile 05:05:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:05:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:05:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:05:45 INFO - Running setup.py install for mozrunner 05:05:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:05:45 INFO - Running setup.py install for mozscreenshot 05:05:45 INFO - Running setup.py install for moztest 05:05:45 INFO - Running setup.py install for mozversion 05:05:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:05:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:05:46 INFO - Cleaning up... 05:05:46 INFO - Return code: 0 05:05:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:46 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 0x1b5c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc090>, '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 0x1eccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', '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 05:05:46 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 05:05:46 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 05:05:46 INFO - Using env: {'DISPLAY': ':0', 05:05:46 INFO - 'HOME': '/home/cltbld', 05:05:46 INFO - 'LANG': 'en_US.UTF-8', 05:05:46 INFO - 'LANGUAGE': 'en_US:en', 05:05:46 INFO - 'LOGNAME': 'cltbld', 05:05:46 INFO - 'MAIL': '/var/mail/cltbld', 05:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:46 INFO - 'MOZ_NO_REMOTE': '1', 05:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:46 INFO - 'NO_EM_RESTART': '1', 05:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:46 INFO - 'PWD': '/builds/slave/test', 05:05:46 INFO - 'SHELL': '/bin/bash', 05:05:46 INFO - 'SHLVL': '1', 05:05:46 INFO - 'TERM': 'linux', 05:05:46 INFO - 'TMOUT': '86400', 05:05:46 INFO - 'USER': 'cltbld', 05:05:46 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', 05:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:46 INFO - '_': '/tools/buildbot/bin/python'} 05:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:46 INFO - Running setup.py (path:/tmp/pip-2mUTWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:46 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)) 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:46 INFO - Running setup.py (path:/tmp/pip-eQFkpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:46 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)) 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:46 INFO - Running setup.py (path:/tmp/pip-gXtU0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:46 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)) 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:46 INFO - Running setup.py (path:/tmp/pip-an6pAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:46 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)) 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:46 INFO - Running setup.py (path:/tmp/pip-c7fT0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:46 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)) 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:46 INFO - Running setup.py (path:/tmp/pip-so9TRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:46 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)) 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:46 INFO - Running setup.py (path:/tmp/pip-ZlYcdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:46 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)) 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:46 INFO - Running setup.py (path:/tmp/pip-vCOSKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:46 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)) 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:46 INFO - Running setup.py (path:/tmp/pip-purYYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:46 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)) 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:46 INFO - Running setup.py (path:/tmp/pip-Q5aFZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:46 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)) 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:46 INFO - Running setup.py (path:/tmp/pip-sRI4Zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:47 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)) 05:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:47 INFO - Running setup.py (path:/tmp/pip-RLpVT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:47 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)) 05:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:47 INFO - Running setup.py (path:/tmp/pip-0pr2uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:47 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)) 05:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:47 INFO - Running setup.py (path:/tmp/pip-k5AQUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:47 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)) 05:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:47 INFO - Running setup.py (path:/tmp/pip-GC9oiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:47 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)) 05:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:47 INFO - Running setup.py (path:/tmp/pip-hPBh20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:47 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)) 05:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:47 INFO - Running setup.py (path:/tmp/pip-M1ivvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:47 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)) 05:05:47 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)) 05:05:47 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)) 05:05:47 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)) 05:05:47 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)) 05:05:47 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)) 05:05:47 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)) 05:05:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:05:47 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 05:05:47 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 05:05:47 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 05:05:47 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 05:05:48 INFO - Downloading blessings-1.6.tar.gz 05:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:05:48 INFO - Installing collected packages: blessings 05:05:48 INFO - Running setup.py install for blessings 05:05:48 INFO - Successfully installed blessings 05:05:48 INFO - Cleaning up... 05:05:48 INFO - Return code: 0 05:05:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:05:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:49 INFO - Reading from file tmpfile_stdout 05:05:49 INFO - Current package versions: 05:05:49 INFO - argparse == 1.2.1 05:05:49 INFO - blessings == 1.6 05:05:49 INFO - blobuploader == 1.2.4 05:05:49 INFO - docopt == 0.6.1 05:05:49 INFO - functools32 == 3.2.3-2 05:05:49 INFO - jsonschema == 2.5.1 05:05:49 INFO - manifestparser == 1.1 05:05:49 INFO - mozInstall == 1.13 05:05:49 INFO - mozcrash == 1.0 05:05:49 INFO - mozdebug == 0.1 05:05:49 INFO - mozdevice == 0.51 05:05:49 INFO - mozfile == 1.2 05:05:49 INFO - mozhttpd == 0.7 05:05:49 INFO - mozinfo == 0.10 05:05:49 INFO - mozleak == 0.1 05:05:49 INFO - mozlog == 3.5 05:05:49 INFO - moznetwork == 0.27 05:05:49 INFO - mozprocess == 0.25 05:05:49 INFO - mozprofile == 0.28 05:05:49 INFO - mozrunner == 6.13 05:05:49 INFO - mozscreenshot == 0.1 05:05:49 INFO - mozsystemmonitor == 0.3 05:05:49 INFO - moztest == 0.8 05:05:49 INFO - mozversion == 1.4 05:05:49 INFO - psutil == 3.1.1 05:05:49 INFO - requests == 1.2.3 05:05:49 INFO - wsgiref == 0.1.2 05:05:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:49 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 0x1b5c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc090>, '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 0x1eccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', '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 05:05:49 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 05:05:49 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 05:05:49 INFO - Using env: {'DISPLAY': ':0', 05:05:49 INFO - 'HOME': '/home/cltbld', 05:05:49 INFO - 'LANG': 'en_US.UTF-8', 05:05:49 INFO - 'LANGUAGE': 'en_US:en', 05:05:49 INFO - 'LOGNAME': 'cltbld', 05:05:49 INFO - 'MAIL': '/var/mail/cltbld', 05:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:49 INFO - 'MOZ_NO_REMOTE': '1', 05:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:49 INFO - 'NO_EM_RESTART': '1', 05:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:49 INFO - 'PWD': '/builds/slave/test', 05:05:49 INFO - 'SHELL': '/bin/bash', 05:05:49 INFO - 'SHLVL': '1', 05:05:49 INFO - 'TERM': 'linux', 05:05:49 INFO - 'TMOUT': '86400', 05:05:49 INFO - 'USER': 'cltbld', 05:05:49 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', 05:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:49 INFO - '_': '/tools/buildbot/bin/python'} 05:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:49 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)) 05:05:49 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)) 05:05:49 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)) 05:05:49 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)) 05:05:49 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)) 05:05:49 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)) 05:05:49 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)) 05:05:49 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)) 05:05:49 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)) 05:05:49 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:05:50 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)) 05:05:50 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)) 05:05:50 INFO - Installing collected packages: simplejson 05:05:50 INFO - Running setup.py install for simplejson 05:05:50 INFO - building 'simplejson._speedups' extension 05:05:50 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 05:05:51 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 05:05:51 INFO - Successfully installed simplejson 05:05:51 INFO - Cleaning up... 05:05:51 INFO - Return code: 0 05:05:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc090>, '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 0x1eccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', '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 05:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:05:51 INFO - Using env: {'DISPLAY': ':0', 05:05:51 INFO - 'HOME': '/home/cltbld', 05:05:51 INFO - 'LANG': 'en_US.UTF-8', 05:05:51 INFO - 'LANGUAGE': 'en_US:en', 05:05:51 INFO - 'LOGNAME': 'cltbld', 05:05:51 INFO - 'MAIL': '/var/mail/cltbld', 05:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:51 INFO - 'MOZ_NO_REMOTE': '1', 05:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:51 INFO - 'NO_EM_RESTART': '1', 05:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:51 INFO - 'PWD': '/builds/slave/test', 05:05:51 INFO - 'SHELL': '/bin/bash', 05:05:51 INFO - 'SHLVL': '1', 05:05:51 INFO - 'TERM': 'linux', 05:05:51 INFO - 'TMOUT': '86400', 05:05:51 INFO - 'USER': 'cltbld', 05:05:51 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', 05:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:51 INFO - '_': '/tools/buildbot/bin/python'} 05:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:05:51 INFO - Cleaning up... 05:05:51 INFO - Return code: 0 05:05:51 INFO - Running post-action listener: _resource_record_post_action 05:05:51 INFO - Running post-action listener: _start_resource_monitoring 05:05:52 INFO - Starting resource monitoring. 05:05:52 INFO - [mozharness: 2017-09-09 12:05:52.012761Z] Finished create-virtualenv step (success) 05:05:52 INFO - [mozharness: 2017-09-09 12:05:52.013787Z] Running install step. 05:05:52 INFO - Running pre-action listener: _resource_record_pre_action 05:05:52 INFO - Running main action method: install 05:05:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:52 INFO - Reading from file tmpfile_stdout 05:05:52 INFO - Detecting whether we're running mozinstall >=1.0... 05:05:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:05:52 INFO - Reading from file tmpfile_stdout 05:05:52 INFO - Output received: 05:05:52 INFO - Usage: mozinstall [options] installer 05:05:52 INFO - Options: 05:05:52 INFO - -h, --help show this help message and exit 05:05:52 INFO - -d DEST, --destination=DEST 05:05:52 INFO - Directory to install application into. [default: 05:05:52 INFO - "/builds/slave/test"] 05:05:52 INFO - --app=APP Application being installed. [default: firefox] 05:05:52 INFO - mkdir: /builds/slave/test/build/application 05:05:52 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'] 05:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:06:08 INFO - Reading from file tmpfile_stdout 05:06:08 INFO - Output received: 05:06:08 INFO - /builds/slave/test/build/application/firefox/firefox 05:06:08 INFO - Running post-action listener: _resource_record_post_action 05:06:08 INFO - [mozharness: 2017-09-09 12:06:08.917280Z] Finished install step (success) 05:06:08 INFO - [mozharness: 2017-09-09 12:06:08.917567Z] Running setup-mitmproxy step. 05:06:08 INFO - Running pre-action listener: _resource_record_pre_action 05:06:08 INFO - Running main action method: setup_mitmproxy 05:06:08 INFO - Skipping: mitmproxy is not required 05:06:08 INFO - Running post-action listener: _resource_record_post_action 05:06:08 INFO - [mozharness: 2017-09-09 12:06:08.918692Z] Finished setup-mitmproxy step (success) 05:06:08 INFO - [mozharness: 2017-09-09 12:06:08.918912Z] Running run-tests step. 05:06:08 INFO - Running pre-action listener: _resource_record_pre_action 05:06:08 INFO - Running pre-action listener: _set_gcov_prefix 05:06:08 INFO - Running main action method: run_tests 05:06:08 WARNING - Try message not found. 05:06:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:06:08 INFO - Python 2.7.3 05:06:08 INFO - Return code: 0 05:06:08 INFO - grabbing minidump binary from tooltool 05:06:08 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')]} 05:06:08 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 0x1ecc090>, '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 0x1eccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:06:08 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 05:06:08 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 05:06:08 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 05:06:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:06:09 INFO - Return code: 0 05:06:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:06:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:06:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:06:09 INFO - ENV: RUST_BACKTRACE is now full 05:06:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:06:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:06:09 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/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 05:06:09 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/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --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 05:06:09 INFO - Using env: {'DISPLAY': ':0', 05:06:09 INFO - 'HOME': '/home/cltbld', 05:06:09 INFO - 'LANG': 'en_US.UTF-8', 05:06:09 INFO - 'LANGUAGE': 'en_US:en', 05:06:09 INFO - 'LOGNAME': 'cltbld', 05:06:09 INFO - 'MAIL': '/var/mail/cltbld', 05:06:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:06:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:09 INFO - 'MOZ_NO_REMOTE': '1', 05:06:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:09 INFO - 'NO_EM_RESTART': '1', 05:06:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:09 INFO - 'PWD': '/builds/slave/test', 05:06:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:06:09 INFO - 'RUST_BACKTRACE': 'full', 05:06:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:06:09 INFO - 'SHELL': '/bin/bash', 05:06:09 INFO - 'SHLVL': '1', 05:06:09 INFO - 'TERM': 'linux', 05:06:09 INFO - 'TMOUT': '86400', 05:06:09 INFO - 'USER': 'cltbld', 05:06:09 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', 05:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:09 INFO - '_': '/tools/buildbot/bin/python'} 05:06:09 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/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 05:06:09 INFO - mozversion application_buildid: 20170909110058 05:06:09 INFO - mozversion application_changeset: 2a9cffb19ab58a7875aee5492c565c549c037511 05:06:09 INFO - mozversion application_display_name: Nightly 05:06:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:06:09 INFO - mozversion application_name: Firefox 05:06:09 INFO - mozversion application_remotingname: firefox 05:06:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:06:09 INFO - mozversion application_vendor: Mozilla 05:06:09 INFO - mozversion application_version: 57.0a1 05:06:09 INFO - mozversion platform_buildid: 20170909110058 05:06:09 INFO - mozversion platform_changeset: 2a9cffb19ab58a7875aee5492c565c549c037511 05:06:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:06:09 INFO - mozversion platform_version: 57.0a1 05:06:09 INFO - using testdate: 1504958769 05:06:09 INFO - actual date: 1504958769 05:06:09 INFO - starting webserver on 'localhost:38948' 05:06:09 INFO - SUITE-START | Running 2 tests 05:06:09 INFO - TEST-START | dromaeo_css 05:06:09 INFO - Initialising browser for dromaeo_css test... 05:06:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38948/getInfo.html -profile /tmp/tmp7gnUwC/profile 05:06:09 INFO - TEST-INFO | started process 3513 (/builds/slave/test/build/application/firefox/firefox http://localhost:38948/getInfo.html) 05:06:18 INFO - TEST-INFO | 3513: exit 0 05:06:18 INFO - Browser initialized. 05:06:18 INFO - Running cycle 1/1 for dromaeo_css test... 05:06:18 INFO - Using env: {'DISPLAY': ':0', 05:06:18 INFO - 'HOME': '/home/cltbld', 05:06:18 INFO - 'JSGC_DISABLE_POISONING': '1', 05:06:18 INFO - 'LANG': 'en_US.UTF-8', 05:06:18 INFO - 'LANGUAGE': 'en_US:en', 05:06:18 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:06:18 INFO - 'LOGNAME': 'cltbld', 05:06:18 INFO - 'MAIL': '/var/mail/cltbld', 05:06:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:06:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:06:18 INFO - 'MOZ_CRASHREPORTER': '1', 05:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:18 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:06:18 INFO - 'MOZ_NO_REMOTE': '1', 05:06:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:18 INFO - 'NO_EM_RESTART': '1', 05:06:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:18 INFO - 'PWD': '/builds/slave/test', 05:06:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:06:18 INFO - 'RUST_BACKTRACE': 'full', 05:06:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:06:18 INFO - 'SHELL': '/bin/bash', 05:06:18 INFO - 'SHLVL': '1', 05:06:18 INFO - 'STYLO_FORCE_DISABLED': '1', 05:06:18 INFO - 'TERM': 'linux', 05:06:18 INFO - 'TMOUT': '86400', 05:06:18 INFO - 'USER': 'cltbld', 05:06:18 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', 05:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:18 INFO - '_': '/tools/buildbot/bin/python'} 05:06:18 INFO - TEST-INFO | started process 3716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7gnUwC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:19 INFO - PID 3716 | 05:06:19 INFO - PID 3716 | (/builds/slave/test/build/application/firefox/firefox:3767): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:06:19 INFO - PID 3716 | 05:06:29 INFO - PID 3716 | RSS: Main: 164864000 05:06:29 INFO - PID 3716 | 05:09:27 INFO - PID 3716 | Cycle 1(1): loaded http://localhost:38948/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38948/tests/dromaeo/cssquery-ext.html) 05:09:28 INFO - PID 3716 | RSS: Main: 171057152 05:09:28 INFO - PID 3716 | 05:12:30 INFO - PID 3716 | Cycle 1(1): loaded http://localhost:38948/tests/dromaeo/cssquery-ext.html (next: http://localhost:38948/tests/dromaeo/cssquery-jquery.html) 05:12:30 INFO - PID 3716 | RSS: Main: 167321600 05:12:30 INFO - PID 3716 | 05:15:32 INFO - PID 3716 | Cycle 1(1): loaded http://localhost:38948/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38948/tests/dromaeo/cssquery-mootools.html) 05:15:33 INFO - PID 3716 | RSS: Main: 170348544 05:15:33 INFO - PID 3716 | 05:18:34 INFO - PID 3716 | Cycle 1(1): loaded http://localhost:38948/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38948/tests/dromaeo/cssquery-prototype.html) 05:18:35 INFO - PID 3716 | RSS: Main: 168742912 05:18:35 INFO - PID 3716 | 05:21:38 INFO - PID 3716 | Cycle 1(1): loaded http://localhost:38948/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38948/tests/dromaeo/cssquery-yui.html) 05:21:39 INFO - PID 3716 | RSS: Main: 169988096 05:21:39 INFO - PID 3716 | 05:24:41 INFO - PID 3716 | Cycle 1(1): loaded http://localhost:38948/tests/dromaeo/cssquery-yui.html (next: http://localhost:38948/tests/dromaeo/cssquery-dojo.html) 05:24:41 INFO - PID 3716 | RSS: Main: 173019136 05:24:41 INFO - PID 3716 | 05:24:41 INFO - PID 3716 | __start_tp_report 05:24:41 INFO - PID 3716 | _x_x_mozilla_page_load 05:24:41 INFO - PID 3716 | _x_x_mozilla_page_load_details 05:24:41 INFO - PID 3716 | |i|pagename|runs| 05:24:41 INFO - PID 3716 | |0;dojo.html;3099.612548431446;3107.5183346581275;3112.42420152272;3121.82829944353;3138.419392412404;6081.695915204233;6163.8150855474405;6190.473809726173;6273.341299163585;6294.370562943704;6159;6193.411625895544;6215.3784621537825;6231.283402408724;6245.4066863647995;5726.828195154152;5757.481826635602;5841.707914604274;5852.824415267549;5932.228810254661;5678.0915053591225;5767.740451679663;5779.595428320019;5803.042497987848;5804.622699524539;5634.239377684001;5701;5725.227094342273;5783.392743761908;5842;5753.309602847643;5812.157237200625;5813.360530341659;5862.06207006879;5893.852653683649;5574.163875418679;5698.715064246812;5721.084626459747;5743.9660861044995;5776.740046697909;6118.1434599156155;6245.406686364788;6298;6302.023186406114;6341.80974570759;6692.297308782557;6712.295209003082;6799.11611490508;6804.421624161952;6816.147981502312;6514.641694706789;6584.539082264243;6611.471082313452;6746.730130794763;6840.3501667341525;6145.569810113294;6161.44546990773;6185.443310102112;6193.225846769154;6238.563300568962;6852.211995620568;7018.719251229996;7033.120859892513;7033.191183013917;7055.823604409931;6617.371349721769;6624.105745724362;6683.331666833375;6684.598924064571;6718.193816742022;6595.967020164869;6666.133402657623;6666.666666666647;6677.165354330708;6710.295418981034;6709.094272273278;6727.663616819237;6730.730770769114;6735.461163106939;6737.292584278678;6686.866262674816;6687.598744075371;6713.832154196184;6721.327867213239;6811.386975172259;5110.361204849394;5188.9740551297755;5258.6581872178185;5339.519443250126;5348.438413966555;4647.930281045787;4650.162970665313;4681.461631912305;4735.739534325577;4743.596794272526;5743.1385292206505;5749.511291540182;5807.883842323215;5814.970925145347;5815.9709201453725;6705.932940670628;6705.966470167618;6754.763583274562;6829.043933849265;6831.2144103428745;5749.080147176515;5753.424657534213;5760.6255593386295;5766.452187042224;5776.653400795965;5725.656460612377;5789.913151302734;5794.275715535558;5808.099744539603;5810.593258471951;6331.430171284606;6409.974404095322;6424.71088801005;6527.804165875032;6544.214694236722;6523.412892839572;6530.444912182517;6536.705848236936;6539;6567.835804104936;6371.649559274284;6372.490200784019;6381.138546296191;6383.0744542042075;6417.133686952388;6629.701663425254;6670.799876003728;6703.396694297341;6719.361660642231;6733.0573719678305;6715.899261511179;6724.865502690017;6733.595984240961;6817.965910170417;6826.078479405217;6223.502119830312;6320.936790632219;6468.353164683494;6474.320196379501;6590.143281373391;6544;6553.311902250386;6555.868882622225;6560.147180866456;6561.1470508833545;6460.709268083042;6466.06242094903;6506.056621789909;6512.251091124582;6522.836929076811;6452.838679033061;6489.1888513935755;6572.178477690289;6642.136522252076;6662.200535935525;6124.326324104434;6214.875702486015;6350.904736428864;6419.2938776735455;6439.034144878306 05:24:41 INFO - PID 3716 | |1;ext.html;815.6288888555707;843.2073850580458;878.8681697745337;884.1467983396018;884.7522693645782;37533.43699844501;41146;41344.17311653765;41347.79326103373;41435.585644143546;37357;38702.61297387025;38796.80601596988;38809;38810.8356749298;6984.5809251444825;7066.3993560547415;7067.116610423697;7067.151941766995;7067.399271061966;6956.582605043688;7030.402415794663;7039.120109986252;7042.68307926142;7057.294270572953;7028.508004439691;7037.824054398629;7057.752978645748;7062.187848397423;7707.884381734279;7790.143084260727;7801.648925798353;7850.528968261894;7855;7857.528548287121;7643.656035478361;7716.2669546393;7716.845663086763;7717.228277172294;7719.536827790294;37853.24293514114;38699.61300387017;38700;38709.419358709645;38712.80643596792;3581.247937933037;3629.6188900165366;3629.8366573504254;3630.8366123524506;3633.5094762207027;32327.6767232327;32365.352692946246;32397.190070248198;32417.351652967045;32589.511157332658;5203.661761985497;5214.582833373359;5222.216667499867;5227.18978558324;5283.498067683564;176692;178413;178997.10501447538;179670.10164949222;180199;41614.791926040176;42096;47541.28688069682;47558.28662570064;47842.52157478381;50579;50582.49417505778;50615.493845061814;50645;50671;15946.60133496672;16055.67888642244;16066.518004459886;16069.919650401673;16076.43732469358;13180;13222.735545289233;13223;13223.867761322264;13254.204747715168;13918.860811391958;14045.648858778612;14089.788653170212;14098.365573549216;14212.431502739775;5848.619839710405;5857.326407463111;5866.266716660418;5878.735456904449;5911.261092363455;1012.6202673997251;1017.5878769098526;1029.3926583315879;1034.79821434821;1035.0684384054412;22731.659025114637;22772.2029728962;22919.427014324443;23211;23517;1095.2114477576292;1096.9561217551209;1115.5593540551438;1117.4245263689206;1120.4957769003981;12012.939935300443;12080.577179798665;12121.69695757613;12125.878741212651;12201.145919785708;225286;225448;225681;225825;228535;51872;51945.48054519406;52246.21630675543;52274;52279.21581176286;1413.6465883529117;1448.717500087473;1451.1583281696592;1451.2308476507467;1453.3605213705935;22257;22375.104995799986;22452;22487.437814054778;23065.88467057654;36737.448938265414;36899;36986.44520332143;36995.63004369922;37010;185098;185198;185546;185857;186056;33430.33139337151;34612;35273.294534109686;35371.82314088413;35407.29185416329;44225.55774442214;45400;45623;45919.08161836678;45972;33270.334593308486;33282.83358583289;33515.83242083774;33790.49314260337;33953.49069763906;32793;32862.94857759864;33048.50427243641;33129.50305745464;33439.66560334365;37196.62803371932;37416.438753419265;37430.62569374272;37454.25091498209;37576.248475030894;32333.191670208435;32362;32369;32513.187170320933;32849.34301314008;24084.2905397002;24220.273391798273;24260.75739242585;24393.63409548894;24633.876830615733 05:24:41 INFO - PID 3716 | |2;jquery.html;552.8009916430087;556.4491153757781;570.3184694290325;576.9942300576994;585.3765739487445;21938.780612193874;22771.08915643372;22772.316830495092;22791.430214244632;22840.543189136206;22823.54352912941;23935.521289574197;24317.878410607966;24513.87743061282;24741;6243.313235544087;6344.238691357021;6374.968125159367;6382.042693595951;6401.391867772554;6133.907991380132;6187.288461826903;6293.150424692677;6298;6301.873962520747;6378.617282963037;6408.743650253984;6409.8397540061405;6434.7747828826;6438.420542151205;6414.583052101621;6434.742610295559;6436.967815160918;6442.162518872564;6448.065030570588;6649.501287403464;6946.965265173692;6991.82520436988;6996.545224560438;6997.055397521321;29418;29907.401851963055;29918.401631967456;29949.850250748827;30056.699433005608;2048.3342913553156;2072.108993132952;2072.751269847613;2072.9481762955897;2073.2225415469197;19481.902590487098;20006.49983750418;20363.796362036337;20364.5927081459;20403.285884993955;2514.8742562871785;2539.606361014046;2593.0405749872666;2594.169865642995;2597.4415500667446;114829;120979;121064.39467802693;126631.36684316612;129420;19609.313674021625;20207.898960505398;20252.772195058533;21884.562308753735;21930.342089737333;40909.38635920463;40956;41169.58830411718;41200.793996029824;41267.7936610315;11147.888521114848;11159.944200278947;11188.888111118784;11313.434328283553;11326.773464530663;9265.72202833916;9296.488693121808;9365.719028429157;9374.5781439834;9458.810823783624;10542.209334299805;10720.195985301134;10780.838287425695;10841.349519028883;11378.943105284421;3491.336646037245;3565;3703.4259689748133;4130.648894843912;4177.7257936329715;955.7992821507561;972.2853702528636;977.6040703515088;994.309673554945;996.6810620601337;18745.7188142178;18757;18859.057047147588;18924.71612925807;19038.52403689891;1018.791147814711;1021.1830535571662;1021.6219998600417;1025.7128004158847;1025.8512515685184;10102.292839501311;10158.187345012382;10258.640947566799;10606.57573697059;10713.142948564097;449283.75358123;450925;466597;471716;483917;112009.43995279972;112580;114176;116248;117238;1024.2318261304022;1079.1420820447763;1134.9375784331776;1155.0874808900874;1185.9525618975144;19516.60966780628;19540.706889396388;19578;19604;19667.508312292306;52210;53294;53530;53749;56572.434275658365;67598.32401676117;67635;68047;68352;68686;18700.532486687942;19272.903635481733;19345.032748362806;19575.412737617895;19728.802711973272;22157.335279941628;22299.554008919407;22372.664410034187;22521.43696407603;22531.324060278217;17823;17875.821241787417;18055.729164062814;18100.366487172887;18112.09439528045;15636.140012299433;15862.206889655241;15993.960392574445;16114.952528085636;16304.592385190464;17215.827841721424;18181;18297.81702182961;18449.631007380045;18786.966716830706;19235.807641923962;19314.227430903167;19320.71018934689;19322.033898304748;19354.8064519353;17785;17908.55228619243;17949.74351795362;18052.18765155545;18087 05:24:41 INFO - PID 3716 | |3;mootools.html;1337.4182230729632;1385.9445622175112;1389.9235542045196;1395.9441622335105;1405.8102156208915;14683.706325873476;15257.694846103072;15334;15387.692246155084;15400.075995440282;15018.624534386647;15166.241687915615;15172.924135379335;15191.164485953268;15197;2727.1409506005593;2742.1773467959633;2796.0353677981066;2798.3703666674937;2799.538076217422;2722.863856807152;2745.574435962419;2757.8758955846934;2761.7514423701864;2762.502749505088;2272.943176420586;2358.2335740884196;2359.1860808021293;2659.734026597344;2765.0322387164433;2625.094342451851;2627.080521817358;2653.2703506535663;2654.9469010619678;2655.681318241804;2693.8383696978244;2706.6075419064127;2709.3497560585515;2710.2004908552026;2719.2250208690625;14655.120692758363;14969.925150374178;14974.101553906801;14986;15050.924745376313;7619.923800761977;7883.921160788376;7901.328387087105;7929.881051784228;7945.841083178362;4819.614430845524;5089.236614507817;5168.689878607295;5292.153255479105;5323.680579165262;1881.6518943995404;1895.5640202753443;1963.626910886927;1966.3412756726514;2016.6571682813958;26692.73307266922;26740.8662956684;26764.73235267642;26774.866125669247;26795.73204267952;7262.96368518154;7284.123110831289;7303.926960730431;7341.88987165193;7410.481266311414;20169.39491815248;20247.291344803154;20328.186872525228;20376.898115509328;20386;7138.607376594233;7271.381932535794;7286.599237042014;7289.781306560812;7297.708091676273;6254.593451425642;6336.271328797156;6343.460805831463;6348.936510634927;6371.426571608577;5572;5641.435856414408;5696.259486266758;5704.714764261853;5749.770009199585;1740.808511063782;1772.273367919147;1775.1301862087485;1789.7225929980873;1799.1004497751123;735.5329365852615;869.573908784691;893.946363218209;902.7743064233941;906.7053207707521;8176.6320515576945;8409.663613455394;8450.492970421794;8471.322294216448;8508.489490630582;989.9851502227473;992.1665800727424;997.7555498902815;999.6051559633904;1004.251832384878;4939.357883475197;5035.420926593415;5128.538431541179;5138.049460849755;5265.973670131625;20731.378058658265;20739.58520829575;21988.780112198994;21992.120315187534;21996.340109796733;20859.8957005214;21228.78771212299;21463.67804482934;21535.353939381843;21607.243746468797;10584.523696433678;10753.946230268799;10826.783464330827;10832.620858269922;10977.12183025356;8138.593070346577;8216.301614362847;8233.34133269325;8262.42163048605;8284.171582841667;17667;18605.34881279203;18643.533911652317;19191.52021199481;19304;19117.522061948563;19257.32599359072;19366.4190074298;19852;20022.59954800925;11562.826557601811;11717.472713727731;11768.117391195523;11777.646670599554;11792.70518237051;13493.39279732434;13778.035537512678;13915.095518791652;13916;13937.930310348384;11159.832602510807;11169.609063682732;11315.20793544444;11481.885181148082;11712.297262164297;9850.408975461496;9969.40183588987;10119;10325.483725813529;10400.167986560906;9232.95383523078;9301.627934882528;9363.204127648954;9447.716568502956;9460.432374057578;6784.76253331131;6807.5575087619145;6903.930960690329;6909.170899492093;6915.412189963708;6797.72809087631;6837.897431538431;6900.137482814648;6946.930530694831;6975.197852247056 05:24:41 INFO - PID 3716 | |4;prototype.html;501.5736623869709;504.6114491841282;518.9802038993378;525.9526642602166;532.3053415293043;6244.157973397847;6293.874122517553;6312.652804095773;6357.205349331333;6408.333833203365;6278.560500764948;6293.370662933704;6306.558540902139;6323.841903952403;6341.207349081354;5142.717150556718;5164.354455693038;5206.281926964093;5207.073382848352;5228.73856307185;4908.429302623162;5057.519535644126;5153.201253805666;5188.974055129719;5231.555317797992;4979.775910084055;4987.925181122286;5003.124453220672;5017.9247311290355;5037.571806396442;4988.800447982077;5022.472640372781;5035.823746168867;5067.39191297043;5083.771230294646;4386.122775444892;4468.575485328888;4468.731876087445;4484.641228701696;4499.977500112478;6034.155218269446;6092.634441933498;6139.355367686373;6153.630782153085;6172.87654246917;5686.2039314496005;5708.945714042967;5714.171445140473;5741.856453588652;5783.971080144573;6608.570442921243;6619.437347825441;6621.801345959629;6622.18557113225;6688.866222675568;4880.463149053601;4892.706437613754;4893.4617192108835;4933;4933.851984440473;6638.966805165944;6691.1636045494315;6876.1748590169;6912.723491060352;6981.162260528718;4775.450823155312;4959.801607935714;4970.850874473772;5028.5977121830165;5037.29477873098;5068.670536415195;5075.137226671474;5092.159793634083;5093.9490605094215;5094.465081166498;5654.15187721845;5676.120201368794;5713.857153571194;5713.857153571194;5721.656700597978;6659.966700166468;6685.732570697215;6704.7988560343265;6725.2602213756445;6740.258571557125;1740.7283495038841;1766.7703198584102;1770.805211426742;1772.6188869392884;1779.7686300781074;1172.3141961952354;1221.0414824362833;1227.098082909061;1228.5147366790247;1232.5501192064833;5794.884102318014;5797.652140871562;5820.534357251409;5838.5329173666005;5851.063829787298;6588.86822263552;6765.154355705537;6795.306622976364;6837.179538455417;6919.308069193041;5654.74553645087;5704.486596206279;5709.687576531428;5717.199592057115;5804.910232316362;3579.302036102935;3594.191306955914;3608.693261072838;3623.836927338223;3626.5104210931713;6481.611103333815;6523.630037692138;6554.541182117301;6597.812393769072;6646.900296495556;6572.666703320252;6985.930140698528;7009.264027277062;7017.92982070183;7027.051348067946;6554.344565543408;6568.1789776277965;6568.474522038226;6589.571677840829;6596.934030659632;6836.179658441019;6868.347506986828;6891;6893.620850853051;6912.930870691229;6756.763513277012;6843.3840954314355;6850.417714494324;6871.553349032497;6880.827979300558;6493.902591461227;6497.675116244263;6578.5395022347975;6603;6633.270340262664;4994.225894986283;5015.623828212826;5033.949660503348;5038.168702164248;5055.772490238021;6431.196100487439;6561.507886908596;6711.765088221889;6732.821756192745;6803.9319606805275;6504.317046710027;6505.739770409131;6522.804315870341;6607.735690572324;6639.800805975829;6474.643894585843;6497.447716943923;6535.803925882231;6585.473162147113;6588.934110659024;6402.90395644075;6439.356064393523;6490.221173459215;6537.182852143482;6598.472122230114;6608.636524991171;6645.0097456145895;6660;6681.899771503528;6711.765088221889;6347.301796802441;6362.522810789117;6368.522360822864;6385.96807015962;6519.511036672174 05:24:41 INFO - PID 3716 | |5;yui.html;853.7438768369487;872.110447343709;890.9376343655945;891.4517571693407;894.217559635319;19250.22999080037;19602.215911363564;19607.019649017544;19645.901770491128;19774.209031638737;17651.117444127805;17836.375726849565;18074.096295185253;18094;18094.366697165602;942.4439580647417;956.7225504603657;959.1751094059103;959.904009599038;960.3757557587554;988.7280997725647;990.267202270322;990.747359423346;992.7666998255404;992.791513782103;994.960201591939;1032.2000449651505;1034.2191645307782;1041.7760181560964;1044.5143008501045;1015.6648306058983;1022.7034160093564;1025.2823023883275;1026.1329176845554;1026.2918586175515;723.9348458638748;743.3718507860849;752.1087511299128;755.4598462099625;756.2777547442234;19377;19575;19590;19631.705524417146;19634.901825490924;20781.688274675893;20792.27227047046;21658.133674652996;21831.345059648236;21847.890760546095;16408.589785255346;16472.917635411864;16547.83452165475;16561.171941403;16785.748213776802;3669.87155449558;3699.7965111918834;3700.5004324416127;3702.0559757261994;3702.0559757261994;97923.52557365801;125665;129662;137809;139671;16285.430009949594;16820.158992050594;16919.23863426149;16942;16946;30418.847905760773;30574.38851222963;31250.843745781127;31315.373692526024;31335;8253.546054967035;8290.253877151084;8300.169983001771;8313.83372332562;8318.292945099613;4160.18876319121;4179.393987871802;4236.639885609758;4245.150969806051;4297.763623000703;5303.231031500411;5379.838604841861;5385.838424847261;5393.460653934575;5413.729313534308;1023.7901230247782;1045.8065257927308;1058;1060.8886066962857;1061.8035663402295;636.5067073018355;648.6075924065966;657.2047822135174;670.1489108831756;671.090672139254;10414.479276036167;10712.303700259614;10765.89234107649;11058.557657693602;11064.004239618473;647.3785166240368;655.1548502431905;661.1966460750211;665.7037618259828;666.9533132680666;4779.689320194177;4814.7833347499445;4828.179209534387;4912.852614421573;4914.803407863646;122700.38649806872;124908;126153;126690.36654816667;128330;106280;108212;109584.4520777391;111512.44243778891;113616;91588.10333887866;93202;95770.52114739381;95784.04215957891;97254.99999999859;8920.197182253629;8983.865242021244;9026.593803278736;9027.684031058881;9087.909120908706;41851.16297673969;42423;42782.57217427786;42837.78581107199;43252.35121473118;54896;55217.171742424696;55408.72295638496;56011.719941400035;56103;14346;14502;14773.92613036928;14798.852011480178;14813.481528146463;15504.224788760292;15657.60855978564;15679;15683.372665093724;15691.450799221973;13538.187708737507;13583.728325433238;13611.931940340235;13717.108387954751;13737.656558586115;13877.583672489842;13919.443222270997;13946.023778335419;14005.859941400864;14099.788503172666;13370.933145334211;13381.130226535244;13484.528041518499;13675.24786136772;13683.657908552366;10118.645847395306;10235.130013948898;10276.691699249035;10298.485075746332;10504.842427363748;10000.799984000134;10006.799864002534;10147.847782283125;10205.132563732166;10385.065344119066 05:24:41 INFO - PID 3716 | __end_tp_report 05:24:41 INFO - PID 3716 | __start_cc_report 05:24:41 INFO - PID 3716 | _x_x_mozilla_cycle_collect,377 05:24:41 INFO - PID 3716 | __end_cc_report 05:24:41 INFO - PID 3716 | __startTimestamp1504959881403__endTimestamp 05:24:41 INFO - PID 3716 | 05:24:41 INFO - PID 3716 | ------- Summary: start ------- 05:24:41 INFO - PID 3716 | Number of tests: 6 05:24:41 INFO - PID 3716 | 05:24:41 INFO - PID 3716 | [#0] dojo.html Cycles:165 Average:6158.65 Median:6372.49 stddev:738.21 (11.6%) stddev-sans-first:700.38 05:24:41 INFO - PID 3716 | Values: 3099.6 3107.5 3112.4 3121.8 3138.4 6081.7 6163.8 6190.5 6273.3 6294.4 6159.0 6193.4 6215.4 6231.3 6245.4 5726.8 5757.5 5841.7 5852.8 5932.2 5678.1 5767.7 5779.6 5803.0 5804.6 5634.2 5701.0 5725.2 5783.4 5842.0 5753.3 5812.2 5813.4 5862.1 5893.9 5574.2 5698.7 5721.1 5744.0 5776.7 6118.1 6245.4 6298.0 6302.0 6341.8 6692.3 6712.3 6799.1 6804.4 6816.1 6514.6 6584.5 6611.5 6746.7 6840.4 6145.6 6161.4 6185.4 6193.2 6238.6 6852.2 7018.7 7033.1 7033.2 7055.8 6617.4 6624.1 6683.3 6684.6 6718.2 6596.0 6666.1 6666.7 6677.2 6710.3 6709.1 6727.7 6730.7 6735.5 6737.3 6686.9 6687.6 6713.8 6721.3 6811.4 5110.4 5189.0 5258.7 5339.5 5348.4 4647.9 4650.2 4681.5 4735.7 4743.6 5743.1 5749.5 5807.9 5815.0 5816.0 6705.9 6706.0 6754.8 6829.0 6831.2 5749.1 5753.4 5760.6 5766.5 5776.7 5725.7 5789.9 5794.3 5808.1 5810.6 6331.4 6410.0 6424.7 6527.8 6544.2 6523.4 6530.4 6536.7 6539.0 6567.8 6371.6 6372.5 6381.1 6383.1 6417.1 6629.7 6670.8 6703.4 6719.4 6733.1 6715.9 6724.9 6733.6 6818.0 6826.1 6223.5 6320.9 6468.4 6474.3 6590.1 6544.0 6553.3 6555.9 6560.1 6561.1 6460.7 6466.1 6506.1 6512.3 6522.8 6452.8 6489.2 6572.2 6642.1 6662.2 6124.3 6214.9 6350.9 6419.3 6439.0 05:24:41 INFO - PID 3716 | 05:24:41 INFO - PID 3716 | [#1] ext.html Cycles:180 Average:36765.21 Median:3605.43 stddev:51232.24 (1421.0%) stddev-sans-first:51304.84 05:24:41 INFO - PID 3716 | Values: 815.6 843.2 878.9 884.1 884.8 37533.4 41146.0 41344.2 41347.8 41435.6 37357.0 38702.6 38796.8 38809.0 38810.8 6984.6 7066.4 7067.1 7067.2 7067.4 6956.6 7030.4 7039.1 7042.7 7057.3 7028.5 7037.8 7057.8 7062.2 7707.9 7790.1 7801.6 7850.5 7855.0 7857.5 7643.7 7716.3 7716.8 7717.2 7719.5 37853.2 38699.6 38700.0 38709.4 38712.8 3581.2 3629.6 3629.8 3630.8 3633.5 32327.7 32365.4 32397.2 32417.4 32589.5 5203.7 5214.6 5222.2 5227.2 5283.5 176692.0 178413.0 178997.1 179670.1 180199.0 41614.8 42096.0 47541.3 47558.3 47842.5 50579.0 50582.5 50615.5 50645.0 50671.0 15946.6 16055.7 16066.5 16069.9 16076.4 13180.0 13222.7 13223.0 13223.9 13254.2 13918.9 14045.6 14089.8 14098.4 14212.4 5848.6 5857.3 5866.3 5878.7 5911.3 1012.6 1017.6 1029.4 1034.8 1035.1 22731.7 22772.2 22919.4 23211.0 23517.0 1095.2 1097.0 1115.6 1117.4 1120.5 12012.9 12080.6 12121.7 12125.9 12201.1 225286.0 225448.0 225681.0 225825.0 228535.0 51872.0 51945.5 52246.2 52274.0 52279.2 1413.6 1448.7 1451.2 1451.2 1453.4 22257.0 22375.1 22452.0 22487.4 23065.9 36737.4 36899.0 36986.4 36995.6 37010.0 185098.0 185198.0 185546.0 185857.0 186056.0 33430.3 34612.0 35273.3 35371.8 35407.3 44225.6 45400.0 45623.0 45919.1 45972.0 33270.3 33282.8 33515.8 33790.5 33953.5 32793.0 32862.9 33048.5 33129.5 33439.7 37196.6 37416.4 37430.6 37454.3 37576.2 32333.2 32362.0 32369.0 32513.2 32849.3 24084.3 24220.3 24260.8 24393.6 24633.9 05:24:41 INFO - PID 3716 | 05:24:41 INFO - PID 3716 | [#2] jquery.html Cycles:180 Average:34385.21 Median:22048.06 stddev:77936.66 (353.5%) stddev-sans-first:78113.90 05:24:41 INFO - PID 3716 | Values: 552.8 556.4 570.3 577.0 585.4 21938.8 22771.1 22772.3 22791.4 22840.5 22823.5 23935.5 24317.9 24513.9 24741.0 6243.3 6344.2 6375.0 6382.0 6401.4 6133.9 6187.3 6293.2 6298.0 6301.9 6378.6 6408.7 6409.8 6434.8 6438.4 6414.6 6434.7 6437.0 6442.2 6448.1 6649.5 6947.0 6991.8 6996.5 6997.1 29418.0 29907.4 29918.4 29949.9 30056.7 2048.3 2072.1 2072.8 2072.9 2073.2 19481.9 20006.5 20363.8 20364.6 20403.3 2514.9 2539.6 2593.0 2594.2 2597.4 114829.0 120979.0 121064.4 126631.4 129420.0 19609.3 20207.9 20252.8 21884.6 21930.3 40909.4 40956.0 41169.6 41200.8 41267.8 11147.9 11159.9 11188.9 11313.4 11326.8 9265.7 9296.5 9365.7 9374.6 9458.8 10542.2 10720.2 10780.8 10841.3 11378.9 3491.3 3565.0 3703.4 4130.6 4177.7 955.8 972.3 977.6 994.3 996.7 18745.7 18757.0 18859.1 18924.7 19038.5 1018.8 1021.2 1021.6 1025.7 1025.9 10102.3 10158.2 10258.6 10606.6 10713.1 449283.8 450925.0 466597.0 471716.0 483917.0 112009.4 112580.0 114176.0 116248.0 117238.0 1024.2 1079.1 1134.9 1155.1 1186.0 19516.6 19540.7 19578.0 19604.0 19667.5 52210.0 53294.0 53530.0 53749.0 56572.4 67598.3 67635.0 68047.0 68352.0 68686.0 18700.5 19272.9 19345.0 19575.4 19728.8 22157.3 22299.6 22372.7 22521.4 22531.3 17823.0 17875.8 18055.7 18100.4 18112.1 15636.1 15862.2 15994.0 16115.0 16304.6 17215.8 18181.0 18297.8 18449.6 18787.0 19235.8 19314.2 19320.7 19322.0 19354.8 17785.0 17908.6 17949.7 18052.2 18087.0 05:24:41 INFO - PID 3716 | 05:24:41 INFO - PID 3716 | [#3] mootools.html Cycles:180 Average:9331.92 Median:26769.80 stddev:6812.16 (25.4%) stddev-sans-first:6804.79 05:24:41 INFO - PID 3716 | Values: 1337.4 1385.9 1389.9 1395.9 1405.8 14683.7 15257.7 15334.0 15387.7 15400.1 15018.6 15166.2 15172.9 15191.2 15197.0 2727.1 2742.2 2796.0 2798.4 2799.5 2722.9 2745.6 2757.9 2761.8 2762.5 2272.9 2358.2 2359.2 2659.7 2765.0 2625.1 2627.1 2653.3 2654.9 2655.7 2693.8 2706.6 2709.3 2710.2 2719.2 14655.1 14969.9 14974.1 14986.0 15050.9 7619.9 7883.9 7901.3 7929.9 7945.8 4819.6 5089.2 5168.7 5292.2 5323.7 1881.7 1895.6 1963.6 1966.3 2016.7 26692.7 26740.9 26764.7 26774.9 26795.7 7263.0 7284.1 7303.9 7341.9 7410.5 20169.4 20247.3 20328.2 20376.9 20386.0 7138.6 7271.4 7286.6 7289.8 7297.7 6254.6 6336.3 6343.5 6348.9 6371.4 5572.0 5641.4 5696.3 5704.7 5749.8 1740.8 1772.3 1775.1 1789.7 1799.1 735.5 869.6 893.9 902.8 906.7 8176.6 8409.7 8450.5 8471.3 8508.5 990.0 992.2 997.8 999.6 1004.3 4939.4 5035.4 5128.5 5138.0 5266.0 20731.4 20739.6 21988.8 21992.1 21996.3 20859.9 21228.8 21463.7 21535.4 21607.2 10584.5 10753.9 10826.8 10832.6 10977.1 8138.6 8216.3 8233.3 8262.4 8284.2 17667.0 18605.3 18643.5 19191.5 19304.0 19117.5 19257.3 19366.4 19852.0 20022.6 11562.8 11717.5 11768.1 11777.6 11792.7 13493.4 13778.0 13915.1 13916.0 13937.9 11159.8 11169.6 11315.2 11481.9 11712.3 9850.4 9969.4 10119.0 10325.5 10400.2 9233.0 9301.6 9363.2 9447.7 9460.4 6784.8 6807.6 6903.9 6909.2 6915.4 6797.7 6837.9 6900.1 6946.9 6975.2 05:24:41 INFO - PID 3716 | 05:24:41 INFO - PID 3716 | [#4] prototype.html Cycles:180 Average:5560.17 Median:6261.36 stddev:1562.53 (25.0%) stddev-sans-first:1520.08 05:24:41 INFO - PID 3716 | Values: 501.6 504.6 519.0 526.0 532.3 6244.2 6293.9 6312.7 6357.2 6408.3 6278.6 6293.4 6306.6 6323.8 6341.2 5142.7 5164.4 5206.3 5207.1 5228.7 4908.4 5057.5 5153.2 5189.0 5231.6 4979.8 4987.9 5003.1 5017.9 5037.6 4988.8 5022.5 5035.8 5067.4 5083.8 4386.1 4468.6 4468.7 4484.6 4500.0 6034.2 6092.6 6139.4 6153.6 6172.9 5686.2 5708.9 5714.2 5741.9 5784.0 6608.6 6619.4 6621.8 6622.2 6688.9 4880.5 4892.7 4893.5 4933.0 4933.9 6639.0 6691.2 6876.2 6912.7 6981.2 4775.5 4959.8 4970.9 5028.6 5037.3 5068.7 5075.1 5092.2 5093.9 5094.5 5654.2 5676.1 5713.9 5713.9 5721.7 6660.0 6685.7 6704.8 6725.3 6740.3 1740.7 1766.8 1770.8 1772.6 1779.8 1172.3 1221.0 1227.1 1228.5 1232.6 5794.9 5797.7 5820.5 5838.5 5851.1 6588.9 6765.2 6795.3 6837.2 6919.3 5654.7 5704.5 5709.7 5717.2 5804.9 3579.3 3594.2 3608.7 3623.8 3626.5 6481.6 6523.6 6554.5 6597.8 6646.9 6572.7 6985.9 7009.3 7017.9 7027.1 6554.3 6568.2 6568.5 6589.6 6596.9 6836.2 6868.3 6891.0 6893.6 6912.9 6756.8 6843.4 6850.4 6871.6 6880.8 6493.9 6497.7 6578.5 6603.0 6633.3 4994.2 5015.6 5033.9 5038.2 5055.8 6431.2 6561.5 6711.8 6732.8 6803.9 6504.3 6505.7 6522.8 6607.7 6639.8 6474.6 6497.4 6535.8 6585.5 6588.9 6402.9 6439.4 6490.2 6537.2 6598.5 6608.6 6645.0 6660.0 6681.9 6711.8 6347.3 6362.5 6368.5 6386.0 6519.5 05:24:41 INFO - PID 3716 | 05:24:41 INFO - PID 3716 | [#5] yui.html Cycles:180 Average:23430.64 Median:19640.40 stddev:34573.49 (176.0%) stddev-sans-first:34628.91 05:24:41 INFO - PID 3716 | Values: 853.7 872.1 890.9 891.5 894.2 19250.2 19602.2 19607.0 19645.9 19774.2 17651.1 17836.4 18074.1 18094.0 18094.4 942.4 956.7 959.2 959.9 960.4 988.7 990.3 990.7 992.8 992.8 995.0 1032.2 1034.2 1041.8 1044.5 1015.7 1022.7 1025.3 1026.1 1026.3 723.9 743.4 752.1 755.5 756.3 19377.0 19575.0 19590.0 19631.7 19634.9 20781.7 20792.3 21658.1 21831.3 21847.9 16408.6 16472.9 16547.8 16561.2 16785.7 3669.9 3699.8 3700.5 3702.1 3702.1 97923.5 125665.0 129662.0 137809.0 139671.0 16285.4 16820.2 16919.2 16942.0 16946.0 30418.8 30574.4 31250.8 31315.4 31335.0 8253.5 8290.3 8300.2 8313.8 8318.3 4160.2 4179.4 4236.6 4245.2 4297.8 5303.2 5379.8 5385.8 5393.5 5413.7 1023.8 1045.8 1058.0 1060.9 1061.8 636.5 648.6 657.2 670.1 671.1 10414.5 10712.3 10765.9 11058.6 11064.0 647.4 655.2 661.2 665.7 667.0 4779.7 4814.8 4828.2 4912.9 4914.8 122700.4 124908.0 126153.0 126690.4 128330.0 106280.0 108212.0 109584.5 111512.4 113616.0 91588.1 93202.0 95770.5 95784.0 97255.0 8920.2 8983.9 9026.6 9027.7 9087.9 41851.2 42423.0 42782.6 42837.8 43252.4 54896.0 55217.2 55408.7 56011.7 56103.0 14346.0 14502.0 14773.9 14798.9 14813.5 15504.2 15657.6 15679.0 15683.4 15691.5 13538.2 13583.7 13611.9 13717.1 13737.7 13877.6 13919.4 13946.0 14005.9 14099.8 13370.9 13381.1 13484.5 13675.2 13683.7 10118.6 10235.1 10276.7 10298.5 10504.8 10000.8 10006.8 10147.8 10205.1 10385.1 05:24:41 INFO - PID 3716 | -------- Summary: end -------- 05:24:41 INFO - PID 3716 | 05:24:42 INFO - TEST-INFO | 3716: exit 0 05:24:42 INFO - TEST-OK | dromaeo_css | took 1112663ms 05:24:42 INFO - TEST-START | kraken 05:24:42 INFO - Initialising browser for kraken test... 05:24:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38948/getInfo.html -profile /tmp/tmp_DnQSz/profile 05:24:42 INFO - TEST-INFO | started process 4092 (/builds/slave/test/build/application/firefox/firefox http://localhost:38948/getInfo.html) 05:24:48 INFO - TEST-INFO | 4092: exit 0 05:24:48 INFO - Browser initialized. 05:24:48 INFO - Running cycle 1/1 for kraken test... 05:24:48 INFO - Using env: {'DISPLAY': ':0', 05:24:48 INFO - 'HOME': '/home/cltbld', 05:24:48 INFO - 'JSGC_DISABLE_POISONING': '1', 05:24:48 INFO - 'LANG': 'en_US.UTF-8', 05:24:48 INFO - 'LANGUAGE': 'en_US:en', 05:24:48 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:24:48 INFO - 'LOGNAME': 'cltbld', 05:24:48 INFO - 'MAIL': '/var/mail/cltbld', 05:24:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:24:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:24:48 INFO - 'MOZ_CRASHREPORTER': '1', 05:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:48 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:24:48 INFO - 'MOZ_NO_REMOTE': '1', 05:24:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:48 INFO - 'NO_EM_RESTART': '1', 05:24:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:48 INFO - 'PWD': '/builds/slave/test', 05:24:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:24:48 INFO - 'RUST_BACKTRACE': 'full', 05:24:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:24:48 INFO - 'SHELL': '/bin/bash', 05:24:48 INFO - 'SHLVL': '1', 05:24:48 INFO - 'STYLO_FORCE_DISABLED': '1', 05:24:48 INFO - 'TERM': 'linux', 05:24:48 INFO - 'TMOUT': '86400', 05:24:48 INFO - 'USER': 'cltbld', 05:24:48 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617', 05:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:48 INFO - '_': '/tools/buildbot/bin/python'} 05:24:48 INFO - TEST-INFO | started process 4292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_DnQSz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:49 INFO - PID 4292 | 05:24:49 INFO - PID 4292 | (/builds/slave/test/build/application/firefox/firefox:4343): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:24:49 INFO - PID 4292 | 05:24:59 INFO - PID 4292 | RSS: Main: 164569088 05:24:59 INFO - PID 4292 | 05:25:02 INFO - PID 4292 | Cycle 1(1): loaded http://localhost:38948/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38948/tests/kraken/driver.html?testName=audio-beat-detection) 05:25:03 INFO - PID 4292 | RSS: Main: 169631744 05:25:03 INFO - PID 4292 | 05:25:05 INFO - PID 4292 | Cycle 1(1): loaded http://localhost:38948/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38948/tests/kraken/driver.html?testName=audio-dft) 05:25:06 INFO - PID 4292 | RSS: Main: 170168320 05:25:06 INFO - PID 4292 | 05:25:09 INFO - PID 4292 | Cycle 1(1): loaded http://localhost:38948/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38948/tests/kraken/driver.html?testName=audio-fft) 05:25:10 INFO - PID 4292 | RSS: Main: 165318656 05:25:10 INFO - PID 4292 | 05:25:12 INFO - PID 4292 | Cycle 1(1): loaded http://localhost:38948/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38948/tests/kraken/driver.html?testName=audio-oscillator) 05:25:12 INFO - PID 4292 | RSS: Main: 166359040 05:25:12 INFO - PID 4292 | 05:25:14 INFO - PID 4292 | Cycle 1(1): loaded http://localhost:38948/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38948/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:25:15 INFO - PID 4292 | RSS: Main: 167018496 05:25:15 INFO - PID 4292 | 05:25:18 INFO - PID 4292 | Cycle 1(1): loaded http://localhost:38948/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38948/tests/kraken/driver.html?testName=imaging-darkroom) 05:25:19 INFO - PID 4292 | RSS: Main: 169312256 05:25:19 INFO - PID 4292 | 05:25:22 INFO - PID 4292 | Cycle 1(1): loaded http://localhost:38948/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38948/tests/kraken/driver.html?testName=imaging-desaturate) 05:25:23 INFO - PID 4292 | RSS: Main: 169533440 05:25:23 INFO - PID 4292 | 05:25:26 INFO - PID 4292 | Cycle 1(1): loaded http://localhost:38948/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38948/tests/kraken/driver.html?testName=json-parse-financial) 05:25:27 INFO - PID 4292 | RSS: Main: 170033152 05:25:27 INFO - PID 4292 | 05:25:28 INFO - PID 4292 | Cycle 1(1): loaded http://localhost:38948/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38948/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:25:29 INFO - PID 4292 | RSS: Main: 170467328 05:25:29 INFO - PID 4292 | 05:25:31 INFO - PID 4292 | Cycle 1(1): loaded http://localhost:38948/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38948/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:25:31 INFO - PID 4292 | RSS: Main: 170266624 05:25:31 INFO - PID 4292 | 05:25:34 INFO - PID 4292 | Cycle 1(1): loaded http://localhost:38948/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38948/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:25:34 INFO - PID 4292 | RSS: Main: 170127360 05:25:34 INFO - PID 4292 | 05:25:37 INFO - PID 4292 | Cycle 1(1): loaded http://localhost:38948/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38948/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:25:38 INFO - PID 4292 | RSS: Main: 170835968 05:25:38 INFO - PID 4292 | 05:25:41 INFO - PID 4292 | Cycle 1(1): loaded http://localhost:38948/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38948/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:25:41 INFO - PID 4292 | RSS: Main: 170954752 05:25:41 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | Cycle 1(1): loaded http://localhost:38948/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38948/tests/kraken/driver.html?testName=ai-astar) 05:25:43 INFO - PID 4292 | RSS: Main: 172482560 05:25:43 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | __start_tp_report 05:25:43 INFO - PID 4292 | _x_x_mozilla_page_load 05:25:43 INFO - PID 4292 | _x_x_mozilla_page_load_details 05:25:43 INFO - PID 4292 | |i|pagename|runs| 05:25:43 INFO - PID 4292 | |0;ai-astar;109;107;115;107;110;111;107;107;108;110 05:25:43 INFO - PID 4292 | |1;audio-beat-detection;117;115;116;117;114;115;115;116;121;118 05:25:43 INFO - PID 4292 | |2;audio-dft;162;161;163;162;162;163;172;168;164;164 05:25:43 INFO - PID 4292 | |3;audio-fft;74;75;76;74;74;74;75;76;78;76 05:25:43 INFO - PID 4292 | |4;audio-oscillator;81;79;79;80;80;80;81;79;81;79 05:25:43 INFO - PID 4292 | |5;imaging-gaussian-blur;114;117;112;113;114;114;114;114;114;114 05:25:43 INFO - PID 4292 | |6;imaging-darkroom;148;154;147;147;147;148;147;148;148;147 05:25:43 INFO - PID 4292 | |7;imaging-desaturate;98;98;98;96;98;96;98;98;99;94 05:25:43 INFO - PID 4292 | |8;json-parse-financial;56;53;54;55;53;54;55;53;52;52 05:25:43 INFO - PID 4292 | |9;json-stringify-tinderbox;37;38;38;37;37;37;38;37;37;37 05:25:43 INFO - PID 4292 | |10;stanford-crypto-aes;78;79;75;74;76;78;75;75;76;76 05:25:43 INFO - PID 4292 | |11;stanford-crypto-ccm;119;117;123;129;116;126;122;113;122;115 05:25:43 INFO - PID 4292 | |12;stanford-crypto-pbkdf2;171;170;174;166;169;182;173;169;174;173 05:25:43 INFO - PID 4292 | |13;stanford-crypto-sha256-iterative;65;65;64;67;62;65;66;62;65;66 05:25:43 INFO - PID 4292 | __end_tp_report 05:25:43 INFO - PID 4292 | __start_cc_report 05:25:43 INFO - PID 4292 | _x_x_mozilla_cycle_collect,941 05:25:43 INFO - PID 4292 | __end_cc_report 05:25:43 INFO - PID 4292 | __startTimestamp1504959943779__endTimestamp 05:25:43 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | ------- Summary: start ------- 05:25:43 INFO - PID 4292 | Number of tests: 14 05:25:43 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | [#0] ai-astar Cycles:10 Average:109.10 Median:109.50 stddev:2.56 (2.3%) stddev-sans-first:2.71 05:25:43 INFO - PID 4292 | Values: 109.0 107.0 115.0 107.0 110.0 111.0 107.0 107.0 108.0 110.0 05:25:43 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | [#1] audio-beat-detection Cycles:10 Average:116.40 Median:116.50 stddev:2.01 (1.7%) stddev-sans-first:2.12 05:25:43 INFO - PID 4292 | Values: 117.0 115.0 116.0 117.0 114.0 115.0 115.0 116.0 121.0 118.0 05:25:43 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:3.38 (2.1%) stddev-sans-first:3.50 05:25:43 INFO - PID 4292 | Values: 162.0 161.0 163.0 162.0 162.0 163.0 172.0 168.0 164.0 164.0 05:25:43 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | [#3] audio-fft Cycles:10 Average:75.20 Median:75.50 stddev:1.32 (1.7%) stddev-sans-first:1.32 05:25:43 INFO - PID 4292 | Values: 74.0 75.0 76.0 74.0 74.0 74.0 75.0 76.0 78.0 76.0 05:25:43 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | [#4] audio-oscillator Cycles:10 Average:79.90 Median:80.00 stddev:0.88 (1.1%) stddev-sans-first:0.83 05:25:43 INFO - PID 4292 | Values: 81.0 79.0 79.0 80.0 80.0 80.0 81.0 79.0 81.0 79.0 05:25:43 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:1.25 (1.1%) stddev-sans-first:1.32 05:25:43 INFO - PID 4292 | Values: 114.0 117.0 112.0 113.0 114.0 114.0 114.0 114.0 114.0 114.0 05:25:43 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:2.13 (1.4%) stddev-sans-first:2.26 05:25:43 INFO - PID 4292 | Values: 148.0 154.0 147.0 147.0 147.0 148.0 147.0 148.0 148.0 147.0 05:25:43 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:98.00 stddev:1.49 (1.5%) stddev-sans-first:1.56 05:25:43 INFO - PID 4292 | Values: 98.0 98.0 98.0 96.0 98.0 96.0 98.0 98.0 99.0 94.0 05:25:43 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.34 (2.5%) stddev-sans-first:1.13 05:25:43 INFO - PID 4292 | Values: 56.0 53.0 54.0 55.0 53.0 54.0 55.0 53.0 52.0 52.0 05:25:43 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | [#9] json-stringify-tinderbox Cycles:10 Average:37.30 Median:37.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 05:25:43 INFO - PID 4292 | Values: 37.0 38.0 38.0 37.0 37.0 37.0 38.0 37.0 37.0 37.0 05:25:43 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:1.62 (2.1%) stddev-sans-first:1.58 05:25:43 INFO - PID 4292 | Values: 78.0 79.0 75.0 74.0 76.0 78.0 75.0 75.0 76.0 76.0 05:25:43 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:122.00 stddev:5.09 (4.2%) stddev-sans-first:5.39 05:25:43 INFO - PID 4292 | Values: 119.0 117.0 123.0 129.0 116.0 126.0 122.0 113.0 122.0 115.0 05:25:43 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:173.00 stddev:4.33 (2.5%) stddev-sans-first:4.58 05:25:43 INFO - PID 4292 | Values: 171.0 170.0 174.0 166.0 169.0 182.0 173.0 169.0 174.0 173.0 05:25:43 INFO - PID 4292 | 05:25:43 INFO - PID 4292 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.64 (2.5%) stddev-sans-first:1.73 05:25:43 INFO - PID 4292 | Values: 65.0 65.0 64.0 67.0 62.0 65.0 66.0 62.0 65.0 66.0 05:25:43 INFO - PID 4292 | -------- Summary: end -------- 05:25:43 INFO - PID 4292 | 05:25:44 INFO - PID 4292 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:25:44 INFO - TEST-INFO | 4292: exit 0 05:25:44 INFO - TEST-OK | kraken | took 62371ms 05:25:44 INFO - SUITE-END | took 1175s 05:25:44 INFO - Completed test suite (00:19:35) 05:25:44 INFO - javascript benchmark 05:25:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8495.359490769277, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.612548431446, 3107.5183346581275, 3112.42420152272, 3121.82829944353, 3138.419392412404, 6081.695915204233, 6163.8150855474405, 6190.473809726173, 6273.341299163585, 6294.370562943704, 6159.0, 6193.411625895544, 6215.3784621537825, 6231.283402408724, 6245.4066863647995, 5726.828195154152, 5757.481826635602, 5841.707914604274, 5852.824415267549, 5932.228810254661, 5678.0915053591225, 5767.740451679663, 5779.595428320019, 5803.042497987848, 5804.622699524539, 5634.239377684001, 5701.0, 5725.227094342273, 5783.392743761908, 5842.0, 5753.309602847643, 5812.157237200625, 5813.360530341659, 5862.06207006879, 5893.852653683649, 5574.163875418679, 5698.715064246812, 5721.084626459747, 5743.9660861044995, 5776.740046697909, 6118.1434599156155, 6245.406686364788, 6298.0, 6302.023186406114, 6341.80974570759, 6692.297308782557, 6712.295209003082, 6799.11611490508, 6804.421624161952, 6816.147981502312, 6514.641694706789, 6584.539082264243, 6611.471082313452, 6746.730130794763, 6840.3501667341525, 6145.569810113294, 6161.44546990773, 6185.443310102112, 6193.225846769154, 6238.563300568962, 6852.211995620568, 7018.719251229996, 7033.120859892513, 7033.191183013917, 7055.823604409931, 6617.371349721769, 6624.105745724362, 6683.331666833375, 6684.598924064571, 6718.193816742022, 6595.967020164869, 6666.133402657623, 6666.666666666647, 6677.165354330708, 6710.295418981034, 6709.094272273278, 6727.663616819237, 6730.730770769114, 6735.461163106939, 6737.292584278678, 6686.866262674816, 6687.598744075371, 6713.832154196184, 6721.327867213239, 6811.386975172259, 5110.361204849394, 5188.9740551297755, 5258.6581872178185, 5339.519443250126, 5348.438413966555, 4647.930281045787, 4650.162970665313, 4681.461631912305, 4735.739534325577, 4743.596794272526, 5743.1385292206505, 5749.511291540182, 5807.883842323215, 5814.970925145347, 5815.9709201453725, 6705.932940670628, 6705.966470167618, 6754.763583274562, 6829.043933849265, 6831.2144103428745, 5749.080147176515, 5753.424657534213, 5760.6255593386295, 5766.452187042224, 5776.653400795965, 5725.656460612377, 5789.913151302734, 5794.275715535558, 5808.099744539603, 5810.593258471951, 6331.430171284606, 6409.974404095322, 6424.71088801005, 6527.804165875032, 6544.214694236722, 6523.412892839572, 6530.444912182517, 6536.705848236936, 6539.0, 6567.835804104936, 6371.649559274284, 6372.490200784019, 6381.138546296191, 6383.0744542042075, 6417.133686952388, 6629.701663425254, 6670.799876003728, 6703.396694297341, 6719.361660642231, 6733.0573719678305, 6715.899261511179, 6724.865502690017, 6733.595984240961, 6817.965910170417, 6826.078479405217, 6223.502119830312, 6320.936790632219, 6468.353164683494, 6474.320196379501, 6590.143281373391, 6544.0, 6553.311902250386, 6555.868882622225, 6560.147180866456, 6561.1470508833545, 6460.709268083042, 6466.06242094903, 6506.056621789909, 6512.251091124582, 6522.836929076811, 6452.838679033061, 6489.1888513935755, 6572.178477690289, 6642.136522252076, 6662.200535935525, 6124.326324104434, 6214.875702486015, 6350.904736428864, 6419.2938776735455, 6439.034144878306], "value": 6102.305907325455, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.6288888555707, 843.2073850580458, 878.8681697745337, 884.1467983396018, 884.7522693645782, 37533.43699844501, 41146.0, 41344.17311653765, 41347.79326103373, 41435.585644143546, 37357.0, 38702.61297387025, 38796.80601596988, 38809.0, 38810.8356749298, 6984.5809251444825, 7066.3993560547415, 7067.116610423697, 7067.151941766995, 7067.399271061966, 6956.582605043688, 7030.402415794663, 7039.120109986252, 7042.68307926142, 7057.294270572953, 7028.508004439691, 7037.824054398629, 7057.752978645748, 7062.187848397423, 7707.884381734279, 7790.143084260727, 7801.648925798353, 7850.528968261894, 7855.0, 7857.528548287121, 7643.656035478361, 7716.2669546393, 7716.845663086763, 7717.228277172294, 7719.536827790294, 37853.24293514114, 38699.61300387017, 38700.0, 38709.419358709645, 38712.80643596792, 3581.247937933037, 3629.6188900165366, 3629.8366573504254, 3630.8366123524506, 3633.5094762207027, 32327.6767232327, 32365.352692946246, 32397.190070248198, 32417.351652967045, 32589.511157332658, 5203.661761985497, 5214.582833373359, 5222.216667499867, 5227.18978558324, 5283.498067683564, 176692.0, 178413.0, 178997.10501447538, 179670.10164949222, 180199.0, 41614.791926040176, 42096.0, 47541.28688069682, 47558.28662570064, 47842.52157478381, 50579.0, 50582.49417505778, 50615.493845061814, 50645.0, 50671.0, 15946.60133496672, 16055.67888642244, 16066.518004459886, 16069.919650401673, 16076.43732469358, 13180.0, 13222.735545289233, 13223.0, 13223.867761322264, 13254.204747715168, 13918.860811391958, 14045.648858778612, 14089.788653170212, 14098.365573549216, 14212.431502739775, 5848.619839710405, 5857.326407463111, 5866.266716660418, 5878.735456904449, 5911.261092363455, 1012.6202673997251, 1017.5878769098526, 1029.3926583315879, 1034.79821434821, 1035.0684384054412, 22731.659025114637, 22772.2029728962, 22919.427014324443, 23211.0, 23517.0, 1095.2114477576292, 1096.9561217551209, 1115.5593540551438, 1117.4245263689206, 1120.4957769003981, 12012.939935300443, 12080.577179798665, 12121.69695757613, 12125.878741212651, 12201.145919785708, 225286.0, 225448.0, 225681.0, 225825.0, 228535.0, 51872.0, 51945.48054519406, 52246.21630675543, 52274.0, 52279.21581176286, 1413.6465883529117, 1448.717500087473, 1451.1583281696592, 1451.2308476507467, 1453.3605213705935, 22257.0, 22375.104995799986, 22452.0, 22487.437814054778, 23065.88467057654, 36737.448938265414, 36899.0, 36986.44520332143, 36995.63004369922, 37010.0, 185098.0, 185198.0, 185546.0, 185857.0, 186056.0, 33430.33139337151, 34612.0, 35273.294534109686, 35371.82314088413, 35407.29185416329, 44225.55774442214, 45400.0, 45623.0, 45919.08161836678, 45972.0, 33270.334593308486, 33282.83358583289, 33515.83242083774, 33790.49314260337, 33953.49069763906, 32793.0, 32862.94857759864, 33048.50427243641, 33129.50305745464, 33439.66560334365, 37196.62803371932, 37416.438753419265, 37430.62569374272, 37454.25091498209, 37576.248475030894, 32333.191670208435, 32362.0, 32369.0, 32513.187170320933, 32849.34301314008, 24084.2905397002, 24220.273391798273, 24260.75739242585, 24393.63409548894, 24633.876830615733], "value": 17034.961408171403, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.8009916430087, 556.4491153757781, 570.3184694290325, 576.9942300576994, 585.3765739487445, 21938.780612193874, 22771.08915643372, 22772.316830495092, 22791.430214244632, 22840.543189136206, 22823.54352912941, 23935.521289574197, 24317.878410607966, 24513.87743061282, 24741.0, 6243.313235544087, 6344.238691357021, 6374.968125159367, 6382.042693595951, 6401.391867772554, 6133.907991380132, 6187.288461826903, 6293.150424692677, 6298.0, 6301.873962520747, 6378.617282963037, 6408.743650253984, 6409.8397540061405, 6434.7747828826, 6438.420542151205, 6414.583052101621, 6434.742610295559, 6436.967815160918, 6442.162518872564, 6448.065030570588, 6649.501287403464, 6946.965265173692, 6991.82520436988, 6996.545224560438, 6997.055397521321, 29418.0, 29907.401851963055, 29918.401631967456, 29949.850250748827, 30056.699433005608, 2048.3342913553156, 2072.108993132952, 2072.751269847613, 2072.9481762955897, 2073.2225415469197, 19481.902590487098, 20006.49983750418, 20363.796362036337, 20364.5927081459, 20403.285884993955, 2514.8742562871785, 2539.606361014046, 2593.0405749872666, 2594.169865642995, 2597.4415500667446, 114829.0, 120979.0, 121064.39467802693, 126631.36684316612, 129420.0, 19609.313674021625, 20207.898960505398, 20252.772195058533, 21884.562308753735, 21930.342089737333, 40909.38635920463, 40956.0, 41169.58830411718, 41200.793996029824, 41267.7936610315, 11147.888521114848, 11159.944200278947, 11188.888111118784, 11313.434328283553, 11326.773464530663, 9265.72202833916, 9296.488693121808, 9365.719028429157, 9374.5781439834, 9458.810823783624, 10542.209334299805, 10720.195985301134, 10780.838287425695, 10841.349519028883, 11378.943105284421, 3491.336646037245, 3565.0, 3703.4259689748133, 4130.648894843912, 4177.7257936329715, 955.7992821507561, 972.2853702528636, 977.6040703515088, 994.309673554945, 996.6810620601337, 18745.7188142178, 18757.0, 18859.057047147588, 18924.71612925807, 19038.52403689891, 1018.791147814711, 1021.1830535571662, 1021.6219998600417, 1025.7128004158847, 1025.8512515685184, 10102.292839501311, 10158.187345012382, 10258.640947566799, 10606.57573697059, 10713.142948564097, 449283.75358123, 450925.0, 466597.0, 471716.0, 483917.0, 112009.43995279972, 112580.0, 114176.0, 116248.0, 117238.0, 1024.2318261304022, 1079.1420820447763, 1134.9375784331776, 1155.0874808900874, 1185.9525618975144, 19516.60966780628, 19540.706889396388, 19578.0, 19604.0, 19667.508312292306, 52210.0, 53294.0, 53530.0, 53749.0, 56572.434275658365, 67598.32401676117, 67635.0, 68047.0, 68352.0, 68686.0, 18700.532486687942, 19272.903635481733, 19345.032748362806, 19575.412737617895, 19728.802711973272, 22157.335279941628, 22299.554008919407, 22372.664410034187, 22521.43696407603, 22531.324060278217, 17823.0, 17875.821241787417, 18055.729164062814, 18100.366487172887, 18112.09439528045, 15636.140012299433, 15862.206889655241, 15993.960392574445, 16114.952528085636, 16304.592385190464, 17215.827841721424, 18181.0, 18297.81702182961, 18449.631007380045, 18786.966716830706, 19235.807641923962, 19314.227430903167, 19320.71018934689, 19322.033898304748, 19354.8064519353, 17785.0, 17908.55228619243, 17949.74351795362, 18052.18765155545, 18087.0], "value": 12528.031932657628, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.4182230729632, 1385.9445622175112, 1389.9235542045196, 1395.9441622335105, 1405.8102156208915, 14683.706325873476, 15257.694846103072, 15334.0, 15387.692246155084, 15400.075995440282, 15018.624534386647, 15166.241687915615, 15172.924135379335, 15191.164485953268, 15197.0, 2727.1409506005593, 2742.1773467959633, 2796.0353677981066, 2798.3703666674937, 2799.538076217422, 2722.863856807152, 2745.574435962419, 2757.8758955846934, 2761.7514423701864, 2762.502749505088, 2272.943176420586, 2358.2335740884196, 2359.1860808021293, 2659.734026597344, 2765.0322387164433, 2625.094342451851, 2627.080521817358, 2653.2703506535663, 2654.9469010619678, 2655.681318241804, 2693.8383696978244, 2706.6075419064127, 2709.3497560585515, 2710.2004908552026, 2719.2250208690625, 14655.120692758363, 14969.925150374178, 14974.101553906801, 14986.0, 15050.924745376313, 7619.923800761977, 7883.921160788376, 7901.328387087105, 7929.881051784228, 7945.841083178362, 4819.614430845524, 5089.236614507817, 5168.689878607295, 5292.153255479105, 5323.680579165262, 1881.6518943995404, 1895.5640202753443, 1963.626910886927, 1966.3412756726514, 2016.6571682813958, 26692.73307266922, 26740.8662956684, 26764.73235267642, 26774.866125669247, 26795.73204267952, 7262.96368518154, 7284.123110831289, 7303.926960730431, 7341.88987165193, 7410.481266311414, 20169.39491815248, 20247.291344803154, 20328.186872525228, 20376.898115509328, 20386.0, 7138.607376594233, 7271.381932535794, 7286.599237042014, 7289.781306560812, 7297.708091676273, 6254.593451425642, 6336.271328797156, 6343.460805831463, 6348.936510634927, 6371.426571608577, 5572.0, 5641.435856414408, 5696.259486266758, 5704.714764261853, 5749.770009199585, 1740.808511063782, 1772.273367919147, 1775.1301862087485, 1789.7225929980873, 1799.1004497751123, 735.5329365852615, 869.573908784691, 893.946363218209, 902.7743064233941, 906.7053207707521, 8176.6320515576945, 8409.663613455394, 8450.492970421794, 8471.322294216448, 8508.489490630582, 989.9851502227473, 992.1665800727424, 997.7555498902815, 999.6051559633904, 1004.251832384878, 4939.357883475197, 5035.420926593415, 5128.538431541179, 5138.049460849755, 5265.973670131625, 20731.378058658265, 20739.58520829575, 21988.780112198994, 21992.120315187534, 21996.340109796733, 20859.8957005214, 21228.78771212299, 21463.67804482934, 21535.353939381843, 21607.243746468797, 10584.523696433678, 10753.946230268799, 10826.783464330827, 10832.620858269922, 10977.12183025356, 8138.593070346577, 8216.301614362847, 8233.34133269325, 8262.42163048605, 8284.171582841667, 17667.0, 18605.34881279203, 18643.533911652317, 19191.52021199481, 19304.0, 19117.522061948563, 19257.32599359072, 19366.4190074298, 19852.0, 20022.59954800925, 11562.826557601811, 11717.472713727731, 11768.117391195523, 11777.646670599554, 11792.70518237051, 13493.39279732434, 13778.035537512678, 13915.095518791652, 13916.0, 13937.930310348384, 11159.832602510807, 11169.609063682732, 11315.20793544444, 11481.885181148082, 11712.297262164297, 9850.408975461496, 9969.40183588987, 10119.0, 10325.483725813529, 10400.167986560906, 9232.95383523078, 9301.627934882528, 9363.204127648954, 9447.716568502956, 9460.432374057578, 6784.76253331131, 6807.5575087619145, 6903.930960690329, 6909.170899492093, 6915.412189963708, 6797.72809087631, 6837.897431538431, 6900.137482814648, 6946.930530694831, 6975.197852247056], "value": 6651.5508183885795, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.5736623869709, 504.6114491841282, 518.9802038993378, 525.9526642602166, 532.3053415293043, 6244.157973397847, 6293.874122517553, 6312.652804095773, 6357.205349331333, 6408.333833203365, 6278.560500764948, 6293.370662933704, 6306.558540902139, 6323.841903952403, 6341.207349081354, 5142.717150556718, 5164.354455693038, 5206.281926964093, 5207.073382848352, 5228.73856307185, 4908.429302623162, 5057.519535644126, 5153.201253805666, 5188.974055129719, 5231.555317797992, 4979.775910084055, 4987.925181122286, 5003.124453220672, 5017.9247311290355, 5037.571806396442, 4988.800447982077, 5022.472640372781, 5035.823746168867, 5067.39191297043, 5083.771230294646, 4386.122775444892, 4468.575485328888, 4468.731876087445, 4484.641228701696, 4499.977500112478, 6034.155218269446, 6092.634441933498, 6139.355367686373, 6153.630782153085, 6172.87654246917, 5686.2039314496005, 5708.945714042967, 5714.171445140473, 5741.856453588652, 5783.971080144573, 6608.570442921243, 6619.437347825441, 6621.801345959629, 6622.18557113225, 6688.866222675568, 4880.463149053601, 4892.706437613754, 4893.4617192108835, 4933.0, 4933.851984440473, 6638.966805165944, 6691.1636045494315, 6876.1748590169, 6912.723491060352, 6981.162260528718, 4775.450823155312, 4959.801607935714, 4970.850874473772, 5028.5977121830165, 5037.29477873098, 5068.670536415195, 5075.137226671474, 5092.159793634083, 5093.9490605094215, 5094.465081166498, 5654.15187721845, 5676.120201368794, 5713.857153571194, 5713.857153571194, 5721.656700597978, 6659.966700166468, 6685.732570697215, 6704.7988560343265, 6725.2602213756445, 6740.258571557125, 1740.7283495038841, 1766.7703198584102, 1770.805211426742, 1772.6188869392884, 1779.7686300781074, 1172.3141961952354, 1221.0414824362833, 1227.098082909061, 1228.5147366790247, 1232.5501192064833, 5794.884102318014, 5797.652140871562, 5820.534357251409, 5838.5329173666005, 5851.063829787298, 6588.86822263552, 6765.154355705537, 6795.306622976364, 6837.179538455417, 6919.308069193041, 5654.74553645087, 5704.486596206279, 5709.687576531428, 5717.199592057115, 5804.910232316362, 3579.302036102935, 3594.191306955914, 3608.693261072838, 3623.836927338223, 3626.5104210931713, 6481.611103333815, 6523.630037692138, 6554.541182117301, 6597.812393769072, 6646.900296495556, 6572.666703320252, 6985.930140698528, 7009.264027277062, 7017.92982070183, 7027.051348067946, 6554.344565543408, 6568.1789776277965, 6568.474522038226, 6589.571677840829, 6596.934030659632, 6836.179658441019, 6868.347506986828, 6891.0, 6893.620850853051, 6912.930870691229, 6756.763513277012, 6843.3840954314355, 6850.417714494324, 6871.553349032497, 6880.827979300558, 6493.902591461227, 6497.675116244263, 6578.5395022347975, 6603.0, 6633.270340262664, 4994.225894986283, 5015.623828212826, 5033.949660503348, 5038.168702164248, 5055.772490238021, 6431.196100487439, 6561.507886908596, 6711.765088221889, 6732.821756192745, 6803.9319606805275, 6504.317046710027, 6505.739770409131, 6522.804315870341, 6607.735690572324, 6639.800805975829, 6474.643894585843, 6497.447716943923, 6535.803925882231, 6585.473162147113, 6588.934110659024, 6402.90395644075, 6439.356064393523, 6490.221173459215, 6537.182852143482, 6598.472122230114, 6608.636524991171, 6645.0097456145895, 6660.0, 6681.899771503528, 6711.765088221889, 6347.301796802441, 6362.522810789117, 6368.522360822864, 6385.96807015962, 6519.511036672174], "value": 5098.912771808688, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.7438768369487, 872.110447343709, 890.9376343655945, 891.4517571693407, 894.217559635319, 19250.22999080037, 19602.215911363564, 19607.019649017544, 19645.901770491128, 19774.209031638737, 17651.117444127805, 17836.375726849565, 18074.096295185253, 18094.0, 18094.366697165602, 942.4439580647417, 956.7225504603657, 959.1751094059103, 959.904009599038, 960.3757557587554, 988.7280997725647, 990.267202270322, 990.747359423346, 992.7666998255404, 992.791513782103, 994.960201591939, 1032.2000449651505, 1034.2191645307782, 1041.7760181560964, 1044.5143008501045, 1015.6648306058983, 1022.7034160093564, 1025.2823023883275, 1026.1329176845554, 1026.2918586175515, 723.9348458638748, 743.3718507860849, 752.1087511299128, 755.4598462099625, 756.2777547442234, 19377.0, 19575.0, 19590.0, 19631.705524417146, 19634.901825490924, 20781.688274675893, 20792.27227047046, 21658.133674652996, 21831.345059648236, 21847.890760546095, 16408.589785255346, 16472.917635411864, 16547.83452165475, 16561.171941403, 16785.748213776802, 3669.87155449558, 3699.7965111918834, 3700.5004324416127, 3702.0559757261994, 3702.0559757261994, 97923.52557365801, 125665.0, 129662.0, 137809.0, 139671.0, 16285.430009949594, 16820.158992050594, 16919.23863426149, 16942.0, 16946.0, 30418.847905760773, 30574.38851222963, 31250.843745781127, 31315.373692526024, 31335.0, 8253.546054967035, 8290.253877151084, 8300.169983001771, 8313.83372332562, 8318.292945099613, 4160.18876319121, 4179.393987871802, 4236.639885609758, 4245.150969806051, 4297.763623000703, 5303.231031500411, 5379.838604841861, 5385.838424847261, 5393.460653934575, 5413.729313534308, 1023.7901230247782, 1045.8065257927308, 1058.0, 1060.8886066962857, 1061.8035663402295, 636.5067073018355, 648.6075924065966, 657.2047822135174, 670.1489108831756, 671.090672139254, 10414.479276036167, 10712.303700259614, 10765.89234107649, 11058.557657693602, 11064.004239618473, 647.3785166240368, 655.1548502431905, 661.1966460750211, 665.7037618259828, 666.9533132680666, 4779.689320194177, 4814.7833347499445, 4828.179209534387, 4912.852614421573, 4914.803407863646, 122700.38649806872, 124908.0, 126153.0, 126690.36654816667, 128330.0, 106280.0, 108212.0, 109584.4520777391, 111512.44243778891, 113616.0, 91588.10333887866, 93202.0, 95770.52114739381, 95784.04215957891, 97254.99999999859, 8920.197182253629, 8983.865242021244, 9026.593803278736, 9027.684031058881, 9087.909120908706, 41851.16297673969, 42423.0, 42782.57217427786, 42837.78581107199, 43252.35121473118, 54896.0, 55217.171742424696, 55408.72295638496, 56011.719941400035, 56103.0, 14346.0, 14502.0, 14773.92613036928, 14798.852011480178, 14813.481528146463, 15504.224788760292, 15657.60855978564, 15679.0, 15683.372665093724, 15691.450799221973, 13538.187708737507, 13583.728325433238, 13611.931940340235, 13717.108387954751, 13737.656558586115, 13877.583672489842, 13919.443222270997, 13946.023778335419, 14005.859941400864, 14099.788503172666, 13370.933145334211, 13381.130226535244, 13484.528041518499, 13675.24786136772, 13683.657908552366, 10118.645847395306, 10235.130013948898, 10276.691699249035, 10298.485075746332, 10504.842427363748, 10000.799984000134, 10006.799864002534, 10147.847782283125, 10205.132563732166, 10385.065344119066], "value": 8510.322120552411, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1428.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 107.0, 115.0, 107.0, 110.0, 111.0, 107.0, 107.0, 108.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 116.0, 117.0, 114.0, 115.0, 115.0, 116.0, 121.0, 118.0], "value": 116.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 162.0, 163.0, 172.0, 168.0, 164.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 74.0, 74.0, 74.0, 75.0, 76.0, 78.0, 76.0], "value": 75.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 79.0, 80.0, 80.0, 80.0, 81.0, 79.0, 81.0, 79.0], "value": 79.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 112.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 154.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 98.0, 96.0, 98.0, 96.0, 98.0, 98.0, 99.0, 94.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 55.0, 53.0, 54.0, 55.0, 53.0, 52.0, 52.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 37.0, 37.0, 37.0, 38.0, 37.0, 37.0, 37.0], "value": 37.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 75.0, 74.0, 76.0, 78.0, 75.0, 75.0, 76.0, 76.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 123.0, 129.0, 116.0, 126.0, 122.0, 113.0, 122.0, 115.0], "value": 120.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 174.0, 166.0, 169.0, 182.0, 173.0, 169.0, 174.0, 173.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 67.0, 62.0, 65.0, 66.0, 62.0, 65.0, 66.0], "value": 64.7, "unit": "score"}]}]} 05:25:44 INFO - Return code: 0 05:25:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:25:45 INFO - # TBPL SUCCESS # 05:25:45 INFO - Running post-action listener: _package_coverage_data 05:25:45 INFO - Running post-action listener: _resource_record_post_action 05:25:45 INFO - [mozharness: 2017-09-09 12:25:45.062808Z] Finished run-tests step (success) 05:25:45 INFO - Running post-run listener: _resource_record_post_run 05:25:45 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8581120; Write bytes: 411987968; Read time: 2164; Write time: 434116 05:25:45 INFO - TinderboxPrint: CPU usage
13.1% 05:25:45 INFO - TinderboxPrint: I/O read bytes / time
8,581,120 / 2,164 05:25:45 INFO - TinderboxPrint: I/O write bytes / time
411,987,968 / 434,116 05:25:45 INFO - TinderboxPrint: CPU idle
8,263.4 (86.9%) 05:25:45 INFO - TinderboxPrint: CPU user
1,192.8 (12.5%) 05:25:45 INFO - TinderboxPrint: Swap in / out
0 / 0 05:25:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 557056; Read time: 0; Write time: 68 05:25:45 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:25:45 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6836224; Write bytes: 411430912; Read time: 2124; Write time: 434048 05:25:45 INFO - Running post-run listener: _upload_blobber_files 05:25:45 INFO - Blob upload gear active. 05:25:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:25:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:25:46 INFO - (blobuploader) - INFO - Open directory for files ... 05:25:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 05:25:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 05:25:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:47 INFO - (blobuploader) - INFO - Done attempting. 05:25:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:25:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:25:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:53 INFO - (blobuploader) - INFO - Done attempting. 05:25:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:25:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:25:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:54 INFO - (blobuploader) - INFO - Done attempting. 05:25:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 05:25:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 05:25:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:55 INFO - (blobuploader) - INFO - Done attempting. 05:25:55 INFO - (blobuploader) - INFO - Iteration through files over. 05:25:55 INFO - Return code: 0 05:25:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:25:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:25:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/940844938e5b741ccc56f880c5e6069bffa522c9894122fc23e75ae0cc365f06c6d82b780c56916b6a352c7f88452147ea8b6362ae089c98d17e62bbde300d32", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d14511f768ef8b41dc4eb05705afd448da888145d6c3cd08168858e0938c8206470ff12a9c13e9943a121fef53e4cdbcc60b8797fc8fce2a4bfa332def2cfec5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fc89dfde997e2217fa70f924b816a94cfa4f224cb9fb66bb47cb17aa53be7d5e19ac4e00a87dab18b55f8edb0beb7588616f6f87cbd4e2acef12a93db5ef09d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2366274c69b0cdcc90106bbbfb4e8361b060fa7ecffc82fc8ebc9ca3f85d70d863ec8d3f16bc9edcd3e59826cc4785f289566fd165e8ac9e16b56c7a75e86bad"} 05:25:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:25:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:25:55 INFO - Contents: 05:25:55 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/940844938e5b741ccc56f880c5e6069bffa522c9894122fc23e75ae0cc365f06c6d82b780c56916b6a352c7f88452147ea8b6362ae089c98d17e62bbde300d32", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d14511f768ef8b41dc4eb05705afd448da888145d6c3cd08168858e0938c8206470ff12a9c13e9943a121fef53e4cdbcc60b8797fc8fce2a4bfa332def2cfec5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fc89dfde997e2217fa70f924b816a94cfa4f224cb9fb66bb47cb17aa53be7d5e19ac4e00a87dab18b55f8edb0beb7588616f6f87cbd4e2acef12a93db5ef09d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2366274c69b0cdcc90106bbbfb4e8361b060fa7ecffc82fc8ebc9ca3f85d70d863ec8d3f16bc9edcd3e59826cc4785f289566fd165e8ac9e16b56c7a75e86bad"} 05:25:55 INFO - Running post-run listener: copy_logs_to_upload_dir 05:25:55 INFO - Copying logs to upload dir... 05:25:55 INFO - mkdir: /builds/slave/test/build/upload/logs 05:25:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.034674 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-09 05:25:55.728489) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 05:25:55.733261) ========= 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=9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617 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/940844938e5b741ccc56f880c5e6069bffa522c9894122fc23e75ae0cc365f06c6d82b780c56916b6a352c7f88452147ea8b6362ae089c98d17e62bbde300d32", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d14511f768ef8b41dc4eb05705afd448da888145d6c3cd08168858e0938c8206470ff12a9c13e9943a121fef53e4cdbcc60b8797fc8fce2a4bfa332def2cfec5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fc89dfde997e2217fa70f924b816a94cfa4f224cb9fb66bb47cb17aa53be7d5e19ac4e00a87dab18b55f8edb0beb7588616f6f87cbd4e2acef12a93db5ef09d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2366274c69b0cdcc90106bbbfb4e8361b060fa7ecffc82fc8ebc9ca3f85d70d863ec8d3f16bc9edcd3e59826cc4785f289566fd165e8ac9e16b56c7a75e86bad"} build_url:https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/940844938e5b741ccc56f880c5e6069bffa522c9894122fc23e75ae0cc365f06c6d82b780c56916b6a352c7f88452147ea8b6362ae089c98d17e62bbde300d32", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d14511f768ef8b41dc4eb05705afd448da888145d6c3cd08168858e0938c8206470ff12a9c13e9943a121fef53e4cdbcc60b8797fc8fce2a4bfa332def2cfec5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fc89dfde997e2217fa70f924b816a94cfa4f224cb9fb66bb47cb17aa53be7d5e19ac4e00a87dab18b55f8edb0beb7588616f6f87cbd4e2acef12a93db5ef09d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2366274c69b0cdcc90106bbbfb4e8361b060fa7ecffc82fc8ebc9ca3f85d70d863ec8d3f16bc9edcd3e59826cc4785f289566fd165e8ac9e16b56c7a75e86bad"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 05:25:55.764297) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 05:25:55.764614) ========= 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=9f7544b6a75ada7b6b576032000001a7-1504958709.996747-381596617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 05:25:55.844807) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 05:25:55.848132) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 05:25:55.848423) ========= ========= Total master_lag: 0.18 =========