builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-061 starttime: 1505034607.41 results: success (0) revision: 00baeed193d4f276694912f0298336880280837d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-10 02:10:07.414135) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-10 02:10:07.414605) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-10 02:10:07.414877) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-10 02:10:07.432741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 02:10:07.433130) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-10 02:10:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.7M=0s 2017-09-10 02:10:07 (41.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146946 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 02:10:07.596713) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 02:10:07.597122) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017422 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 02:10:07.646728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 02:10:07.647079) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 00baeed193d4f276694912f0298336880280837d --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 00baeed193d4f276694912f0298336880280837d --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=516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-10 02:10:07,717 truncating revision to first 12 chars 2017-09-10 02:10:07,717 Setting DEBUG logging. 2017-09-10 02:10:07,717 attempt 1/10 2017-09-10 02:10:07,717 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/00baeed193d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-10 02:10:08,229 unpacking tar archive at: mozilla-central-00baeed193d4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.815200 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 02:10:08.570562) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-10 02:10:08.570881) ========= script_repo_revision: 00baeed193d4f276694912f0298336880280837d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-10 02:10:08.571277) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-10 02:10:08.571554) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-10 02:10:08.585020) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-09-10 02:10:08.585393) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:10:08 INFO - MultiFileLogger online at 20170910 02:10:08 in /builds/slave/test 02:10:08 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 02:10:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:10:08 INFO - {'append_to_log': False, 02:10:08 INFO - 'base_work_dir': '/builds/slave/test', 02:10:08 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:10:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:10:08 INFO - 'branch': 'Firefox-Non-PGO', 02:10:08 INFO - 'buildbot_json_path': 'buildprops.json', 02:10:08 INFO - 'code_coverage': False, 02:10:08 INFO - 'config_files': ('talos/linux_config.py',), 02:10:08 INFO - 'default_actions': ('clobber', 02:10:08 INFO - 'read-buildbot-config', 02:10:08 INFO - 'download-and-extract', 02:10:08 INFO - 'populate-webroot', 02:10:08 INFO - 'create-virtualenv', 02:10:08 INFO - 'install', 02:10:08 INFO - 'setup-mitmproxy', 02:10:08 INFO - 'run-tests'), 02:10:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:10:08 INFO - 'disable_ccov_upload': False, 02:10:08 INFO - 'disable_stylo': False, 02:10:08 INFO - 'download_minidump_stackwalk': True, 02:10:08 INFO - 'download_symbols': 'ondemand', 02:10:08 INFO - 'enable_stylo': False, 02:10:08 INFO - 'enable_webrender': False, 02:10:08 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:10:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:10:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:10:08 INFO - 'gecko_profile': False, 02:10:08 INFO - 'gecko_profile_interval': 0, 02:10:08 INFO - 'installer_path': 'installer.exe', 02:10:08 INFO - 'log_level': 'info', 02:10:08 INFO - 'log_name': 'talos', 02:10:08 INFO - 'log_to_console': True, 02:10:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:10:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:10:08 INFO - 'opt_config_files': (), 02:10:08 INFO - 'pip_index': False, 02:10:08 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 02:10:08 INFO - 'system_bits': '32', 02:10:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:10:08 INFO - 'title': 'talos-linux64-ix-061', 02:10:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:10:08 INFO - 'use_talos_json': True, 02:10:08 INFO - 'verify': 'False', 02:10:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:10:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:10:08 INFO - 'work_dir': 'build'} 02:10:08 INFO - [mozharness: 2017-09-10 09:10:08.801728Z] Running clobber step. 02:10:08 INFO - Running pre-action listener: _resource_record_pre_action 02:10:08 INFO - Running main action method: clobber 02:10:08 INFO - rmtree: /builds/slave/test/build 02:10:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:10:10 INFO - Running post-action listener: _resource_record_post_action 02:10:10 INFO - [mozharness: 2017-09-10 09:10:10.354382Z] Finished clobber step (success) 02:10:10 INFO - [mozharness: 2017-09-10 09:10:10.354480Z] Running read-buildbot-config step. 02:10:10 INFO - Running pre-action listener: _resource_record_pre_action 02:10:10 INFO - Running main action method: read_buildbot_config 02:10:10 INFO - Using buildbot properties: 02:10:10 INFO - { 02:10:10 INFO - "project": "", 02:10:10 INFO - "product": "firefox", 02:10:10 INFO - "who": "archaeopteryx@coole-files.de", 02:10:10 INFO - "installer_path": "public/build/target.tar.bz2", 02:10:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 02:10:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:10:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 02:10:10 INFO - "stage_platform": "linux64", 02:10:10 INFO - "basedir": "/builds/slave/test", 02:10:10 INFO - "buildnumber": 6, 02:10:10 INFO - "platform": "ubuntu64_hw", 02:10:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:10:10 INFO - "slavebuilddir": "test", 02:10:10 INFO - "taskId": "DQQe0VTDRC-CDOO5mwlPrA", 02:10:10 INFO - "branch": "mozilla-central", 02:10:10 INFO - "script_repo_revision": "production", 02:10:10 INFO - "revision": "00baeed193d4f276694912f0298336880280837d", 02:10:10 INFO - "slavename": "talos-linux64-ix-061", 02:10:10 INFO - "repo_path": "mozilla-central" 02:10:10 INFO - } 02:10:10 INFO - Finding installer, test and symbols from parent task. 02:10:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DQQe0VTDRC-CDOO5mwlPrA'}, attempt #1 02:10:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DQQe0VTDRC-CDOO5mwlPrA'}, attempt #1 02:10:11 INFO - Task dependencies: DRhsJxRzQc2SbL7C1Z9-Ww 02:10:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww'}, attempt #1 02:10:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.tar.bz2 02:10:11 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.test_packages.json 02:10:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.crashreporter-symbols.zip 02:10:11 INFO - Running post-action listener: _resource_record_post_action 02:10:11 INFO - [mozharness: 2017-09-10 09:10:11.719167Z] Finished read-buildbot-config step (success) 02:10:11 INFO - [mozharness: 2017-09-10 09:10:11.719385Z] Running download-and-extract step. 02:10:11 INFO - Running pre-action listener: _resource_record_pre_action 02:10:11 INFO - Running main action method: download_and_extract 02:10:11 INFO - mkdir: /builds/slave/test/build/tests 02:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:11 INFO - trying https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.test_packages.json 02:10:11 INFO - Downloading https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:10:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:10:12 INFO - Downloaded 989 bytes. 02:10:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:10:12 INFO - Using the following test package requirements: 02:10:12 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:10:12 INFO - u'common': [u'target.common.tests.zip'], 02:10:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:10:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:10:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:10:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:10:12 INFO - u'mozbase': [u'target.common.tests.zip'], 02:10:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:10:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:10:12 INFO - u'web-platform': [u'target.common.tests.zip', 02:10:12 INFO - u'target.web-platform.tests.tar.gz'], 02:10:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:10:12 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 02:10:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.common.tests.zip 02:10:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:10:12 INFO - Fetch https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.common.tests.zip into memory 02:10:48 INFO - Content-Length response header: 55028609 02:10:48 INFO - Bytes received: 55028609 02:10:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.talos.tests.zip 02:10:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:10:59 INFO - Fetch https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.talos.tests.zip into memory 02:11:00 INFO - Content-Length response header: 14497963 02:11:00 INFO - Bytes received: 14497963 02:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:01 INFO - trying https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.tar.bz2 02:11:01 INFO - Downloading https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:11:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:11:03 INFO - Downloaded 62876814 bytes. 02:11:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.tar.bz2 02:11:03 INFO - mkdir: /builds/slave/test/properties 02:11:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:11:03 INFO - Writing to file /builds/slave/test/properties/build_url 02:11:03 INFO - Contents: 02:11:03 INFO - build_url:https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.tar.bz2 02:11:03 INFO - Running post-action listener: _resource_record_post_action 02:11:03 INFO - Running post-action listener: find_tests_for_verification 02:11:03 INFO - Running post-action listener: set_extra_try_arguments 02:11:03 INFO - [mozharness: 2017-09-10 09:11:03.326255Z] Finished download-and-extract step (success) 02:11:03 INFO - [mozharness: 2017-09-10 09:11:03.326446Z] Running populate-webroot step. 02:11:03 INFO - Running pre-action listener: _resource_record_pre_action 02:11:03 INFO - Running main action method: populate_webroot 02:11:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:11:03 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:11:03 INFO - 'tests': ['tresize', 02:11:03 INFO - 'tcanvasmark']}, 02:11:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:11:03 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:11:03 INFO - 'tests': ['dromaeo_css', 02:11:03 INFO - 'kraken']}, 02:11:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:11:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:11:03 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:11:03 INFO - 'talos_options': ['--disable-stylo'], 02:11:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:11:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:11:03 INFO - 'tests': ['damp', 'tps']}, 02:11:03 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:11:03 INFO - 'talos_options': ['--disable-stylo'], 02:11:03 INFO - 'tests': ['damp', 'tps']}, 02:11:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:11:03 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:11:03 INFO - 'tests': ['dromaeo_dom']}, 02:11:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:11:03 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:11:03 INFO - 'tests': ['basic_compositor_video', 02:11:03 INFO - 'glvideo']}, 02:11:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:11:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:11:03 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:11:03 INFO - 'talos_options': ['--disable-stylo'], 02:11:03 INFO - 'tests': ['ts_paint_webext', 02:11:03 INFO - 'tp5o_webext']}, 02:11:03 INFO - 'other-e10s': {'tests': ['a11yr', 02:11:03 INFO - 'ts_paint', 02:11:03 INFO - 'tpaint', 02:11:03 INFO - 'sessionrestore', 02:11:03 INFO - 'sessionrestore_many_windows', 02:11:03 INFO - 'sessionrestore_no_auto_restore', 02:11:03 INFO - 'tabpaint']}, 02:11:03 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:11:03 INFO - 'tests': ['a11yr', 02:11:03 INFO - 'ts_paint', 02:11:03 INFO - 'tpaint', 02:11:03 INFO - 'sessionrestore', 02:11:03 INFO - 'sessionrestore_many_windows', 02:11:03 INFO - 'sessionrestore_no_auto_restore', 02:11:03 INFO - 'tabpaint']}, 02:11:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:11:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:11:03 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:11:03 INFO - 'tests': ['bloom_basic_singleton']}, 02:11:03 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:11:03 INFO - 'tests': ['bloom_basic']}, 02:11:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:11:03 INFO - 'tsvgr_opacity', 02:11:03 INFO - 'tart', 02:11:03 INFO - 'tscrollx', 02:11:03 INFO - 'tsvg_static']}, 02:11:03 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:11:03 INFO - 'tests': ['tsvgx', 02:11:03 INFO - 'tsvgr_opacity', 02:11:03 INFO - 'tart', 02:11:03 INFO - 'tscrollx', 02:11:03 INFO - 'tsvg_static']}, 02:11:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:11:03 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:11:03 INFO - 'talos_options': ['--disable-stylo'], 02:11:03 INFO - 'tests': ['tp5o']}, 02:11:03 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:11:03 INFO - 'talos_options': ['--mitmproxy', 02:11:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:11:03 INFO - '--firstNonBlankPaint'], 02:11:03 INFO - 'tests': ['tp6_google', 02:11:03 INFO - 'tp6_youtube', 02:11:03 INFO - 'tp6_amazon', 02:11:03 INFO - 'tp6_facebook']}, 02:11:03 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:11:03 INFO - 'talos_options': ['--disable-stylo', 02:11:03 INFO - '--mitmproxy', 02:11:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:11:03 INFO - '--firstNonBlankPaint'], 02:11:03 INFO - 'tests': ['tp6_google', 02:11:03 INFO - 'tp6_youtube', 02:11:03 INFO - 'tp6_amazon', 02:11:03 INFO - 'tp6_facebook']}, 02:11:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:11:03 INFO - 'talos_options': ['--stylo-threads=1', 02:11:03 INFO - '--mitmproxy', 02:11:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:11:03 INFO - '--firstNonBlankPaint'], 02:11:03 INFO - 'tests': ['tp6_google', 02:11:03 INFO - 'tp6_youtube', 02:11:03 INFO - 'tp6_amazon', 02:11:03 INFO - 'tp6_facebook']}, 02:11:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:11:03 INFO - 'talos_options': ['--xperf_path', 02:11:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:11:03 INFO - 'tests': ['tp5n']}, 02:11:03 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:11:03 INFO - 'talos_options': ['--disable-stylo', 02:11:03 INFO - '--xperf_path', 02:11:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:11:03 INFO - 'tests': ['tp5n']}}} 02:11:03 INFO - Running post-action listener: _resource_record_post_action 02:11:03 INFO - [mozharness: 2017-09-10 09:11:03.346393Z] Finished populate-webroot step (success) 02:11:03 INFO - [mozharness: 2017-09-10 09:11:03.346483Z] Running create-virtualenv step. 02:11:03 INFO - Running pre-action listener: _resource_record_pre_action 02:11:03 INFO - Running main action method: create_virtualenv 02:11:03 INFO - Creating virtualenv /builds/slave/test/build/venv 02:11:03 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:11:03 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:11:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:11:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:11:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:11:04 INFO - Installing distribute.............................................................................................................................................................................................done. 02:11:04 INFO - Installing pip...............done. 02:11:04 INFO - Return code: 0 02:11:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:11:04 INFO - Reading from file tmpfile_stdout 02:11:04 INFO - Output received: 02:11:04 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:11:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:11:04 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')]} 02:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:04 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')]} 02:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:04 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 0x170d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', '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 02:11:04 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 02:11:04 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 02:11:04 INFO - Using env: {'DISPLAY': ':0', 02:11:04 INFO - 'HOME': '/home/cltbld', 02:11:04 INFO - 'LANG': 'en_US.UTF-8', 02:11:04 INFO - 'LANGUAGE': 'en_US:en', 02:11:04 INFO - 'LOGNAME': 'cltbld', 02:11:04 INFO - 'MAIL': '/var/mail/cltbld', 02:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:04 INFO - 'MOZ_NO_REMOTE': '1', 02:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:04 INFO - 'NO_EM_RESTART': '1', 02:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:04 INFO - 'PWD': '/builds/slave/test', 02:11:04 INFO - 'SHELL': '/bin/bash', 02:11:04 INFO - 'SHLVL': '1', 02:11:04 INFO - 'TERM': 'linux', 02:11:04 INFO - 'TMOUT': '86400', 02:11:04 INFO - 'USER': 'cltbld', 02:11:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', 02:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:04 INFO - '_': '/tools/buildbot/bin/python'} 02:11:05 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:11:05 INFO - Downloading/unpacking pip>=1.5 02:11:05 INFO - Running setup.py egg_info for package pip 02:11:05 INFO - warning: no files found matching 'pip/cacert.pem' 02:11:05 INFO - warning: no files found matching '*.html' under directory 'docs' 02:11:05 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:11:05 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:11:05 INFO - Installing collected packages: pip 02:11:05 INFO - Found existing installation: pip 1.1 02:11:05 INFO - Uninstalling pip: 02:11:05 INFO - Successfully uninstalled pip 02:11:05 INFO - Running setup.py install for pip 02:11:05 INFO - warning: no files found matching 'pip/cacert.pem' 02:11:05 INFO - warning: no files found matching '*.html' under directory 'docs' 02:11:05 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:11:05 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:11:05 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:11:05 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:11:05 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:11:05 INFO - Successfully installed pip 02:11:05 INFO - Cleaning up... 02:11:05 INFO - Return code: 0 02:11:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:05 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 0x170d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', '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 02:11:05 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 02:11:05 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 02:11:05 INFO - Using env: {'DISPLAY': ':0', 02:11:05 INFO - 'HOME': '/home/cltbld', 02:11:05 INFO - 'LANG': 'en_US.UTF-8', 02:11:05 INFO - 'LANGUAGE': 'en_US:en', 02:11:05 INFO - 'LOGNAME': 'cltbld', 02:11:05 INFO - 'MAIL': '/var/mail/cltbld', 02:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:05 INFO - 'MOZ_NO_REMOTE': '1', 02:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:05 INFO - 'NO_EM_RESTART': '1', 02:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:05 INFO - 'PWD': '/builds/slave/test', 02:11:05 INFO - 'SHELL': '/bin/bash', 02:11:05 INFO - 'SHLVL': '1', 02:11:05 INFO - 'TERM': 'linux', 02:11:05 INFO - 'TMOUT': '86400', 02:11:05 INFO - 'USER': 'cltbld', 02:11:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', 02:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:05 INFO - '_': '/tools/buildbot/bin/python'} 02:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:05 INFO - Downloading/unpacking psutil>=3.1.1 02:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:11:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:11:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:11:07 INFO - Installing collected packages: psutil 02:11:07 INFO - Running setup.py install for psutil 02:11:07 INFO - building 'psutil._psutil_linux' extension 02:11:07 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 02:11:07 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 02:11:07 INFO - building 'psutil._psutil_posix' extension 02:11:07 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 02:11:07 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 02:11:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:11:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:11:07 INFO - Successfully installed psutil 02:11:07 INFO - Cleaning up... 02:11:07 INFO - Return code: 0 02:11:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', '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 02:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:11:07 INFO - Using env: {'DISPLAY': ':0', 02:11:07 INFO - 'HOME': '/home/cltbld', 02:11:07 INFO - 'LANG': 'en_US.UTF-8', 02:11:07 INFO - 'LANGUAGE': 'en_US:en', 02:11:07 INFO - 'LOGNAME': 'cltbld', 02:11:07 INFO - 'MAIL': '/var/mail/cltbld', 02:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:07 INFO - 'MOZ_NO_REMOTE': '1', 02:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:07 INFO - 'NO_EM_RESTART': '1', 02:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:07 INFO - 'PWD': '/builds/slave/test', 02:11:07 INFO - 'SHELL': '/bin/bash', 02:11:07 INFO - 'SHLVL': '1', 02:11:07 INFO - 'TERM': 'linux', 02:11:07 INFO - 'TMOUT': '86400', 02:11:07 INFO - 'USER': 'cltbld', 02:11:07 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', 02:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:07 INFO - '_': '/tools/buildbot/bin/python'} 02:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:11:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:11:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:11:08 INFO - Installing collected packages: mozsystemmonitor 02:11:08 INFO - Running setup.py install for mozsystemmonitor 02:11:10 INFO - Successfully installed mozsystemmonitor 02:11:10 INFO - Cleaning up... 02:11:10 INFO - Return code: 0 02:11:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:11:10 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')]} 02:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:10 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')]} 02:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:10 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 0x170d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', '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 02:11:10 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 02:11:10 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 02:11:10 INFO - Using env: {'DISPLAY': ':0', 02:11:10 INFO - 'HOME': '/home/cltbld', 02:11:10 INFO - 'LANG': 'en_US.UTF-8', 02:11:10 INFO - 'LANGUAGE': 'en_US:en', 02:11:10 INFO - 'LOGNAME': 'cltbld', 02:11:10 INFO - 'MAIL': '/var/mail/cltbld', 02:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:10 INFO - 'MOZ_NO_REMOTE': '1', 02:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:10 INFO - 'NO_EM_RESTART': '1', 02:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:10 INFO - 'PWD': '/builds/slave/test', 02:11:10 INFO - 'SHELL': '/bin/bash', 02:11:10 INFO - 'SHLVL': '1', 02:11:10 INFO - 'TERM': 'linux', 02:11:10 INFO - 'TMOUT': '86400', 02:11:10 INFO - 'USER': 'cltbld', 02:11:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', 02:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:10 INFO - '_': '/tools/buildbot/bin/python'} 02:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:10 INFO - Downloading/unpacking jsonschema==2.5.1 02:11:10 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 02:11:10 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 02:11:10 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 02:11:10 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 02:11:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:11:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:11:12 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 02:11:12 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 02:11:12 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 02:11:12 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 02:11:12 INFO - Downloading functools32-3.2.3-2.tar.gz 02:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:11:12 INFO - warning: no files found matching '*.txt' 02:11:12 INFO - no previously-included directories found matching 'build' 02:11:12 INFO - no previously-included directories found matching 'dist' 02:11:12 INFO - no previously-included directories found matching '.git*' 02:11:12 INFO - Installing collected packages: jsonschema, functools32 02:11:12 INFO - Running setup.py install for functools32 02:11:12 INFO - warning: no files found matching '*.txt' 02:11:12 INFO - no previously-included directories found matching 'build' 02:11:12 INFO - no previously-included directories found matching 'dist' 02:11:12 INFO - no previously-included directories found matching '.git*' 02:11:12 INFO - Successfully installed jsonschema functools32 02:11:12 INFO - Cleaning up... 02:11:12 INFO - Return code: 0 02:11:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:12 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 0x170d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', '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 02:11:12 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 02:11:12 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 02:11:12 INFO - Using env: {'DISPLAY': ':0', 02:11:12 INFO - 'HOME': '/home/cltbld', 02:11:12 INFO - 'LANG': 'en_US.UTF-8', 02:11:12 INFO - 'LANGUAGE': 'en_US:en', 02:11:12 INFO - 'LOGNAME': 'cltbld', 02:11:12 INFO - 'MAIL': '/var/mail/cltbld', 02:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:12 INFO - 'MOZ_NO_REMOTE': '1', 02:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:12 INFO - 'NO_EM_RESTART': '1', 02:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:12 INFO - 'PWD': '/builds/slave/test', 02:11:12 INFO - 'SHELL': '/bin/bash', 02:11:12 INFO - 'SHLVL': '1', 02:11:12 INFO - 'TERM': 'linux', 02:11:12 INFO - 'TMOUT': '86400', 02:11:12 INFO - 'USER': 'cltbld', 02:11:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', 02:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:12 INFO - '_': '/tools/buildbot/bin/python'} 02:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:11:12 INFO - Cleaning up... 02:11:12 INFO - Return code: 0 02:11:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:12 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 0x170d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', '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 02:11:12 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 02:11:12 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 02:11:12 INFO - Using env: {'DISPLAY': ':0', 02:11:12 INFO - 'HOME': '/home/cltbld', 02:11:12 INFO - 'LANG': 'en_US.UTF-8', 02:11:12 INFO - 'LANGUAGE': 'en_US:en', 02:11:12 INFO - 'LOGNAME': 'cltbld', 02:11:12 INFO - 'MAIL': '/var/mail/cltbld', 02:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:12 INFO - 'MOZ_NO_REMOTE': '1', 02:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:12 INFO - 'NO_EM_RESTART': '1', 02:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:12 INFO - 'PWD': '/builds/slave/test', 02:11:12 INFO - 'SHELL': '/bin/bash', 02:11:12 INFO - 'SHLVL': '1', 02:11:12 INFO - 'TERM': 'linux', 02:11:12 INFO - 'TMOUT': '86400', 02:11:12 INFO - 'USER': 'cltbld', 02:11:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', 02:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:12 INFO - '_': '/tools/buildbot/bin/python'} 02:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:12 INFO - Downloading/unpacking blobuploader==1.2.4 02:11:12 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 02:11:12 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 02:11:12 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 02:11:12 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 02:11:14 INFO - Downloading blobuploader-1.2.4.tar.gz 02:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:11:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:11:15 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 02:11:15 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 02:11:15 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 02:11:15 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 02:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:11:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:11:15 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 02:11:15 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 02:11:15 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 02:11:15 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 02:11:15 INFO - Downloading docopt-0.6.1.tar.gz 02:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:11:15 INFO - Installing collected packages: blobuploader, requests, docopt 02:11:15 INFO - Running setup.py install for blobuploader 02:11:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:11:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:11:15 INFO - Running setup.py install for requests 02:11:16 INFO - Running setup.py install for docopt 02:11:16 INFO - Successfully installed blobuploader requests docopt 02:11:16 INFO - Cleaning up... 02:11:16 INFO - Return code: 0 02:11:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:16 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 0x170d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', '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 02:11:16 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 02:11:16 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 02:11:16 INFO - Using env: {'DISPLAY': ':0', 02:11:16 INFO - 'HOME': '/home/cltbld', 02:11:16 INFO - 'LANG': 'en_US.UTF-8', 02:11:16 INFO - 'LANGUAGE': 'en_US:en', 02:11:16 INFO - 'LOGNAME': 'cltbld', 02:11:16 INFO - 'MAIL': '/var/mail/cltbld', 02:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:16 INFO - 'MOZ_NO_REMOTE': '1', 02:11:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:16 INFO - 'NO_EM_RESTART': '1', 02:11:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:16 INFO - 'PWD': '/builds/slave/test', 02:11:16 INFO - 'SHELL': '/bin/bash', 02:11:16 INFO - 'SHLVL': '1', 02:11:16 INFO - 'TERM': 'linux', 02:11:16 INFO - 'TMOUT': '86400', 02:11:16 INFO - 'USER': 'cltbld', 02:11:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', 02:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:16 INFO - '_': '/tools/buildbot/bin/python'} 02:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:11:16 INFO - Running setup.py (path:/tmp/pip-RDqQUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:11:16 INFO - Running setup.py (path:/tmp/pip-hkxDM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:11:16 INFO - Running setup.py (path:/tmp/pip-pUo7vW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:11:16 INFO - Running setup.py (path:/tmp/pip-GKXQku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:11:16 INFO - Running setup.py (path:/tmp/pip-DBibzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:11:16 INFO - Running setup.py (path:/tmp/pip-WuqY2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:11:16 INFO - Running setup.py (path:/tmp/pip-WZP_Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:11:16 INFO - Running setup.py (path:/tmp/pip-XD8kY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:11:16 INFO - Running setup.py (path:/tmp/pip-P7_Wr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:11:16 INFO - Running setup.py (path:/tmp/pip-KyEWzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:11:17 INFO - Running setup.py (path:/tmp/pip-z1zEFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:11:17 INFO - Running setup.py (path:/tmp/pip-guCjPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:11:17 INFO - Running setup.py (path:/tmp/pip-5NHcag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:11:17 INFO - Running setup.py (path:/tmp/pip-iDw0PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:17 INFO - Running setup.py (path:/tmp/pip-ynnQX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:11:17 INFO - Running setup.py (path:/tmp/pip-u84D9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:11:17 INFO - Running setup.py (path:/tmp/pip-kPMSo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:11:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:11:17 INFO - Running setup.py install for manifestparser 02:11:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:11:17 INFO - Running setup.py install for mozcrash 02:11:17 INFO - Running setup.py install for mozdebug 02:11:17 INFO - Running setup.py install for mozdevice 02:11:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:11:17 INFO - Running setup.py install for mozfile 02:11:18 INFO - Running setup.py install for mozhttpd 02:11:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:11:18 INFO - Running setup.py install for mozinfo 02:11:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:11:18 INFO - Running setup.py install for mozInstall 02:11:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:11:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:11:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:11:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:11:18 INFO - Running setup.py install for mozleak 02:11:18 INFO - Running setup.py install for mozlog 02:11:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:11:18 INFO - Running setup.py install for moznetwork 02:11:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:11:18 INFO - Running setup.py install for mozprocess 02:11:18 INFO - Running setup.py install for mozprofile 02:11:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:11:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:11:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:11:18 INFO - Running setup.py install for mozrunner 02:11:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:11:19 INFO - Running setup.py install for mozscreenshot 02:11:19 INFO - Running setup.py install for moztest 02:11:19 INFO - Running setup.py install for mozversion 02:11:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:11:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:11:19 INFO - Cleaning up... 02:11:19 INFO - Return code: 0 02:11:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:11:19 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')]} 02:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:19 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')]} 02:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:19 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 0x170d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', '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 02:11:19 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 02:11:19 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 02:11:19 INFO - Using env: {'DISPLAY': ':0', 02:11:19 INFO - 'HOME': '/home/cltbld', 02:11:19 INFO - 'LANG': 'en_US.UTF-8', 02:11:19 INFO - 'LANGUAGE': 'en_US:en', 02:11:19 INFO - 'LOGNAME': 'cltbld', 02:11:19 INFO - 'MAIL': '/var/mail/cltbld', 02:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:19 INFO - 'MOZ_NO_REMOTE': '1', 02:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:19 INFO - 'NO_EM_RESTART': '1', 02:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:19 INFO - 'PWD': '/builds/slave/test', 02:11:19 INFO - 'SHELL': '/bin/bash', 02:11:19 INFO - 'SHLVL': '1', 02:11:19 INFO - 'TERM': 'linux', 02:11:19 INFO - 'TMOUT': '86400', 02:11:19 INFO - 'USER': 'cltbld', 02:11:19 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', 02:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:19 INFO - '_': '/tools/buildbot/bin/python'} 02:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:11:19 INFO - Running setup.py (path:/tmp/pip-DaKhJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:11:19 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)) 02:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:11:19 INFO - Running setup.py (path:/tmp/pip-7l_YnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:11:19 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)) 02:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:11:19 INFO - Running setup.py (path:/tmp/pip-AwuInq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:11:19 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)) 02:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:11:19 INFO - Running setup.py (path:/tmp/pip-FLryHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:11:19 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)) 02:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:11:19 INFO - Running setup.py (path:/tmp/pip-KweHNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:11:19 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)) 02:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:11:19 INFO - Running setup.py (path:/tmp/pip-QhbkB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:11:19 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)) 02:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:11:19 INFO - Running setup.py (path:/tmp/pip-piqPxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:11:20 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)) 02:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:11:20 INFO - Running setup.py (path:/tmp/pip-6lxvb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:11:20 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)) 02:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:11:20 INFO - Running setup.py (path:/tmp/pip-ealoHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:11:20 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)) 02:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:11:20 INFO - Running setup.py (path:/tmp/pip-HMeotl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:11:20 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)) 02:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:11:20 INFO - Running setup.py (path:/tmp/pip-_iYvG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:11:20 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)) 02:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:11:20 INFO - Running setup.py (path:/tmp/pip-vZM9Dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:11:20 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)) 02:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:11:20 INFO - Running setup.py (path:/tmp/pip-ij4twD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:11:20 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)) 02:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:11:20 INFO - Running setup.py (path:/tmp/pip-0UMFFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:11:20 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)) 02:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:20 INFO - Running setup.py (path:/tmp/pip-rIMeWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:20 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)) 02:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:11:20 INFO - Running setup.py (path:/tmp/pip-QlkHUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:11:20 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)) 02:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:11:20 INFO - Running setup.py (path:/tmp/pip-VtPFNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:11:20 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)) 02:11:20 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)) 02:11:20 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)) 02:11:20 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)) 02:11:20 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)) 02:11:20 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)) 02:11:20 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)) 02:11:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:21 INFO - Downloading blessings-1.6.tar.gz 02:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:11:21 INFO - Installing collected packages: blessings 02:11:21 INFO - Running setup.py install for blessings 02:11:22 INFO - Successfully installed blessings 02:11:22 INFO - Cleaning up... 02:11:22 INFO - Return code: 0 02:11:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:11:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:11:22 INFO - Reading from file tmpfile_stdout 02:11:22 INFO - Current package versions: 02:11:22 INFO - argparse == 1.2.1 02:11:22 INFO - blessings == 1.6 02:11:22 INFO - blobuploader == 1.2.4 02:11:22 INFO - docopt == 0.6.1 02:11:22 INFO - functools32 == 3.2.3-2 02:11:22 INFO - jsonschema == 2.5.1 02:11:22 INFO - manifestparser == 1.1 02:11:22 INFO - mozInstall == 1.13 02:11:22 INFO - mozcrash == 1.0 02:11:22 INFO - mozdebug == 0.1 02:11:22 INFO - mozdevice == 0.51 02:11:22 INFO - mozfile == 1.2 02:11:22 INFO - mozhttpd == 0.7 02:11:22 INFO - mozinfo == 0.10 02:11:22 INFO - mozleak == 0.1 02:11:22 INFO - mozlog == 3.5 02:11:22 INFO - moznetwork == 0.27 02:11:22 INFO - mozprocess == 0.25 02:11:22 INFO - mozprofile == 0.28 02:11:22 INFO - mozrunner == 6.13 02:11:22 INFO - mozscreenshot == 0.1 02:11:22 INFO - mozsystemmonitor == 0.3 02:11:22 INFO - moztest == 0.8 02:11:22 INFO - mozversion == 1.4 02:11:22 INFO - psutil == 3.1.1 02:11:22 INFO - requests == 1.2.3 02:11:22 INFO - wsgiref == 0.1.2 02:11:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:22 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 0x170d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', '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 02:11:22 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 02:11:22 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 02:11:22 INFO - Using env: {'DISPLAY': ':0', 02:11:22 INFO - 'HOME': '/home/cltbld', 02:11:22 INFO - 'LANG': 'en_US.UTF-8', 02:11:22 INFO - 'LANGUAGE': 'en_US:en', 02:11:22 INFO - 'LOGNAME': 'cltbld', 02:11:22 INFO - 'MAIL': '/var/mail/cltbld', 02:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:22 INFO - 'MOZ_NO_REMOTE': '1', 02:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:22 INFO - 'NO_EM_RESTART': '1', 02:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:22 INFO - 'PWD': '/builds/slave/test', 02:11:22 INFO - 'SHELL': '/bin/bash', 02:11:22 INFO - 'SHLVL': '1', 02:11:22 INFO - 'TERM': 'linux', 02:11:22 INFO - 'TMOUT': '86400', 02:11:22 INFO - 'USER': 'cltbld', 02:11:22 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', 02:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:22 INFO - '_': '/tools/buildbot/bin/python'} 02:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:22 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)) 02:11:22 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)) 02:11:22 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)) 02:11:22 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)) 02:11:22 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)) 02:11:22 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)) 02:11:22 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)) 02:11:22 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)) 02:11:22 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)) 02:11:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:11:23 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)) 02:11:23 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)) 02:11:23 INFO - Installing collected packages: simplejson 02:11:23 INFO - Running setup.py install for simplejson 02:11:23 INFO - building 'simplejson._speedups' extension 02:11:23 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 02:11:24 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 02:11:24 INFO - Successfully installed simplejson 02:11:24 INFO - Cleaning up... 02:11:24 INFO - Return code: 0 02:11:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:24 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 0x170d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', '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 02:11:24 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 02:11:24 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 02:11:24 INFO - Using env: {'DISPLAY': ':0', 02:11:24 INFO - 'HOME': '/home/cltbld', 02:11:24 INFO - 'LANG': 'en_US.UTF-8', 02:11:24 INFO - 'LANGUAGE': 'en_US:en', 02:11:24 INFO - 'LOGNAME': 'cltbld', 02:11:24 INFO - 'MAIL': '/var/mail/cltbld', 02:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:24 INFO - 'MOZ_NO_REMOTE': '1', 02:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:24 INFO - 'NO_EM_RESTART': '1', 02:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:24 INFO - 'PWD': '/builds/slave/test', 02:11:24 INFO - 'SHELL': '/bin/bash', 02:11:24 INFO - 'SHLVL': '1', 02:11:24 INFO - 'TERM': 'linux', 02:11:24 INFO - 'TMOUT': '86400', 02:11:24 INFO - 'USER': 'cltbld', 02:11:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', 02:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:24 INFO - '_': '/tools/buildbot/bin/python'} 02:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:11:24 INFO - Cleaning up... 02:11:24 INFO - Return code: 0 02:11:24 INFO - Running post-action listener: _resource_record_post_action 02:11:24 INFO - Running post-action listener: _start_resource_monitoring 02:11:25 INFO - Starting resource monitoring. 02:11:25 INFO - [mozharness: 2017-09-10 09:11:25.023254Z] Finished create-virtualenv step (success) 02:11:25 INFO - [mozharness: 2017-09-10 09:11:25.023763Z] Running install step. 02:11:25 INFO - Running pre-action listener: _resource_record_pre_action 02:11:25 INFO - Running main action method: install 02:11:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:11:25 INFO - Reading from file tmpfile_stdout 02:11:25 INFO - Detecting whether we're running mozinstall >=1.0... 02:11:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:11:25 INFO - Reading from file tmpfile_stdout 02:11:25 INFO - Output received: 02:11:25 INFO - Usage: mozinstall [options] installer 02:11:25 INFO - Options: 02:11:25 INFO - -h, --help show this help message and exit 02:11:25 INFO - -d DEST, --destination=DEST 02:11:25 INFO - Directory to install application into. [default: 02:11:25 INFO - "/builds/slave/test"] 02:11:25 INFO - --app=APP Application being installed. [default: firefox] 02:11:25 INFO - mkdir: /builds/slave/test/build/application 02:11:25 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'] 02:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:11:42 INFO - Reading from file tmpfile_stdout 02:11:42 INFO - Output received: 02:11:42 INFO - /builds/slave/test/build/application/firefox/firefox 02:11:42 INFO - Running post-action listener: _resource_record_post_action 02:11:42 INFO - [mozharness: 2017-09-10 09:11:42.049643Z] Finished install step (success) 02:11:42 INFO - [mozharness: 2017-09-10 09:11:42.049894Z] Running setup-mitmproxy step. 02:11:42 INFO - Running pre-action listener: _resource_record_pre_action 02:11:42 INFO - Running main action method: setup_mitmproxy 02:11:42 INFO - Skipping: mitmproxy is not required 02:11:42 INFO - Running post-action listener: _resource_record_post_action 02:11:42 INFO - [mozharness: 2017-09-10 09:11:42.051022Z] Finished setup-mitmproxy step (success) 02:11:42 INFO - [mozharness: 2017-09-10 09:11:42.051247Z] Running run-tests step. 02:11:42 INFO - Running pre-action listener: _resource_record_pre_action 02:11:42 INFO - Running pre-action listener: _set_gcov_prefix 02:11:42 INFO - Running main action method: run_tests 02:11:42 WARNING - Try message not found. 02:11:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:11:42 INFO - Python 2.7.3 02:11:42 INFO - Return code: 0 02:11:42 INFO - grabbing minidump binary from tooltool 02:11: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')]} 02:11:42 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 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:11:42 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 02:11:42 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 02:11:42 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 02:11:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:11:42 INFO - Return code: 0 02:11:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:11:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:11:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:11:42 INFO - ENV: RUST_BACKTRACE is now full 02:11:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:11:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:11:42 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/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 02:11:42 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/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 02:11:42 INFO - Using env: {'DISPLAY': ':0', 02:11:42 INFO - 'HOME': '/home/cltbld', 02:11:42 INFO - 'LANG': 'en_US.UTF-8', 02:11:42 INFO - 'LANGUAGE': 'en_US:en', 02:11:42 INFO - 'LOGNAME': 'cltbld', 02:11:42 INFO - 'MAIL': '/var/mail/cltbld', 02:11:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:11:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:42 INFO - 'MOZ_NO_REMOTE': '1', 02:11:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:42 INFO - 'NO_EM_RESTART': '1', 02:11:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:42 INFO - 'PWD': '/builds/slave/test', 02:11:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:11:42 INFO - 'RUST_BACKTRACE': 'full', 02:11:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:11:42 INFO - 'SHELL': '/bin/bash', 02:11:42 INFO - 'SHLVL': '1', 02:11:42 INFO - 'TERM': 'linux', 02:11:42 INFO - 'TMOUT': '86400', 02:11:42 INFO - 'USER': 'cltbld', 02:11:42 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', 02:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:42 INFO - '_': '/tools/buildbot/bin/python'} 02:11:42 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/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 02:11:42 INFO - mozversion application_buildid: 20170910080726 02:11:42 INFO - mozversion application_changeset: 00baeed193d4f276694912f0298336880280837d 02:11:42 INFO - mozversion application_display_name: Nightly 02:11:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:11:42 INFO - mozversion application_name: Firefox 02:11:42 INFO - mozversion application_remotingname: firefox 02:11:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:11:42 INFO - mozversion application_vendor: Mozilla 02:11:42 INFO - mozversion application_version: 57.0a1 02:11:42 INFO - mozversion platform_buildid: 20170910080726 02:11:42 INFO - mozversion platform_changeset: 00baeed193d4f276694912f0298336880280837d 02:11:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:11:42 INFO - mozversion platform_version: 57.0a1 02:11:42 INFO - using testdate: 1505034702 02:11:42 INFO - actual date: 1505034702 02:11:42 INFO - starting webserver on 'localhost:46397' 02:11:42 INFO - SUITE-START | Running 2 tests 02:11:42 INFO - TEST-START | dromaeo_css 02:11:42 INFO - Initialising browser for dromaeo_css test... 02:11:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46397/getInfo.html -profile /tmp/tmpW_rtd4/profile 02:11:42 INFO - TEST-INFO | started process 10307 (/builds/slave/test/build/application/firefox/firefox http://localhost:46397/getInfo.html) 02:11:49 INFO - TEST-INFO | 10307: exit 0 02:11:49 INFO - Browser initialized. 02:11:49 INFO - Running cycle 1/1 for dromaeo_css test... 02:11:49 INFO - Using env: {'DISPLAY': ':0', 02:11:49 INFO - 'HOME': '/home/cltbld', 02:11:49 INFO - 'JSGC_DISABLE_POISONING': '1', 02:11:49 INFO - 'LANG': 'en_US.UTF-8', 02:11:49 INFO - 'LANGUAGE': 'en_US:en', 02:11:49 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:11:49 INFO - 'LOGNAME': 'cltbld', 02:11:49 INFO - 'MAIL': '/var/mail/cltbld', 02:11:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:11:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:11:49 INFO - 'MOZ_CRASHREPORTER': '1', 02:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:49 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:11:49 INFO - 'MOZ_NO_REMOTE': '1', 02:11:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:49 INFO - 'NO_EM_RESTART': '1', 02:11:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:49 INFO - 'PWD': '/builds/slave/test', 02:11:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:11:49 INFO - 'RUST_BACKTRACE': 'full', 02:11:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:11:49 INFO - 'SHELL': '/bin/bash', 02:11:49 INFO - 'SHLVL': '1', 02:11:49 INFO - 'STYLO_FORCE_DISABLED': '1', 02:11:49 INFO - 'TERM': 'linux', 02:11:49 INFO - 'TMOUT': '86400', 02:11:49 INFO - 'USER': 'cltbld', 02:11:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', 02:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:49 INFO - '_': '/tools/buildbot/bin/python'} 02:11:49 INFO - TEST-INFO | started process 10508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW_rtd4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:50 INFO - PID 10508 | 02:11:50 INFO - PID 10508 | (/builds/slave/test/build/application/firefox/firefox:10559): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:11:50 INFO - PID 10508 | 02:12:00 INFO - PID 10508 | RSS: Main: 164929536 02:12:00 INFO - PID 10508 | 02:14:56 INFO - PID 10508 | Cycle 1(1): loaded http://localhost:46397/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46397/tests/dromaeo/cssquery-ext.html) 02:14:57 INFO - PID 10508 | RSS: Main: 171102208 02:14:57 INFO - PID 10508 | 02:17:59 INFO - PID 10508 | Cycle 1(1): loaded http://localhost:46397/tests/dromaeo/cssquery-ext.html (next: http://localhost:46397/tests/dromaeo/cssquery-jquery.html) 02:17:59 INFO - PID 10508 | RSS: Main: 165679104 02:17:59 INFO - PID 10508 | 02:21:01 INFO - PID 10508 | Cycle 1(1): loaded http://localhost:46397/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46397/tests/dromaeo/cssquery-mootools.html) 02:21:02 INFO - PID 10508 | RSS: Main: 170307584 02:21:02 INFO - PID 10508 | 02:24:04 INFO - PID 10508 | Cycle 1(1): loaded http://localhost:46397/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46397/tests/dromaeo/cssquery-prototype.html) 02:24:04 INFO - PID 10508 | RSS: Main: 168370176 02:24:04 INFO - PID 10508 | 02:27:07 INFO - PID 10508 | Cycle 1(1): loaded http://localhost:46397/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46397/tests/dromaeo/cssquery-yui.html) 02:27:08 INFO - PID 10508 | RSS: Main: 169267200 02:27:08 INFO - PID 10508 | 02:30:10 INFO - PID 10508 | Cycle 1(1): loaded http://localhost:46397/tests/dromaeo/cssquery-yui.html (next: http://localhost:46397/tests/dromaeo/cssquery-dojo.html) 02:30:10 INFO - PID 10508 | RSS: Main: 171745280 02:30:10 INFO - PID 10508 | 02:30:10 INFO - PID 10508 | __start_tp_report 02:30:10 INFO - PID 10508 | _x_x_mozilla_page_load 02:30:10 INFO - PID 10508 | _x_x_mozilla_page_load_details 02:30:10 INFO - PID 10508 | |i|pagename|runs| 02:30:10 INFO - PID 10508 | |0;dojo.html;3119.7972131811434;3146.056183145056;3147.3075923296865;3154.4164329599025;3158.1473002289376;6078.300995385532;6161.045038019103;6202.7208775605095;6313.242410910691;6339.778107766223;6098.939010609893;6147.8770424591485;6161.476274516672;6167.290761562422;6185.350538193492;5697.715114244292;5780.2196703444915;5805.564582656297;5827.329857066428;5845.123231515286;89.02189248717642;5779.855503612402;5826.009578371666;5851.180834683148;5873.207117039187;5241.86895327616;5638.097904335307;5661.7735290588325;5803.970980145094;5813.709314534299;5687.516561092312;5708.600397972144;5775.422457754191;5783.190353350535;5794.5074668653215;5675.943240567624;5711.543076553866;5769.682667453289;5783.277090363705;5808.680522571257;6207.782727604512;6231.968840155816;6239.844003899939;6243.1883855099;6278.4035516625845;6470.191226096738;6561.639109848957;6686.13080299558;6697.966510167466;6763.458923286125;6707.228668703113;6732.697028633724;6735;6737.93262067378;6745.527813053088;6108.419700128481;6158.630482171039;6210.285817130997;6232.688365581703;6321.336259692758;6898.482613803984;6919.930800691928;6968.965155174243;6983.82540436483;6985.615791131435;6564.409203171737;6571.3757193066585;6583;6586.473082153416;6688.832779180462;6493.25327587324;6556.213254409406;6658.866822663616;6698.966505167443;6754.898676519856;6690.163729533809;6701.028350889192;6706.295838936939;6711.865762684719;6748;6683.097781799492;6756.763513277012;6775;6777.186737591521;6786.219584747719;5205.297284866495;5229.790808367623;5283.735813209324;5284;5297.284866543045;4478.9552104478535;4534.115847409789;4562.064776720765;4592.7014744041535;4676.625869930397;5776.508996735324;5788.247527821441;5819.330776960619;5820.621659592198;5823.359430462646;6601;6700.095487109275;6769.05233267343;6793.116894803644;6802.727890884408;5597.860053498695;5727.398623144593;5730.226419433407;5794.0439827428;5801.477866991907;5687.289088863892;5713.942860571341;5767.682777447197;5768.336641286306;5776.768929242868;6496.285408605049;6504.739810407626;6506.772262970773;6509.707063182168;6511.902321465182;6653.700583473658;6655.134832471747;6655.633940133339;6655.86688266232;6767.39093481589;6170.53720970938;6337.809865704036;6357.841053973502;6390.4248617624635;6481.740730370732;6501.772437964649;6531.183602049744;6567.179102612174;6626.171728533934;6628.171478565179;6725.39471447572;6733.966330168318;6791.422729068085;6795.150606174228;6825.692843822139;6469.838254043687;6498.480121590167;6500.707468164039;6577.671116444254;6585.80242592723;6338.714757836001;6437.967810160919;6493.675316234264;6565.671716414065;6579.967100164468;6388.2972872984865;6484.902726459012;6487.967560162169;6496.9025464617125;6498.870022599616;6529.053287273414;6548.967255163694;6551.574147680385;6607.405333519814;6638.336166383323;6310.716017779119;6313.463355614824;6337.9366206337345;6390.392912673288;6441.806745797446 02:30:10 INFO - PID 10508 | |1;ext.html;845.742048675154;848.8811566380712;857.4726543175949;861.4099341950764;870.7823044238941;37507.62492375075;40896.795516022416;41081.58918410815;41096.38355424671;41468;37331.44002839959;37552.248955020885;37584.62415375846;37596;37672.24655506888;7042.894356584642;7105.111861017373;7686.884696729554;7887.8028049298655;7897.605119744018;7742.2644848739565;7823.45235833489;7875.684972601089;7880.2513761192595;7880.330171935364;7819.804504887366;7869.921300787005;7880.172581878906;7897.8025549361155;7903.683852645887;7821.843563128734;7873.173316801711;7881.369490440751;7882.172371900925;7883.566403847786;7753.534787912687;7796.961015194945;7800.726974555863;7804.765857024298;7805.765827025199;38441;38467.42298865519;38673.22653546942;38821.61178388208;38822.41766373507;3573.446115852047;3607.314610224049;3612.3858943979585;3613.5121758562523;3624.2932628137523;31368.686313136805;31378.431078445985;31389.52915706266;31396;31407.05778826639;5044.772985215674;5059.848204553869;5087.847364579032;5103.234514822806;5105.897882042375;181917;182245;182299;182988;183441;41071.58928410737;48106.518934810905;48309.75845120752;48327.650511454136;48443.75778121157;44116.77941610271;48810;49317;49473.75263123661;49478.257826132634;14607.488737894122;14738.484153054591;14746.262686865613;14770.483033094006;14780.852191477947;11920.688724240326;11947.223430477165;11950.342731149696;11961;12032.939835300942;13286;13344.733105337838;13429.798553021712;13473.663158420923;13486.190828550318;5443.292371991616;5525.309336332958;5628.549716022709;5659.43405659439;5740.196372507852;997.7755005123935;1005.9446730429896;1007.2093406675871;1020.7550187954986;1035.5857656937135;22538.549229015327;22680.319590411986;22744.31767046958;23057.19299824498;23137.7686223139;1096.2381145104237;1097.4510653342013;1113.1984970820995;1122.6239209864787;1126.4142645824124;11958.940205299092;12005.579804706793;12218.75562488763;12224.083193760503;12236;213054;213314;213763;214307;214440;50348.748256258485;50577;50674.23988640173;50775;50873.491265087614;1416.8653977872086;1458.7228426598913;1465.5383554180398;1469.397547005744;1475.5352064099775;22166.224182154194;22264.554708906056;22401.887990559942;22443;22616.321510354715;35452.29095418129;35519.82240088783;35549.46675799813;35571.28857422785;35602.643973559934;185418;187234.06382967997;188123;189182;190468;32396.514052289705;32592.185195370304;35032;35857.64142358543;35921.64078359288;43775.78112109547;44614.55385446104;44932.326015110455;45019.32471012872;45366.09267814691;33315;33332;33377.332453351286;33609.83195084009;33818.3236335267;32700.83649581737;32832.343353132324;32878.34243315168;33091.66908330886;33540.832295838365;35530.822345888104;37253.441198382585;37302.253954920205;37349.43975840419;37484.81257593694;31465.842670787417;31790.36419271648;32017.359652807278;32049.519257210693;32242;23813.880930595235;23867.880660596587;24036.39909002289;24483.38791530226;24600.507989839745 02:30:10 INFO - PID 10508 | |2;jquery.html;546.0805269477786;561.6349372907612;564.5427203964787;568.0995621939226;575.3153747041019;21583.67624485632;22431.102755889766;22639;22642.88678556607;22685.886570567123;23994.40013999651;24553.75446245537;24971.126010589633;25194;25489.490210195785;6370.745170193187;6460.41856232939;6506.349365063479;6512.6092434454085;6513.185851768505;6229.968850155743;6432.163818703562;6505.674716264191;6543.640099794509;6544.443722283611;6477.157969463963;6492.123563318963;6505.828950788856;6518.706658200369;6524.543281970264;6505.4145126938565;6518.315576864408;6522.119513865615;6522.15212022434;6523.021546767975;5942.3760505146765;6162.907556386658;6171.043488259327;6172.969135154295;6173.536984726164;29203;29258.561121583192;29650.70349296501;29746;29783.404331913458;2004.3385682724665;2036.2364113457454;2053.5892821435623;2055.7533096028424;2062.3709768520594;18730.34443794461;18796.906015469973;18950.43148705541;19522.80477195224;19878.503037424034;2446.9755302446924;2458.0659349447096;2499.9125030624023;2500.3999040230397;2509.4102885821817;116536;119977;131100.6889931098;136876;142103;14432.209965915801;14735.305439874337;14976.850231497545;14997.850021499646;15014.699706006037;22976.885115574314;23014.194503192644;23022.65466018011;23036.769632303796;23047;9460.290478214161;9650.613975440903;9659.275554333453;9672.419654820733;9826.213902887752;8661.91338086611;8695.173958473935;8724.171203735636;8741.781455463537;8840.778980525409;8746.65013399457;8880.978687450897;9067.637294508279;9181.0818918109;9254.953725231331;2563.974360256411;2596.40282734972;2696;2725.4549090182045;2805.761510271609;918.6738707758783;932.5430539035959;937.8311903857372;944.3342443577261;956.0582825916466;19139.712904306445;19422.22311107568;19680.40958771239;19828.20687172526;19950.002499874947;985.531872360623;989.450854775592;993.3692105512907;1000.8648832407532;1011.8330475471465;10679.412632305142;10730.2488825783;10964;10976.176786741027;11048.06091482233;438446;447198;447530;450876;454283;102087.48956255171;104838.47580762047;107325.4633726842;109722;110340;1045.1168762395764;1055.287680815462;1146.2262972493534;1172.0623501199007;1201.3452668295624;20740.68888966697;20863.26978555804;20955.58088838245;20996.265130720352;21107.788922110583;53989;54487;55729;56456;56714;70311;70550.29449705438;71026.28973710403;71036.64481677559;71301.28698713153;13676.863231367957;13706.109102908278;13709.931450343083;14311.856881431053;14423.855761442252;22794.886025569765;22856.428589285402;23249.76750232476;23415.297541073796;23430.414239644146;16442.588935276715;16707.415240466526;17623.647527049645;17762.200700968748;17792.822071779116;15064.246787660353;15711.292991815624;16364.67270654604;16952.57618559546;17394.217260223068;18666.813331866506;18717;18919.337823176123;18955.14701838393;19192.13635386439;14085.507007254697;14164.645883852574;14193;14207.147571145764;14215.50245741394;18537.35119270819;18568;18575.071246437896;18634;18837.24651013999 02:30:10 INFO - PID 10508 | |3;mootools.html;1278.4886045581766;1374.7387996280709;1375.1336657905517;1392.338639146405;1394.5119208277104;14774.926125369371;15422;15429.768553471707;15444.84555154451;15452.690946181083;15069.547913562583;15179.089254644701;15296.617584560392;15331.540053798404;15350.00224985378;2722.9727702723017;2747.0659975608287;2780.5829125631217;2783.5128852450844;2794.790390720704;2726.2775364528416;2742.698303186648;2754.311422144464;2755.2973991632107;2756.3109222694325;2659.7207293234223;2665.9733402666016;2679.223025322654;2818.8449635270053;2820.5205115130475;2701.810873238874;2704.9053283135095;2724.223596275062;2725.809193356466;2726.5637498000224;2603.1799983005294;2663.946721065568;2683.0206974454186;2684.181324695967;2685.9194224173307;14884.62788430298;14999.700005999819;15010.249487525689;15013.174275414847;15040.097594144278;7842.490238134503;8125.959370203171;8165.510069395856;8174.918250817475;8176.223258790405;5141.485851414866;5233.947660523384;5280.07598670235;5348.625596208267;5357.303550538444;1934.1586409911733;1941.825235728777;1967.6359873423462;1995.7106219598222;1998.2206939293687;26671.066512672158;26725.331866703295;26816.061437849778;26840.06059787898;26875.86562067177;6616.470682345401;6796.184457864989;6816.147981502312;6952.200496942916;6977.6511174441075;16316.75524867128;16350.918245408935;16749.58126046834;17357.045362505185;17391.91304043497;7576.924230757732;7761.534307941429;7785.961070194613;7819.335356494762;7828.804279892935;7146.821329466701;7182.784516464514;7188.820279493055;7220.061392019109;7270.854582908312;4831.51684831514;4979.352684151109;4994.825181118644;5007.37407824022;5013.548780609763;1355;1372.7597670407638;1374.883134933542;1382.4608402722947;1385.7090011097782;868.1015149320423;884.5577211394303;897.3314880414133;900.8919426849777;901.2609660078673;7414.295641914009;7631.618419079024;7646.158922518519;7775.961120194363;7806.453548251568;714.1929619530001;720.1250480666016;721.7942886277385;723.3345322303494;735.1068451831051;4692.906141877143;5031.974840125776;5164.586833053347;5316.1494160934835;5359.08895487768;20406.183752650024;20992.055357508947;21214.681779773317;21365.14539418437;21654.24210152637;20783.58432831335;21246;21522.246721364678;21684.24105156312;21700.782992169876;10433.113185379329;10525.473726313654;10611.734706632242;10745.14038876888;10749.301295415773;7999.160088190656;8081.15147909461;8189.877151842847;8225.177482251727;8337.791555211168;18136.18387172607;18306.81693183051;18451.077446127907;18581.721274181167;18992.335268265546;18983;19019.809801901803;19020.80979190246;19125.80874191296;19127;10857.891421085687;10949;10957.12343012573;10958.232923695583;10966.232363734462;13621.931890340486;13781.310934453037;13783.310834458036;13785.931070344985;13789.517366892513;10979.670609881716;11002.614908478165;11091.778164436504;11168.553257869919;11300.717482063013;10430.68707938763;10437.478126093816;10438.58245670195;10712.35725856451;10872.238943274211;9309.487978161265;9416.62333506652;9496.85754713666;9514.571844266886;9521.523923803643;7087.893681594884;7168.498205125591;7182.569045857265;7183.20984691694;7228.421726261991;7135.785926422215;7314.341709246193;7328.377087947584;7343.816404589928;7440.73957411488 02:30:10 INFO - PID 10508 | |4;prototype.html;485.87853036740813;504.5963229416466;510.3900838497995;518.5618152661001;518.5644058990449;6277.273749718824;6317;6331.715072821728;6339.6830158492;6351.682415879199;6202.689865506718;6215.160953271307;6228.19033525641;6229.501639868811;6245.531585131111;5093.388793344804;5106.259592359106;5109.3357863477695;5111.495367270029;5122.641415100945;4789.592884604813;4864.391951006124;5031.257964409406;5081.237814327862;5093.567046801027;4829.154897892872;4852.199387101142;4857.878553036167;4877.975610121945;4879.975600122012;4820.276958456225;4848.8302909398;4856.927146092811;4877.414710234777;4878;4220.07158425146;4345.348197770328;4376.956230437687;4377.430933978594;4380.123975204971;6045.186444066806;6075.878482430371;6092.329843717188;6099.6950152492645;6103.267607887037;5536.723163841792;5569.498745112919;5576.302962129734;5592.328920529562;5600.943990560083;6520.804375868732;6523.347665233486;6538;6558.573692709959;6560.835979100513;4527.615152712024;4772.16487114757;4779.3308936748535;4788.880277993043;4791.305260737174;6656.767013154565;6674.799756007279;6800.4219641330055;6805.149356330458;6822.271091563414;4892.263246547495;4899.461059283476;4905.754712264373;4905.779239934212;4908.460069392364;4926.852194434173;4935.185694360391;4953;4956.231784073474;4981.302617633534;5568.554515638739;5576.553875689935;5587.329520457572;5599.60802743804;5608.46719561641;6540.8364790880605;6576.210854697467;6583.967080164664;6624.211462904988;6657.367550082734;1701.4470297153475;1705.224123024021;1713.8089028125582;1719.72484402495;1723.3709695960883;1143.5311522275993;1189.5004098278744;1195.8804119587971;1200.8378868852767;1210.9878901211052;5651.547876169897;5698.287714035746;5708.172315014383;5728.112142617901;5755.22304488897;6560.835979100465;6571.2771595124495;6576.868462630816;6642.63465509392;6726.8654626908165;5593.440655934374;5652.74562644682;5670.858228544319;5692.516136128475;5695.772169113272;3486.3027394521196;3528.6118526962014;3539;3548.6806187443253;3553.4136867417105;6380.585261957958;6416.294207637156;6430.260520040255;6446.548741588138;6448.4846061175585;6666.2333831609985;6831.897521537181;6865.485088618274;6870.896936545956;6875.656217189221;6331.588446750947;6333.714982825784;6411.647359395278;6419.51853610981;6449.709763060673;5936.871994321065;6548.728273739685;6596;6618.525274231067;6620.285682870192;6435.270076493867;6507.349265073455;6517.902231466437;6557.573757705733;6572.80281591553;6201.131841542097;6237.721267140135;6257.56197066201;6273.765208484164;6277.2781130170615;4746.691465054761;4842.854714358575;4852.1508735971765;4858.92711609319;4883.6325828768;6353;6499.512536559682;6502.187226596676;6695.451410752309;6726.3520437493125;6262.279837818709;6476.222853257639;6493.870122597427;6513.632137251041;6523.543351965317;6503.479721622353;6520.967395162994;6539.247986481616;6543.411093001652;6550.379848060814;6441.935580644321;6474.320196379501;6477.190351206099;6484.351564843478;6493.285738568659;6386.425221730066;6485.77299794505;6512.413882750575;6526.757607555127;6580.473562114924;6267.62394256346;6286.9371306288185;6323.810285691437;6338.429541341301;6358.205224346957 02:30:10 INFO - PID 10508 | |5;yui.html;855.5337341149069;877.8288233794405;887.2458410351202;890.6125835261661;913.4473643445715;18523.259069637214;19476.610467790637;19479.31822386215;19593.902030489862;22527.887360563214;21495.67756483654;21750.12999480019;21817.781822181772;21850.781492185073;21873.343799685994;994.0208894239187;1011.1859952738043;1016.4054028393399;1016.6136867990153;1017.6082208349802;909.4588719711794;995.5768798260747;999.4952548962764;1001.539291925715;1001.7145113642613;1051.1800795379577;1058.1376178414605;1058.3755584205317;1058.7776566920957;1059.8251288537383;1043.0351924469835;1046.6807623674777;1047.2983101322095;1047.842823576462;1049.18163832211;774.144570249877;776.6388629287352;777.8249893773913;778.2178910195274;778.8987431633908;19791.901040494704;19901.900490497454;20033.499162520908;20039.398818035483;20071.1971521139;20547.589048219103;20661.793382066287;21088.2619108332;21134.89432552843;21173.04721287546;17936.19287132069;18126.274949002025;18144.546386340317;18163.09184540768;18178.636427271515;3573.6783689468075;3649.489071529988;3675.9448608270895;3676.2096149327754;3677.632236776301;139584;140033;140839;142491;142918.99999999895;17531.386401475887;17551.210195541233;17559.122043897754;17581.472555823344;17800.55498612545;30818.53772193419;31545.684543154275;31623;31697.52453713196;31697.8415107923;7643.656035478417;7899;7975.680972761141;7992.480488768211;8028.397870159762;3400.880969166067;3569.1434055826935;3834.309824231609;3942.8619998299923;3961.7028722845325;5701.71491425427;5913.083472061838;5937.287525496968;5937.465628093406;5966.254218222723;1083.2958576924905;1097.6597254851022;1114.6823155400834;1118.2898859224288;1126.633844000703;677.376813331736;685.2222727204659;697.7453229571272;701.7578935267427;706.0468367703662;11454.713632159262;11530.711732206762;11737.530498779954;12396.504139834306;12661.936690316674;580.9186713860063;589.5843430381657;590.2533295381346;594.7145370222318;609.1684850179473;5255.264263003182;5319.601029922694;5354;5381.3811411687375;5427.240186373911;118632;119256.40371798085;120262;122928;126245;102322;103109;104868.64904698434;106079;108640.45679771551;86401;87620.56189719011;88179.55910220408;90813.54593226992;92190.53904730434;9739.172170365599;9941.65204217849;9947.452890091114;10135.290529662852;10181.949090254502;40112.59887401205;40183.3972490407;40851.591484084776;41220.1755964885;41563.7921810389;53238.46761532335;53450.73274633602;53601.731991339795;54304.72847635736;54443.45556544384;15202.543923682308;15393.461228856937;15494;15527.84472155264;15637.374505020127;17039.829601703823;17168.141592920554;17198.14009299555;17236.74144887853;17321.826781732525;15704.842951570337;16005.519834404986;16057.277422516248;16066.758998614796;16110.355585776437;15482.225888705294;15526.9223653881;15649.1392973383;15686.294116765;15728.921355393608;15374.38502459889;15473.226338682796;15498.302576384316;15500;15598.532044038697;11243.10055195566;11265.943670281596;11373.488193031499;11454.14093942941;11563.421828908353;11765.235259708092;11982.041436685218;12076.75846483083;12425.068119890864;12468.93765531203 02:30:10 INFO - PID 10508 | __end_tp_report 02:30:10 INFO - PID 10508 | __start_cc_report 02:30:10 INFO - PID 10508 | _x_x_mozilla_cycle_collect,354 02:30:10 INFO - PID 10508 | __end_cc_report 02:30:10 INFO - PID 10508 | __startTimestamp1505035810254__endTimestamp 02:30:10 INFO - PID 10508 | 02:30:10 INFO - PID 10508 | ------- Summary: start ------- 02:30:10 INFO - PID 10508 | Number of tests: 6 02:30:10 INFO - PID 10508 | 02:30:10 INFO - PID 10508 | [#0] dojo.html Cycles:165 Average:6112.69 Median:6390.39 stddev:878.34 (13.7%) stddev-sans-first:849.07 02:30:10 INFO - PID 10508 | Values: 3119.8 3146.1 3147.3 3154.4 3158.1 6078.3 6161.0 6202.7 6313.2 6339.8 6098.9 6147.9 6161.5 6167.3 6185.4 5697.7 5780.2 5805.6 5827.3 5845.1 89.0 5779.9 5826.0 5851.2 5873.2 5241.9 5638.1 5661.8 5804.0 5813.7 5687.5 5708.6 5775.4 5783.2 5794.5 5675.9 5711.5 5769.7 5783.3 5808.7 6207.8 6232.0 6239.8 6243.2 6278.4 6470.2 6561.6 6686.1 6698.0 6763.5 6707.2 6732.7 6735.0 6737.9 6745.5 6108.4 6158.6 6210.3 6232.7 6321.3 6898.5 6919.9 6969.0 6983.8 6985.6 6564.4 6571.4 6583.0 6586.5 6688.8 6493.3 6556.2 6658.9 6699.0 6754.9 6690.2 6701.0 6706.3 6711.9 6748.0 6683.1 6756.8 6775.0 6777.2 6786.2 5205.3 5229.8 5283.7 5284.0 5297.3 4479.0 4534.1 4562.1 4592.7 4676.6 5776.5 5788.2 5819.3 5820.6 5823.4 6601.0 6700.1 6769.1 6793.1 6802.7 5597.9 5727.4 5730.2 5794.0 5801.5 5687.3 5713.9 5767.7 5768.3 5776.8 6496.3 6504.7 6506.8 6509.7 6511.9 6653.7 6655.1 6655.6 6655.9 6767.4 6170.5 6337.8 6357.8 6390.4 6481.7 6501.8 6531.2 6567.2 6626.2 6628.2 6725.4 6734.0 6791.4 6795.2 6825.7 6469.8 6498.5 6500.7 6577.7 6585.8 6338.7 6438.0 6493.7 6565.7 6580.0 6388.3 6484.9 6488.0 6496.9 6498.9 6529.1 6549.0 6551.6 6607.4 6638.3 6310.7 6313.5 6337.9 6390.4 6441.8 02:30:10 INFO - PID 10508 | 02:30:10 INFO - PID 10508 | [#1] ext.html Cycles:180 Average:36317.37 Median:35560.38 stddev:50492.86 (142.0%) stddev-sans-first:50564.26 02:30:10 INFO - PID 10508 | Values: 845.7 848.9 857.5 861.4 870.8 37507.6 40896.8 41081.6 41096.4 41468.0 37331.4 37552.2 37584.6 37596.0 37672.2 7042.9 7105.1 7686.9 7887.8 7897.6 7742.3 7823.5 7875.7 7880.3 7880.3 7819.8 7869.9 7880.2 7897.8 7903.7 7821.8 7873.2 7881.4 7882.2 7883.6 7753.5 7797.0 7800.7 7804.8 7805.8 38441.0 38467.4 38673.2 38821.6 38822.4 3573.4 3607.3 3612.4 3613.5 3624.3 31368.7 31378.4 31389.5 31396.0 31407.1 5044.8 5059.8 5087.8 5103.2 5105.9 181917.0 182245.0 182299.0 182988.0 183441.0 41071.6 48106.5 48309.8 48327.7 48443.8 44116.8 48810.0 49317.0 49473.8 49478.3 14607.5 14738.5 14746.3 14770.5 14780.9 11920.7 11947.2 11950.3 11961.0 12032.9 13286.0 13344.7 13429.8 13473.7 13486.2 5443.3 5525.3 5628.5 5659.4 5740.2 997.8 1005.9 1007.2 1020.8 1035.6 22538.5 22680.3 22744.3 23057.2 23137.8 1096.2 1097.5 1113.2 1122.6 1126.4 11958.9 12005.6 12218.8 12224.1 12236.0 213054.0 213314.0 213763.0 214307.0 214440.0 50348.7 50577.0 50674.2 50775.0 50873.5 1416.9 1458.7 1465.5 1469.4 1475.5 22166.2 22264.6 22401.9 22443.0 22616.3 35452.3 35519.8 35549.5 35571.3 35602.6 185418.0 187234.1 188123.0 189182.0 190468.0 32396.5 32592.2 35032.0 35857.6 35921.6 43775.8 44614.6 44932.3 45019.3 45366.1 33315.0 33332.0 33377.3 33609.8 33818.3 32700.8 32832.3 32878.3 33091.7 33540.8 35530.8 37253.4 37302.3 37349.4 37484.8 31465.8 31790.4 32017.4 32049.5 32242.0 23813.9 23867.9 24036.4 24483.4 24600.5 02:30:10 INFO - PID 10508 | 02:30:10 INFO - PID 10508 | [#2] jquery.html Cycles:180 Average:33001.54 Median:23422.86 stddev:75542.55 (322.5%) stddev-sans-first:75715.17 02:30:10 INFO - PID 10508 | Values: 546.1 561.6 564.5 568.1 575.3 21583.7 22431.1 22639.0 22642.9 22685.9 23994.4 24553.8 24971.1 25194.0 25489.5 6370.7 6460.4 6506.3 6512.6 6513.2 6230.0 6432.2 6505.7 6543.6 6544.4 6477.2 6492.1 6505.8 6518.7 6524.5 6505.4 6518.3 6522.1 6522.2 6523.0 5942.4 6162.9 6171.0 6173.0 6173.5 29203.0 29258.6 29650.7 29746.0 29783.4 2004.3 2036.2 2053.6 2055.8 2062.4 18730.3 18796.9 18950.4 19522.8 19878.5 2447.0 2458.1 2499.9 2500.4 2509.4 116536.0 119977.0 131100.7 136876.0 142103.0 14432.2 14735.3 14976.9 14997.9 15014.7 22976.9 23014.2 23022.7 23036.8 23047.0 9460.3 9650.6 9659.3 9672.4 9826.2 8661.9 8695.2 8724.2 8741.8 8840.8 8746.7 8881.0 9067.6 9181.1 9255.0 2564.0 2596.4 2696.0 2725.5 2805.8 918.7 932.5 937.8 944.3 956.1 19139.7 19422.2 19680.4 19828.2 19950.0 985.5 989.5 993.4 1000.9 1011.8 10679.4 10730.2 10964.0 10976.2 11048.1 438446.0 447198.0 447530.0 450876.0 454283.0 102087.5 104838.5 107325.5 109722.0 110340.0 1045.1 1055.3 1146.2 1172.1 1201.3 20740.7 20863.3 20955.6 20996.3 21107.8 53989.0 54487.0 55729.0 56456.0 56714.0 70311.0 70550.3 71026.3 71036.6 71301.3 13676.9 13706.1 13709.9 14311.9 14423.9 22794.9 22856.4 23249.8 23415.3 23430.4 16442.6 16707.4 17623.6 17762.2 17792.8 15064.2 15711.3 16364.7 16952.6 17394.2 18666.8 18717.0 18919.3 18955.1 19192.1 14085.5 14164.6 14193.0 14207.1 14215.5 18537.4 18568.0 18575.1 18634.0 18837.2 02:30:10 INFO - PID 10508 | 02:30:10 INFO - PID 10508 | [#3] mootools.html Cycles:180 Average:9198.43 Median:14762.99 stddev:6645.58 (45.0%) stddev-sans-first:6637.59 02:30:10 INFO - PID 10508 | Values: 1278.5 1374.7 1375.1 1392.3 1394.5 14774.9 15422.0 15429.8 15444.8 15452.7 15069.5 15179.1 15296.6 15331.5 15350.0 2723.0 2747.1 2780.6 2783.5 2794.8 2726.3 2742.7 2754.3 2755.3 2756.3 2659.7 2666.0 2679.2 2818.8 2820.5 2701.8 2704.9 2724.2 2725.8 2726.6 2603.2 2663.9 2683.0 2684.2 2685.9 14884.6 14999.7 15010.2 15013.2 15040.1 7842.5 8126.0 8165.5 8174.9 8176.2 5141.5 5233.9 5280.1 5348.6 5357.3 1934.2 1941.8 1967.6 1995.7 1998.2 26671.1 26725.3 26816.1 26840.1 26875.9 6616.5 6796.2 6816.1 6952.2 6977.7 16316.8 16350.9 16749.6 17357.0 17391.9 7576.9 7761.5 7786.0 7819.3 7828.8 7146.8 7182.8 7188.8 7220.1 7270.9 4831.5 4979.4 4994.8 5007.4 5013.5 1355.0 1372.8 1374.9 1382.5 1385.7 868.1 884.6 897.3 900.9 901.3 7414.3 7631.6 7646.2 7776.0 7806.5 714.2 720.1 721.8 723.3 735.1 4692.9 5032.0 5164.6 5316.1 5359.1 20406.2 20992.1 21214.7 21365.1 21654.2 20783.6 21246.0 21522.2 21684.2 21700.8 10433.1 10525.5 10611.7 10745.1 10749.3 7999.2 8081.2 8189.9 8225.2 8337.8 18136.2 18306.8 18451.1 18581.7 18992.3 18983.0 19019.8 19020.8 19125.8 19127.0 10857.9 10949.0 10957.1 10958.2 10966.2 13621.9 13781.3 13783.3 13785.9 13789.5 10979.7 11002.6 11091.8 11168.6 11300.7 10430.7 10437.5 10438.6 10712.4 10872.2 9309.5 9416.6 9496.9 9514.6 9521.5 7087.9 7168.5 7182.6 7183.2 7228.4 7135.8 7314.3 7328.4 7343.8 7440.7 02:30:10 INFO - PID 10508 | 02:30:10 INFO - PID 10508 | [#4] prototype.html Cycles:180 Average:5440.59 Median:6152.20 stddev:1535.49 (25.0%) stddev-sans-first:1494.09 02:30:10 INFO - PID 10508 | Values: 485.9 504.6 510.4 518.6 518.6 6277.3 6317.0 6331.7 6339.7 6351.7 6202.7 6215.2 6228.2 6229.5 6245.5 5093.4 5106.3 5109.3 5111.5 5122.6 4789.6 4864.4 5031.3 5081.2 5093.6 4829.2 4852.2 4857.9 4878.0 4880.0 4820.3 4848.8 4856.9 4877.4 4878.0 4220.1 4345.3 4377.0 4377.4 4380.1 6045.2 6075.9 6092.3 6099.7 6103.3 5536.7 5569.5 5576.3 5592.3 5600.9 6520.8 6523.3 6538.0 6558.6 6560.8 4527.6 4772.2 4779.3 4788.9 4791.3 6656.8 6674.8 6800.4 6805.1 6822.3 4892.3 4899.5 4905.8 4905.8 4908.5 4926.9 4935.2 4953.0 4956.2 4981.3 5568.6 5576.6 5587.3 5599.6 5608.5 6540.8 6576.2 6584.0 6624.2 6657.4 1701.4 1705.2 1713.8 1719.7 1723.4 1143.5 1189.5 1195.9 1200.8 1211.0 5651.5 5698.3 5708.2 5728.1 5755.2 6560.8 6571.3 6576.9 6642.6 6726.9 5593.4 5652.7 5670.9 5692.5 5695.8 3486.3 3528.6 3539.0 3548.7 3553.4 6380.6 6416.3 6430.3 6446.5 6448.5 6666.2 6831.9 6865.5 6870.9 6875.7 6331.6 6333.7 6411.6 6419.5 6449.7 5936.9 6548.7 6596.0 6618.5 6620.3 6435.3 6507.3 6517.9 6557.6 6572.8 6201.1 6237.7 6257.6 6273.8 6277.3 4746.7 4842.9 4852.2 4858.9 4883.6 6353.0 6499.5 6502.2 6695.5 6726.4 6262.3 6476.2 6493.9 6513.6 6523.5 6503.5 6521.0 6539.2 6543.4 6550.4 6441.9 6474.3 6477.2 6484.4 6493.3 6386.4 6485.8 6512.4 6526.8 6580.5 6267.6 6286.9 6323.8 6338.4 6358.2 02:30:10 INFO - PID 10508 | 02:30:10 INFO - PID 10508 | [#5] yui.html Cycles:180 Average:23914.79 Median:19536.61 stddev:34624.59 (177.2%) stddev-sans-first:34678.43 02:30:10 INFO - PID 10508 | Values: 855.5 877.8 887.2 890.6 913.4 18523.3 19476.6 19479.3 19593.9 22527.9 21495.7 21750.1 21817.8 21850.8 21873.3 994.0 1011.2 1016.4 1016.6 1017.6 909.5 995.6 999.5 1001.5 1001.7 1051.2 1058.1 1058.4 1058.8 1059.8 1043.0 1046.7 1047.3 1047.8 1049.2 774.1 776.6 777.8 778.2 778.9 19791.9 19901.9 20033.5 20039.4 20071.2 20547.6 20661.8 21088.3 21134.9 21173.0 17936.2 18126.3 18144.5 18163.1 18178.6 3573.7 3649.5 3675.9 3676.2 3677.6 139584.0 140033.0 140839.0 142491.0 142919.0 17531.4 17551.2 17559.1 17581.5 17800.6 30818.5 31545.7 31623.0 31697.5 31697.8 7643.7 7899.0 7975.7 7992.5 8028.4 3400.9 3569.1 3834.3 3942.9 3961.7 5701.7 5913.1 5937.3 5937.5 5966.3 1083.3 1097.7 1114.7 1118.3 1126.6 677.4 685.2 697.7 701.8 706.0 11454.7 11530.7 11737.5 12396.5 12661.9 580.9 589.6 590.3 594.7 609.2 5255.3 5319.6 5354.0 5381.4 5427.2 118632.0 119256.4 120262.0 122928.0 126245.0 102322.0 103109.0 104868.6 106079.0 108640.5 86401.0 87620.6 88179.6 90813.5 92190.5 9739.2 9941.7 9947.5 10135.3 10181.9 40112.6 40183.4 40851.6 41220.2 41563.8 53238.5 53450.7 53601.7 54304.7 54443.5 15202.5 15393.5 15494.0 15527.8 15637.4 17039.8 17168.1 17198.1 17236.7 17321.8 15704.8 16005.5 16057.3 16066.8 16110.4 15482.2 15526.9 15649.1 15686.3 15728.9 15374.4 15473.2 15498.3 15500.0 15598.5 11243.1 11265.9 11373.5 11454.1 11563.4 11765.2 11982.0 12076.8 12425.1 12468.9 02:30:10 INFO - PID 10508 | -------- Summary: end -------- 02:30:10 INFO - PID 10508 | 02:30:10 INFO - TEST-INFO | 10508: exit 0 02:30:10 INFO - TEST-OK | dromaeo_css | took 1108562ms 02:30:10 INFO - TEST-START | kraken 02:30:10 INFO - Initialising browser for kraken test... 02:30:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46397/getInfo.html -profile /tmp/tmpF4V9aI/profile 02:30:10 INFO - TEST-INFO | started process 10888 (/builds/slave/test/build/application/firefox/firefox http://localhost:46397/getInfo.html) 02:30:16 INFO - TEST-INFO | 10888: exit 0 02:30:16 INFO - Browser initialized. 02:30:17 INFO - Running cycle 1/1 for kraken test... 02:30:17 INFO - Using env: {'DISPLAY': ':0', 02:30:17 INFO - 'HOME': '/home/cltbld', 02:30:17 INFO - 'JSGC_DISABLE_POISONING': '1', 02:30:17 INFO - 'LANG': 'en_US.UTF-8', 02:30:17 INFO - 'LANGUAGE': 'en_US:en', 02:30:17 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:30:17 INFO - 'LOGNAME': 'cltbld', 02:30:17 INFO - 'MAIL': '/var/mail/cltbld', 02:30:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:30:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:30:17 INFO - 'MOZ_CRASHREPORTER': '1', 02:30:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:17 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:30:17 INFO - 'MOZ_NO_REMOTE': '1', 02:30:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:30:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:17 INFO - 'NO_EM_RESTART': '1', 02:30:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:17 INFO - 'PWD': '/builds/slave/test', 02:30:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:30:17 INFO - 'RUST_BACKTRACE': 'full', 02:30:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:30:17 INFO - 'SHELL': '/bin/bash', 02:30:17 INFO - 'SHLVL': '1', 02:30:17 INFO - 'STYLO_FORCE_DISABLED': '1', 02:30:17 INFO - 'TERM': 'linux', 02:30:17 INFO - 'TMOUT': '86400', 02:30:17 INFO - 'USER': 'cltbld', 02:30:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761', 02:30:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:17 INFO - '_': '/tools/buildbot/bin/python'} 02:30:17 INFO - TEST-INFO | started process 11086 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF4V9aI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:30:17 INFO - PID 11086 | 02:30:17 INFO - PID 11086 | (/builds/slave/test/build/application/firefox/firefox:11137): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:30:17 INFO - PID 11086 | 02:30:28 INFO - PID 11086 | RSS: Main: 168824832 02:30:28 INFO - PID 11086 | 02:30:30 INFO - PID 11086 | Cycle 1(1): loaded http://localhost:46397/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46397/tests/kraken/driver.html?testName=audio-beat-detection) 02:30:31 INFO - PID 11086 | RSS: Main: 173625344 02:30:31 INFO - PID 11086 | 02:30:34 INFO - PID 11086 | Cycle 1(1): loaded http://localhost:46397/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46397/tests/kraken/driver.html?testName=audio-dft) 02:30:35 INFO - PID 11086 | RSS: Main: 173883392 02:30:35 INFO - PID 11086 | 02:30:38 INFO - PID 11086 | Cycle 1(1): loaded http://localhost:46397/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46397/tests/kraken/driver.html?testName=audio-fft) 02:30:38 INFO - PID 11086 | RSS: Main: 169451520 02:30:38 INFO - PID 11086 | 02:30:40 INFO - PID 11086 | Cycle 1(1): loaded http://localhost:46397/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46397/tests/kraken/driver.html?testName=audio-oscillator) 02:30:41 INFO - PID 11086 | RSS: Main: 170188800 02:30:41 INFO - PID 11086 | 02:30:43 INFO - PID 11086 | Cycle 1(1): loaded http://localhost:46397/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46397/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:30:44 INFO - PID 11086 | RSS: Main: 170577920 02:30:44 INFO - PID 11086 | 02:30:47 INFO - PID 11086 | Cycle 1(1): loaded http://localhost:46397/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46397/tests/kraken/driver.html?testName=imaging-darkroom) 02:30:48 INFO - PID 11086 | RSS: Main: 173330432 02:30:48 INFO - PID 11086 | 02:30:51 INFO - PID 11086 | Cycle 1(1): loaded http://localhost:46397/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46397/tests/kraken/driver.html?testName=imaging-desaturate) 02:30:52 INFO - PID 11086 | RSS: Main: 173232128 02:30:52 INFO - PID 11086 | 02:30:55 INFO - PID 11086 | Cycle 1(1): loaded http://localhost:46397/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46397/tests/kraken/driver.html?testName=json-parse-financial) 02:30:55 INFO - PID 11086 | RSS: Main: 173785088 02:30:55 INFO - PID 11086 | 02:30:57 INFO - PID 11086 | Cycle 1(1): loaded http://localhost:46397/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46397/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:30:58 INFO - PID 11086 | RSS: Main: 173613056 02:30:58 INFO - PID 11086 | 02:30:59 INFO - PID 11086 | Cycle 1(1): loaded http://localhost:46397/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46397/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:31:00 INFO - PID 11086 | RSS: Main: 171208704 02:31:00 INFO - PID 11086 | 02:31:02 INFO - PID 11086 | Cycle 1(1): loaded http://localhost:46397/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46397/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:31:03 INFO - PID 11086 | RSS: Main: 170364928 02:31:03 INFO - PID 11086 | 02:31:05 INFO - PID 11086 | Cycle 1(1): loaded http://localhost:46397/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46397/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:31:06 INFO - PID 11086 | RSS: Main: 171253760 02:31:06 INFO - PID 11086 | 02:31:09 INFO - PID 11086 | Cycle 1(1): loaded http://localhost:46397/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46397/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:31:10 INFO - PID 11086 | RSS: Main: 171286528 02:31:10 INFO - PID 11086 | 02:31:11 INFO - PID 11086 | Cycle 1(1): loaded http://localhost:46397/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46397/tests/kraken/driver.html?testName=ai-astar) 02:31:12 INFO - PID 11086 | RSS: Main: 172539904 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | __start_tp_report 02:31:12 INFO - PID 11086 | _x_x_mozilla_page_load 02:31:12 INFO - PID 11086 | _x_x_mozilla_page_load_details 02:31:12 INFO - PID 11086 | |i|pagename|runs| 02:31:12 INFO - PID 11086 | |0;ai-astar;107;107;108;108;108;114;112;110;109;107 02:31:12 INFO - PID 11086 | |1;audio-beat-detection;117;121;115;117;115;118;116;117;116;116 02:31:12 INFO - PID 11086 | |2;audio-dft;162;161;162;164;162;165;169;166;161;165 02:31:12 INFO - PID 11086 | |3;audio-fft;75;74;73;73;74;82;74;75;74;75 02:31:12 INFO - PID 11086 | |4;audio-oscillator;81;82;78;80;80;79;79;80;80;79 02:31:12 INFO - PID 11086 | |5;imaging-gaussian-blur;111;114;110;114;115;114;112;114;113;114 02:31:12 INFO - PID 11086 | |6;imaging-darkroom;148;156;148;148;148;147;148;148;147;148 02:31:12 INFO - PID 11086 | |7;imaging-desaturate;102;99;102;94;94;94;93;94;95;95 02:31:12 INFO - PID 11086 | |8;json-parse-financial;55;56;53;53;54;53;50;50;50;52 02:31:12 INFO - PID 11086 | |9;json-stringify-tinderbox;39;39;38;43;39;38;38;38;38;39 02:31:12 INFO - PID 11086 | |10;stanford-crypto-aes;74;77;75;75;75;77;77;79;74;74 02:31:12 INFO - PID 11086 | |11;stanford-crypto-ccm;125;117;117;122;128;118;120;124;134;115 02:31:12 INFO - PID 11086 | |12;stanford-crypto-pbkdf2;173;171;172;171;172;168;179;174;184;180 02:31:12 INFO - PID 11086 | |13;stanford-crypto-sha256-iterative;70;65;66;67;64;64;66;65;63;63 02:31:12 INFO - PID 11086 | __end_tp_report 02:31:12 INFO - PID 11086 | __start_cc_report 02:31:12 INFO - PID 11086 | _x_x_mozilla_cycle_collect,942 02:31:12 INFO - PID 11086 | __end_cc_report 02:31:12 INFO - PID 11086 | __startTimestamp1505035872128__endTimestamp 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | ------- Summary: start ------- 02:31:12 INFO - PID 11086 | Number of tests: 14 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | [#0] ai-astar Cycles:10 Average:109.00 Median:108.50 stddev:2.36 (2.2%) stddev-sans-first:2.39 02:31:12 INFO - PID 11086 | Values: 107.0 107.0 108.0 108.0 108.0 114.0 112.0 110.0 109.0 107.0 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | [#1] audio-beat-detection Cycles:10 Average:116.80 Median:117.00 stddev:1.75 (1.5%) stddev-sans-first:1.86 02:31:12 INFO - PID 11086 | Values: 117.0 121.0 115.0 117.0 115.0 118.0 116.0 117.0 116.0 116.0 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.50 stddev:2.58 (1.6%) stddev-sans-first:2.67 02:31:12 INFO - PID 11086 | Values: 162.0 161.0 162.0 164.0 162.0 165.0 169.0 166.0 161.0 165.0 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | [#3] audio-fft Cycles:10 Average:74.90 Median:74.50 stddev:2.60 (3.5%) stddev-sans-first:2.76 02:31:12 INFO - PID 11086 | Values: 75.0 74.0 73.0 73.0 74.0 82.0 74.0 75.0 74.0 75.0 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:80.00 stddev:1.14 (1.4%) stddev-sans-first:1.12 02:31:12 INFO - PID 11086 | Values: 81.0 82.0 78.0 80.0 80.0 79.0 79.0 80.0 80.0 79.0 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:114.00 stddev:1.60 (1.4%) stddev-sans-first:1.50 02:31:12 INFO - PID 11086 | Values: 111.0 114.0 110.0 114.0 115.0 114.0 112.0 114.0 113.0 114.0 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.00 stddev:2.63 (1.8%) stddev-sans-first:2.78 02:31:12 INFO - PID 11086 | Values: 148.0 156.0 148.0 148.0 148.0 147.0 148.0 148.0 147.0 148.0 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:94.00 stddev:3.46 (3.7%) stddev-sans-first:2.96 02:31:12 INFO - PID 11086 | Values: 102.0 99.0 102.0 94.0 94.0 94.0 93.0 94.0 95.0 95.0 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:2.12 (4.0%) stddev-sans-first:2.06 02:31:12 INFO - PID 11086 | Values: 55.0 56.0 53.0 53.0 54.0 53.0 50.0 50.0 50.0 52.0 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | [#9] json-stringify-tinderbox Cycles:10 Average:38.90 Median:39.00 stddev:1.52 (3.9%) stddev-sans-first:1.62 02:31:12 INFO - PID 11086 | Values: 39.0 39.0 38.0 43.0 39.0 38.0 38.0 38.0 38.0 39.0 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:76.00 stddev:1.70 (2.2%) stddev-sans-first:1.69 02:31:12 INFO - PID 11086 | Values: 74.0 77.0 75.0 75.0 75.0 77.0 77.0 79.0 74.0 74.0 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:123.00 stddev:5.89 (4.8%) stddev-sans-first:6.14 02:31:12 INFO - PID 11086 | Values: 125.0 117.0 117.0 122.0 128.0 118.0 120.0 124.0 134.0 115.0 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:173.50 stddev:4.97 (2.9%) stddev-sans-first:5.25 02:31:12 INFO - PID 11086 | Values: 173.0 171.0 172.0 171.0 172.0 168.0 179.0 174.0 184.0 180.0 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:2.11 (3.2%) stddev-sans-first:1.39 02:31:12 INFO - PID 11086 | Values: 70.0 65.0 66.0 67.0 64.0 64.0 66.0 65.0 63.0 63.0 02:31:12 INFO - PID 11086 | -------- Summary: end -------- 02:31:12 INFO - PID 11086 | 02:31:12 INFO - PID 11086 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 02:31:12 INFO - TEST-INFO | 11086: exit 0 02:31:12 INFO - TEST-OK | kraken | took 61854ms 02:31:12 INFO - SUITE-END | took 1170s 02:31:13 INFO - Completed test suite (00:19:30) 02:31:13 INFO - javascript benchmark 02:31:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8383.825526509687, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.7972131811434, 3146.056183145056, 3147.3075923296865, 3154.4164329599025, 3158.1473002289376, 6078.300995385532, 6161.045038019103, 6202.7208775605095, 6313.242410910691, 6339.778107766223, 6098.939010609893, 6147.8770424591485, 6161.476274516672, 6167.290761562422, 6185.350538193492, 5697.715114244292, 5780.2196703444915, 5805.564582656297, 5827.329857066428, 5845.123231515286, 89.02189248717642, 5779.855503612402, 5826.009578371666, 5851.180834683148, 5873.207117039187, 5241.86895327616, 5638.097904335307, 5661.7735290588325, 5803.970980145094, 5813.709314534299, 5687.516561092312, 5708.600397972144, 5775.422457754191, 5783.190353350535, 5794.5074668653215, 5675.943240567624, 5711.543076553866, 5769.682667453289, 5783.277090363705, 5808.680522571257, 6207.782727604512, 6231.968840155816, 6239.844003899939, 6243.1883855099, 6278.4035516625845, 6470.191226096738, 6561.639109848957, 6686.13080299558, 6697.966510167466, 6763.458923286125, 6707.228668703113, 6732.697028633724, 6735.0, 6737.93262067378, 6745.527813053088, 6108.419700128481, 6158.630482171039, 6210.285817130997, 6232.688365581703, 6321.336259692758, 6898.482613803984, 6919.930800691928, 6968.965155174243, 6983.82540436483, 6985.615791131435, 6564.409203171737, 6571.3757193066585, 6583.0, 6586.473082153416, 6688.832779180462, 6493.25327587324, 6556.213254409406, 6658.866822663616, 6698.966505167443, 6754.898676519856, 6690.163729533809, 6701.028350889192, 6706.295838936939, 6711.865762684719, 6748.0, 6683.097781799492, 6756.763513277012, 6775.0, 6777.186737591521, 6786.219584747719, 5205.297284866495, 5229.790808367623, 5283.735813209324, 5284.0, 5297.284866543045, 4478.9552104478535, 4534.115847409789, 4562.064776720765, 4592.7014744041535, 4676.625869930397, 5776.508996735324, 5788.247527821441, 5819.330776960619, 5820.621659592198, 5823.359430462646, 6601.0, 6700.095487109275, 6769.05233267343, 6793.116894803644, 6802.727890884408, 5597.860053498695, 5727.398623144593, 5730.226419433407, 5794.0439827428, 5801.477866991907, 5687.289088863892, 5713.942860571341, 5767.682777447197, 5768.336641286306, 5776.768929242868, 6496.285408605049, 6504.739810407626, 6506.772262970773, 6509.707063182168, 6511.902321465182, 6653.700583473658, 6655.134832471747, 6655.633940133339, 6655.86688266232, 6767.39093481589, 6170.53720970938, 6337.809865704036, 6357.841053973502, 6390.4248617624635, 6481.740730370732, 6501.772437964649, 6531.183602049744, 6567.179102612174, 6626.171728533934, 6628.171478565179, 6725.39471447572, 6733.966330168318, 6791.422729068085, 6795.150606174228, 6825.692843822139, 6469.838254043687, 6498.480121590167, 6500.707468164039, 6577.671116444254, 6585.80242592723, 6338.714757836001, 6437.967810160919, 6493.675316234264, 6565.671716414065, 6579.967100164468, 6388.2972872984865, 6484.902726459012, 6487.967560162169, 6496.9025464617125, 6498.870022599616, 6529.053287273414, 6548.967255163694, 6551.574147680385, 6607.405333519814, 6638.336166383323, 6310.716017779119, 6313.463355614824, 6337.9366206337345, 6390.392912673288, 6441.806745797446], "value": 6050.640533901229, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.742048675154, 848.8811566380712, 857.4726543175949, 861.4099341950764, 870.7823044238941, 37507.62492375075, 40896.795516022416, 41081.58918410815, 41096.38355424671, 41468.0, 37331.44002839959, 37552.248955020885, 37584.62415375846, 37596.0, 37672.24655506888, 7042.894356584642, 7105.111861017373, 7686.884696729554, 7887.8028049298655, 7897.605119744018, 7742.2644848739565, 7823.45235833489, 7875.684972601089, 7880.2513761192595, 7880.330171935364, 7819.804504887366, 7869.921300787005, 7880.172581878906, 7897.8025549361155, 7903.683852645887, 7821.843563128734, 7873.173316801711, 7881.369490440751, 7882.172371900925, 7883.566403847786, 7753.534787912687, 7796.961015194945, 7800.726974555863, 7804.765857024298, 7805.765827025199, 38441.0, 38467.42298865519, 38673.22653546942, 38821.61178388208, 38822.41766373507, 3573.446115852047, 3607.314610224049, 3612.3858943979585, 3613.5121758562523, 3624.2932628137523, 31368.686313136805, 31378.431078445985, 31389.52915706266, 31396.0, 31407.05778826639, 5044.772985215674, 5059.848204553869, 5087.847364579032, 5103.234514822806, 5105.897882042375, 181917.0, 182245.0, 182299.0, 182988.0, 183441.0, 41071.58928410737, 48106.518934810905, 48309.75845120752, 48327.650511454136, 48443.75778121157, 44116.77941610271, 48810.0, 49317.0, 49473.75263123661, 49478.257826132634, 14607.488737894122, 14738.484153054591, 14746.262686865613, 14770.483033094006, 14780.852191477947, 11920.688724240326, 11947.223430477165, 11950.342731149696, 11961.0, 12032.939835300942, 13286.0, 13344.733105337838, 13429.798553021712, 13473.663158420923, 13486.190828550318, 5443.292371991616, 5525.309336332958, 5628.549716022709, 5659.43405659439, 5740.196372507852, 997.7755005123935, 1005.9446730429896, 1007.2093406675871, 1020.7550187954986, 1035.5857656937135, 22538.549229015327, 22680.319590411986, 22744.31767046958, 23057.19299824498, 23137.7686223139, 1096.2381145104237, 1097.4510653342013, 1113.1984970820995, 1122.6239209864787, 1126.4142645824124, 11958.940205299092, 12005.579804706793, 12218.75562488763, 12224.083193760503, 12236.0, 213054.0, 213314.0, 213763.0, 214307.0, 214440.0, 50348.748256258485, 50577.0, 50674.23988640173, 50775.0, 50873.491265087614, 1416.8653977872086, 1458.7228426598913, 1465.5383554180398, 1469.397547005744, 1475.5352064099775, 22166.224182154194, 22264.554708906056, 22401.887990559942, 22443.0, 22616.321510354715, 35452.29095418129, 35519.82240088783, 35549.46675799813, 35571.28857422785, 35602.643973559934, 185418.0, 187234.06382967997, 188123.0, 189182.0, 190468.0, 32396.514052289705, 32592.185195370304, 35032.0, 35857.64142358543, 35921.64078359288, 43775.78112109547, 44614.55385446104, 44932.326015110455, 45019.32471012872, 45366.09267814691, 33315.0, 33332.0, 33377.332453351286, 33609.83195084009, 33818.3236335267, 32700.83649581737, 32832.343353132324, 32878.34243315168, 33091.66908330886, 33540.832295838365, 35530.822345888104, 37253.441198382585, 37302.253954920205, 37349.43975840419, 37484.81257593694, 31465.842670787417, 31790.36419271648, 32017.359652807278, 32049.519257210693, 32242.0, 23813.880930595235, 23867.880660596587, 24036.39909002289, 24483.38791530226, 24600.507989839745], "value": 16902.438325373245, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.0805269477786, 561.6349372907612, 564.5427203964787, 568.0995621939226, 575.3153747041019, 21583.67624485632, 22431.102755889766, 22639.0, 22642.88678556607, 22685.886570567123, 23994.40013999651, 24553.75446245537, 24971.126010589633, 25194.0, 25489.490210195785, 6370.745170193187, 6460.41856232939, 6506.349365063479, 6512.6092434454085, 6513.185851768505, 6229.968850155743, 6432.163818703562, 6505.674716264191, 6543.640099794509, 6544.443722283611, 6477.157969463963, 6492.123563318963, 6505.828950788856, 6518.706658200369, 6524.543281970264, 6505.4145126938565, 6518.315576864408, 6522.119513865615, 6522.15212022434, 6523.021546767975, 5942.3760505146765, 6162.907556386658, 6171.043488259327, 6172.969135154295, 6173.536984726164, 29203.0, 29258.561121583192, 29650.70349296501, 29746.0, 29783.404331913458, 2004.3385682724665, 2036.2364113457454, 2053.5892821435623, 2055.7533096028424, 2062.3709768520594, 18730.34443794461, 18796.906015469973, 18950.43148705541, 19522.80477195224, 19878.503037424034, 2446.9755302446924, 2458.0659349447096, 2499.9125030624023, 2500.3999040230397, 2509.4102885821817, 116536.0, 119977.0, 131100.6889931098, 136876.0, 142103.0, 14432.209965915801, 14735.305439874337, 14976.850231497545, 14997.850021499646, 15014.699706006037, 22976.885115574314, 23014.194503192644, 23022.65466018011, 23036.769632303796, 23047.0, 9460.290478214161, 9650.613975440903, 9659.275554333453, 9672.419654820733, 9826.213902887752, 8661.91338086611, 8695.173958473935, 8724.171203735636, 8741.781455463537, 8840.778980525409, 8746.65013399457, 8880.978687450897, 9067.637294508279, 9181.0818918109, 9254.953725231331, 2563.974360256411, 2596.40282734972, 2696.0, 2725.4549090182045, 2805.761510271609, 918.6738707758783, 932.5430539035959, 937.8311903857372, 944.3342443577261, 956.0582825916466, 19139.712904306445, 19422.22311107568, 19680.40958771239, 19828.20687172526, 19950.002499874947, 985.531872360623, 989.450854775592, 993.3692105512907, 1000.8648832407532, 1011.8330475471465, 10679.412632305142, 10730.2488825783, 10964.0, 10976.176786741027, 11048.06091482233, 438446.0, 447198.0, 447530.0, 450876.0, 454283.0, 102087.48956255171, 104838.47580762047, 107325.4633726842, 109722.0, 110340.0, 1045.1168762395764, 1055.287680815462, 1146.2262972493534, 1172.0623501199007, 1201.3452668295624, 20740.68888966697, 20863.26978555804, 20955.58088838245, 20996.265130720352, 21107.788922110583, 53989.0, 54487.0, 55729.0, 56456.0, 56714.0, 70311.0, 70550.29449705438, 71026.28973710403, 71036.64481677559, 71301.28698713153, 13676.863231367957, 13706.109102908278, 13709.931450343083, 14311.856881431053, 14423.855761442252, 22794.886025569765, 22856.428589285402, 23249.76750232476, 23415.297541073796, 23430.414239644146, 16442.588935276715, 16707.415240466526, 17623.647527049645, 17762.200700968748, 17792.822071779116, 15064.246787660353, 15711.292991815624, 16364.67270654604, 16952.57618559546, 17394.217260223068, 18666.813331866506, 18717.0, 18919.337823176123, 18955.14701838393, 19192.13635386439, 14085.507007254697, 14164.645883852574, 14193.0, 14207.147571145764, 14215.50245741394, 18537.35119270819, 18568.0, 18575.071246437896, 18634.0, 18837.24651013999], "value": 11769.594634221583, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.4886045581766, 1374.7387996280709, 1375.1336657905517, 1392.338639146405, 1394.5119208277104, 14774.926125369371, 15422.0, 15429.768553471707, 15444.84555154451, 15452.690946181083, 15069.547913562583, 15179.089254644701, 15296.617584560392, 15331.540053798404, 15350.00224985378, 2722.9727702723017, 2747.0659975608287, 2780.5829125631217, 2783.5128852450844, 2794.790390720704, 2726.2775364528416, 2742.698303186648, 2754.311422144464, 2755.2973991632107, 2756.3109222694325, 2659.7207293234223, 2665.9733402666016, 2679.223025322654, 2818.8449635270053, 2820.5205115130475, 2701.810873238874, 2704.9053283135095, 2724.223596275062, 2725.809193356466, 2726.5637498000224, 2603.1799983005294, 2663.946721065568, 2683.0206974454186, 2684.181324695967, 2685.9194224173307, 14884.62788430298, 14999.700005999819, 15010.249487525689, 15013.174275414847, 15040.097594144278, 7842.490238134503, 8125.959370203171, 8165.510069395856, 8174.918250817475, 8176.223258790405, 5141.485851414866, 5233.947660523384, 5280.07598670235, 5348.625596208267, 5357.303550538444, 1934.1586409911733, 1941.825235728777, 1967.6359873423462, 1995.7106219598222, 1998.2206939293687, 26671.066512672158, 26725.331866703295, 26816.061437849778, 26840.06059787898, 26875.86562067177, 6616.470682345401, 6796.184457864989, 6816.147981502312, 6952.200496942916, 6977.6511174441075, 16316.75524867128, 16350.918245408935, 16749.58126046834, 17357.045362505185, 17391.91304043497, 7576.924230757732, 7761.534307941429, 7785.961070194613, 7819.335356494762, 7828.804279892935, 7146.821329466701, 7182.784516464514, 7188.820279493055, 7220.061392019109, 7270.854582908312, 4831.51684831514, 4979.352684151109, 4994.825181118644, 5007.37407824022, 5013.548780609763, 1355.0, 1372.7597670407638, 1374.883134933542, 1382.4608402722947, 1385.7090011097782, 868.1015149320423, 884.5577211394303, 897.3314880414133, 900.8919426849777, 901.2609660078673, 7414.295641914009, 7631.618419079024, 7646.158922518519, 7775.961120194363, 7806.453548251568, 714.1929619530001, 720.1250480666016, 721.7942886277385, 723.3345322303494, 735.1068451831051, 4692.906141877143, 5031.974840125776, 5164.586833053347, 5316.1494160934835, 5359.08895487768, 20406.183752650024, 20992.055357508947, 21214.681779773317, 21365.14539418437, 21654.24210152637, 20783.58432831335, 21246.0, 21522.246721364678, 21684.24105156312, 21700.782992169876, 10433.113185379329, 10525.473726313654, 10611.734706632242, 10745.14038876888, 10749.301295415773, 7999.160088190656, 8081.15147909461, 8189.877151842847, 8225.177482251727, 8337.791555211168, 18136.18387172607, 18306.81693183051, 18451.077446127907, 18581.721274181167, 18992.335268265546, 18983.0, 19019.809801901803, 19020.80979190246, 19125.80874191296, 19127.0, 10857.891421085687, 10949.0, 10957.12343012573, 10958.232923695583, 10966.232363734462, 13621.931890340486, 13781.310934453037, 13783.310834458036, 13785.931070344985, 13789.517366892513, 10979.670609881716, 11002.614908478165, 11091.778164436504, 11168.553257869919, 11300.717482063013, 10430.68707938763, 10437.478126093816, 10438.58245670195, 10712.35725856451, 10872.238943274211, 9309.487978161265, 9416.62333506652, 9496.85754713666, 9514.571844266886, 9521.523923803643, 7087.893681594884, 7168.498205125591, 7182.569045857265, 7183.20984691694, 7228.421726261991, 7135.785926422215, 7314.341709246193, 7328.377087947584, 7343.816404589928, 7440.73957411488], "value": 6528.604085508195, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.87853036740813, 504.5963229416466, 510.3900838497995, 518.5618152661001, 518.5644058990449, 6277.273749718824, 6317.0, 6331.715072821728, 6339.6830158492, 6351.682415879199, 6202.689865506718, 6215.160953271307, 6228.19033525641, 6229.501639868811, 6245.531585131111, 5093.388793344804, 5106.259592359106, 5109.3357863477695, 5111.495367270029, 5122.641415100945, 4789.592884604813, 4864.391951006124, 5031.257964409406, 5081.237814327862, 5093.567046801027, 4829.154897892872, 4852.199387101142, 4857.878553036167, 4877.975610121945, 4879.975600122012, 4820.276958456225, 4848.8302909398, 4856.927146092811, 4877.414710234777, 4878.0, 4220.07158425146, 4345.348197770328, 4376.956230437687, 4377.430933978594, 4380.123975204971, 6045.186444066806, 6075.878482430371, 6092.329843717188, 6099.6950152492645, 6103.267607887037, 5536.723163841792, 5569.498745112919, 5576.302962129734, 5592.328920529562, 5600.943990560083, 6520.804375868732, 6523.347665233486, 6538.0, 6558.573692709959, 6560.835979100513, 4527.615152712024, 4772.16487114757, 4779.3308936748535, 4788.880277993043, 4791.305260737174, 6656.767013154565, 6674.799756007279, 6800.4219641330055, 6805.149356330458, 6822.271091563414, 4892.263246547495, 4899.461059283476, 4905.754712264373, 4905.779239934212, 4908.460069392364, 4926.852194434173, 4935.185694360391, 4953.0, 4956.231784073474, 4981.302617633534, 5568.554515638739, 5576.553875689935, 5587.329520457572, 5599.60802743804, 5608.46719561641, 6540.8364790880605, 6576.210854697467, 6583.967080164664, 6624.211462904988, 6657.367550082734, 1701.4470297153475, 1705.224123024021, 1713.8089028125582, 1719.72484402495, 1723.3709695960883, 1143.5311522275993, 1189.5004098278744, 1195.8804119587971, 1200.8378868852767, 1210.9878901211052, 5651.547876169897, 5698.287714035746, 5708.172315014383, 5728.112142617901, 5755.22304488897, 6560.835979100465, 6571.2771595124495, 6576.868462630816, 6642.63465509392, 6726.8654626908165, 5593.440655934374, 5652.74562644682, 5670.858228544319, 5692.516136128475, 5695.772169113272, 3486.3027394521196, 3528.6118526962014, 3539.0, 3548.6806187443253, 3553.4136867417105, 6380.585261957958, 6416.294207637156, 6430.260520040255, 6446.548741588138, 6448.4846061175585, 6666.2333831609985, 6831.897521537181, 6865.485088618274, 6870.896936545956, 6875.656217189221, 6331.588446750947, 6333.714982825784, 6411.647359395278, 6419.51853610981, 6449.709763060673, 5936.871994321065, 6548.728273739685, 6596.0, 6618.525274231067, 6620.285682870192, 6435.270076493867, 6507.349265073455, 6517.902231466437, 6557.573757705733, 6572.80281591553, 6201.131841542097, 6237.721267140135, 6257.56197066201, 6273.765208484164, 6277.2781130170615, 4746.691465054761, 4842.854714358575, 4852.1508735971765, 4858.92711609319, 4883.6325828768, 6353.0, 6499.512536559682, 6502.187226596676, 6695.451410752309, 6726.3520437493125, 6262.279837818709, 6476.222853257639, 6493.870122597427, 6513.632137251041, 6523.543351965317, 6503.479721622353, 6520.967395162994, 6539.247986481616, 6543.411093001652, 6550.379848060814, 6441.935580644321, 6474.320196379501, 6477.190351206099, 6484.351564843478, 6493.285738568659, 6386.425221730066, 6485.77299794505, 6512.413882750575, 6526.757607555127, 6580.473562114924, 6267.62394256346, 6286.9371306288185, 6323.810285691437, 6338.429541341301, 6358.205224346957], "value": 4987.314249567922, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [855.5337341149069, 877.8288233794405, 887.2458410351202, 890.6125835261661, 913.4473643445715, 18523.259069637214, 19476.610467790637, 19479.31822386215, 19593.902030489862, 22527.887360563214, 21495.67756483654, 21750.12999480019, 21817.781822181772, 21850.781492185073, 21873.343799685994, 994.0208894239187, 1011.1859952738043, 1016.4054028393399, 1016.6136867990153, 1017.6082208349802, 909.4588719711794, 995.5768798260747, 999.4952548962764, 1001.539291925715, 1001.7145113642613, 1051.1800795379577, 1058.1376178414605, 1058.3755584205317, 1058.7776566920957, 1059.8251288537383, 1043.0351924469835, 1046.6807623674777, 1047.2983101322095, 1047.842823576462, 1049.18163832211, 774.144570249877, 776.6388629287352, 777.8249893773913, 778.2178910195274, 778.8987431633908, 19791.901040494704, 19901.900490497454, 20033.499162520908, 20039.398818035483, 20071.1971521139, 20547.589048219103, 20661.793382066287, 21088.2619108332, 21134.89432552843, 21173.04721287546, 17936.19287132069, 18126.274949002025, 18144.546386340317, 18163.09184540768, 18178.636427271515, 3573.6783689468075, 3649.489071529988, 3675.9448608270895, 3676.2096149327754, 3677.632236776301, 139584.0, 140033.0, 140839.0, 142491.0, 142918.99999999895, 17531.386401475887, 17551.210195541233, 17559.122043897754, 17581.472555823344, 17800.55498612545, 30818.53772193419, 31545.684543154275, 31623.0, 31697.52453713196, 31697.8415107923, 7643.656035478417, 7899.0, 7975.680972761141, 7992.480488768211, 8028.397870159762, 3400.880969166067, 3569.1434055826935, 3834.309824231609, 3942.8619998299923, 3961.7028722845325, 5701.71491425427, 5913.083472061838, 5937.287525496968, 5937.465628093406, 5966.254218222723, 1083.2958576924905, 1097.6597254851022, 1114.6823155400834, 1118.2898859224288, 1126.633844000703, 677.376813331736, 685.2222727204659, 697.7453229571272, 701.7578935267427, 706.0468367703662, 11454.713632159262, 11530.711732206762, 11737.530498779954, 12396.504139834306, 12661.936690316674, 580.9186713860063, 589.5843430381657, 590.2533295381346, 594.7145370222318, 609.1684850179473, 5255.264263003182, 5319.601029922694, 5354.0, 5381.3811411687375, 5427.240186373911, 118632.0, 119256.40371798085, 120262.0, 122928.0, 126245.0, 102322.0, 103109.0, 104868.64904698434, 106079.0, 108640.45679771551, 86401.0, 87620.56189719011, 88179.55910220408, 90813.54593226992, 92190.53904730434, 9739.172170365599, 9941.65204217849, 9947.452890091114, 10135.290529662852, 10181.949090254502, 40112.59887401205, 40183.3972490407, 40851.591484084776, 41220.1755964885, 41563.7921810389, 53238.46761532335, 53450.73274633602, 53601.731991339795, 54304.72847635736, 54443.45556544384, 15202.543923682308, 15393.461228856937, 15494.0, 15527.84472155264, 15637.374505020127, 17039.829601703823, 17168.141592920554, 17198.14009299555, 17236.74144887853, 17321.826781732525, 15704.842951570337, 16005.519834404986, 16057.277422516248, 16066.758998614796, 16110.355585776437, 15482.225888705294, 15526.9223653881, 15649.1392973383, 15686.294116765, 15728.921355393608, 15374.38502459889, 15473.226338682796, 15498.302576384316, 15500.0, 15598.532044038697, 11243.10055195566, 11265.943670281596, 11373.488193031499, 11454.14093942941, 11563.421828908353, 11765.235259708092, 11982.041436685218, 12076.75846483083, 12425.068119890864, 12468.93765531203], "value": 8859.881871169331, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1431.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 108.0, 108.0, 108.0, 114.0, 112.0, 110.0, 109.0, 107.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 121.0, 115.0, 117.0, 115.0, 118.0, 116.0, 117.0, 116.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 164.0, 162.0, 165.0, 169.0, 166.0, 161.0, 165.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 73.0, 74.0, 82.0, 74.0, 75.0, 74.0, 75.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 78.0, 80.0, 80.0, 79.0, 79.0, 80.0, 80.0, 79.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 110.0, 114.0, 115.0, 114.0, 112.0, 114.0, 113.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 156.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 99.0, 102.0, 94.0, 94.0, 94.0, 93.0, 94.0, 95.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 53.0, 53.0, 54.0, 53.0, 50.0, 50.0, 50.0, 52.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 38.0, 43.0, 39.0, 38.0, 38.0, 38.0, 38.0, 39.0], "value": 38.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 75.0, 75.0, 77.0, 77.0, 79.0, 74.0, 74.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 117.0, 117.0, 122.0, 128.0, 118.0, 120.0, 124.0, 134.0, 115.0], "value": 122.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 172.0, 171.0, 172.0, 168.0, 179.0, 174.0, 184.0, 180.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 66.0, 67.0, 64.0, 64.0, 66.0, 65.0, 63.0, 63.0], "value": 65.3, "unit": "score"}]}]} 02:31:13 INFO - Return code: 0 02:31:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:31:13 INFO - # TBPL SUCCESS # 02:31:13 INFO - Running post-action listener: _package_coverage_data 02:31:13 INFO - Running post-action listener: _resource_record_post_action 02:31:13 INFO - [mozharness: 2017-09-10 09:31:13.395095Z] Finished run-tests step (success) 02:31:13 INFO - Running post-run listener: _resource_record_post_run 02:31:13 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297144320; Read time: 8; Write time: 140260 02:31:13 INFO - TinderboxPrint: CPU usage
13.1% 02:31:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:31:13 INFO - TinderboxPrint: I/O write bytes / time
297,144,320 / 140,260 02:31:13 INFO - TinderboxPrint: CPU idle
8,229.6 (86.9%) 02:31:13 INFO - TinderboxPrint: CPU user
1,191.0 (12.6%) 02:31:13 INFO - TinderboxPrint: Swap in / out
0 / 0 02:31:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 9908224; Read time: 0; Write time: 808 02:31:13 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:31:13 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 287236096; Read time: 0; Write time: 139452 02:31:14 INFO - Running post-run listener: _upload_blobber_files 02:31:14 INFO - Blob upload gear active. 02:31:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:31:14 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 02:31:14 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'] 02:31:14 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 02:31:14 INFO - (blobuploader) - INFO - Open directory for files ... 02:31:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 02:31:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:31:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:31:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 02:31:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:31:15 INFO - (blobuploader) - INFO - Done attempting. 02:31:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:31:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:31:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:31:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:31:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:31:16 INFO - (blobuploader) - INFO - Done attempting. 02:31:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:31:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:31:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:31:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:31:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:31:23 INFO - (blobuploader) - INFO - Done attempting. 02:31:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 02:31:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:31:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:31:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 02:31:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:31:24 INFO - (blobuploader) - INFO - Done attempting. 02:31:24 INFO - (blobuploader) - INFO - Iteration through files over. 02:31:24 INFO - Return code: 0 02:31:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:31:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:31:24 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4416fce97ab51ca574ef4f3372c33f9b7212778763704d259c32aabc08c26bb4977dbd89d2d1c7347e9597ae290486f075093bed8d16e140d29987882f200e9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6671d18f38d978b727cead55e09fc9afcb4155e6ef8e27917eff7e60cbcce3456b5c322535aa15831e266cdae8d26940b488a4ce79dcd08768d45df53a71741c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c1e1ad4e29489ee0815155b6dbf6610f3368e8d923c540c616237a84d6c8ae9c724e027e099123c1262879136fe1a0581dbaa211befb88cc5a8a139ed8f542c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08087c5aafaaf86c98a9aaad4ece5186de584d99d6d07e32bdce2a42acef6cbe1c4af63043788518b0a6a758ebe3d5cc86ec555c099045c9d4a473d32b7a0ffe"} 02:31:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:31:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:31:24 INFO - Contents: 02:31:24 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4416fce97ab51ca574ef4f3372c33f9b7212778763704d259c32aabc08c26bb4977dbd89d2d1c7347e9597ae290486f075093bed8d16e140d29987882f200e9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6671d18f38d978b727cead55e09fc9afcb4155e6ef8e27917eff7e60cbcce3456b5c322535aa15831e266cdae8d26940b488a4ce79dcd08768d45df53a71741c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c1e1ad4e29489ee0815155b6dbf6610f3368e8d923c540c616237a84d6c8ae9c724e027e099123c1262879136fe1a0581dbaa211befb88cc5a8a139ed8f542c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08087c5aafaaf86c98a9aaad4ece5186de584d99d6d07e32bdce2a42acef6cbe1c4af63043788518b0a6a758ebe3d5cc86ec555c099045c9d4a473d32b7a0ffe"} 02:31:24 INFO - Running post-run listener: copy_logs_to_upload_dir 02:31:24 INFO - Copying logs to upload dir... 02:31:24 INFO - mkdir: /builds/slave/test/build/upload/logs 02:31:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.916269 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-09-10 02:31:24.533573) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-10 02:31:24.536907) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761 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/c4416fce97ab51ca574ef4f3372c33f9b7212778763704d259c32aabc08c26bb4977dbd89d2d1c7347e9597ae290486f075093bed8d16e140d29987882f200e9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6671d18f38d978b727cead55e09fc9afcb4155e6ef8e27917eff7e60cbcce3456b5c322535aa15831e266cdae8d26940b488a4ce79dcd08768d45df53a71741c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c1e1ad4e29489ee0815155b6dbf6610f3368e8d923c540c616237a84d6c8ae9c724e027e099123c1262879136fe1a0581dbaa211befb88cc5a8a139ed8f542c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08087c5aafaaf86c98a9aaad4ece5186de584d99d6d07e32bdce2a42acef6cbe1c4af63043788518b0a6a758ebe3d5cc86ec555c099045c9d4a473d32b7a0ffe"} build_url:https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/DRhsJxRzQc2SbL7C1Z9-Ww/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4416fce97ab51ca574ef4f3372c33f9b7212778763704d259c32aabc08c26bb4977dbd89d2d1c7347e9597ae290486f075093bed8d16e140d29987882f200e9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6671d18f38d978b727cead55e09fc9afcb4155e6ef8e27917eff7e60cbcce3456b5c322535aa15831e266cdae8d26940b488a4ce79dcd08768d45df53a71741c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c1e1ad4e29489ee0815155b6dbf6610f3368e8d923c540c616237a84d6c8ae9c724e027e099123c1262879136fe1a0581dbaa211befb88cc5a8a139ed8f542c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08087c5aafaaf86c98a9aaad4ece5186de584d99d6d07e32bdce2a42acef6cbe1c4af63043788518b0a6a758ebe3d5cc86ec555c099045c9d4a473d32b7a0ffe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-10 02:31:24.565340) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 02:31:24.565704) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1505034606.659525-1378922761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004575 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 02:31:24.649497) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-10 02:31:24.649808) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-10 02:31:24.650126) ========= ========= Total master_lag: 0.29 =========