builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-089 starttime: 1505470801.48 results: success (0) revision: f36106f3f52a9bb2769860d20568c589fc2498d0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.483705) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.484364) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.484811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.515192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.515645) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-15 03:20:01-- 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% 24.7M=0s 2017-09-15 03:20:01 (24.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116426 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.661453) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.661899) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023970 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.713997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:01.714524) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f36106f3f52a9bb2769860d20568c589fc2498d0 --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 f36106f3f52a9bb2769860d20568c589fc2498d0 --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=8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-15 03:20:01,767 truncating revision to first 12 chars 2017-09-15 03:20:01,768 Setting DEBUG logging. 2017-09-15 03:20:01,768 attempt 1/10 2017-09-15 03:20:01,768 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f36106f3f52a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-15 03:20:02,153 unpacking tar archive at: mozilla-central-f36106f3f52a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.755034 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:02.487368) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:02.487701) ========= script_repo_revision: f36106f3f52a9bb2769860d20568c589fc2498d0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:02.488117) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:02.488517) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 03:20:02.509670) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-15 03:20:02.509981) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:20:02 INFO - MultiFileLogger online at 20170915 03:20:02 in /builds/slave/test 03:20:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:20:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:20:02 INFO - {'append_to_log': False, 03:20:02 INFO - 'base_work_dir': '/builds/slave/test', 03:20:02 INFO - 'blob_upload_branch': 'Firefox', 03:20:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:20:02 INFO - 'branch': 'Firefox', 03:20:02 INFO - 'buildbot_json_path': 'buildprops.json', 03:20:02 INFO - 'code_coverage': False, 03:20:02 INFO - 'config_files': ('talos/linux_config.py',), 03:20:02 INFO - 'default_actions': ('clobber', 03:20:02 INFO - 'read-buildbot-config', 03:20:02 INFO - 'download-and-extract', 03:20:02 INFO - 'populate-webroot', 03:20:02 INFO - 'create-virtualenv', 03:20:02 INFO - 'install', 03:20:02 INFO - 'setup-mitmproxy', 03:20:02 INFO - 'run-tests'), 03:20:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:20:02 INFO - 'disable_ccov_upload': False, 03:20:02 INFO - 'disable_stylo': False, 03:20:02 INFO - 'download_minidump_stackwalk': True, 03:20:02 INFO - 'download_symbols': 'ondemand', 03:20:02 INFO - 'enable_stylo': False, 03:20:02 INFO - 'enable_webrender': False, 03:20:02 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:20:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:20:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:20:02 INFO - 'gecko_profile': False, 03:20:02 INFO - 'gecko_profile_interval': 0, 03:20:02 INFO - 'installer_path': 'installer.exe', 03:20:02 INFO - 'log_level': 'info', 03:20:02 INFO - 'log_name': 'talos', 03:20:02 INFO - 'log_to_console': True, 03:20:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:20:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:20:02 INFO - 'opt_config_files': (), 03:20:02 INFO - 'pip_index': False, 03:20:02 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:20:02 INFO - 'system_bits': '32', 03:20:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:20:02 INFO - 'title': 'talos-linux64-ix-089', 03:20:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:20:02 INFO - 'use_talos_json': True, 03:20:02 INFO - 'verify': 'False', 03:20:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:20:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:20:02 INFO - 'work_dir': 'build'} 03:20:02 INFO - [mozharness: 2017-09-15 10:20:02.707718Z] Running clobber step. 03:20:02 INFO - Running pre-action listener: _resource_record_pre_action 03:20:02 INFO - Running main action method: clobber 03:20:02 INFO - rmtree: /builds/slave/test/build 03:20:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:20:03 INFO - Running post-action listener: _resource_record_post_action 03:20:03 INFO - [mozharness: 2017-09-15 10:20:03.693449Z] Finished clobber step (success) 03:20:03 INFO - [mozharness: 2017-09-15 10:20:03.693545Z] Running read-buildbot-config step. 03:20:03 INFO - Running pre-action listener: _resource_record_pre_action 03:20:03 INFO - Running main action method: read_buildbot_config 03:20:03 INFO - Using buildbot properties: 03:20:03 INFO - { 03:20:03 INFO - "project": "", 03:20:03 INFO - "product": "firefox", 03:20:03 INFO - "who": "archaeopteryx@coole-files.de", 03:20:03 INFO - "installer_path": "public/build/target.tar.bz2", 03:20:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:20:03 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:20:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 03:20:03 INFO - "stage_platform": "linux64-pgo", 03:20:03 INFO - "basedir": "/builds/slave/test", 03:20:03 INFO - "buildnumber": 18, 03:20:03 INFO - "platform": "ubuntu64_hw", 03:20:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:20:03 INFO - "slavebuilddir": "test", 03:20:03 INFO - "taskId": "ehqDrAW7SC2AyhHkEUG73Q", 03:20:03 INFO - "branch": "mozilla-central", 03:20:03 INFO - "script_repo_revision": "production", 03:20:03 INFO - "revision": "f36106f3f52a9bb2769860d20568c589fc2498d0", 03:20:03 INFO - "slavename": "talos-linux64-ix-089", 03:20:03 INFO - "repo_path": "mozilla-central" 03:20:03 INFO - } 03:20:03 INFO - Finding installer, test and symbols from parent task. 03:20:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ehqDrAW7SC2AyhHkEUG73Q'}, attempt #1 03:20:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ehqDrAW7SC2AyhHkEUG73Q'}, attempt #1 03:20:04 INFO - Task dependencies: GEzbUQjLSKKZw0Ok6RZgng 03:20:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng'}, attempt #1 03:20:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.tar.bz2 03:20:05 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.test_packages.json 03:20:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.crashreporter-symbols.zip 03:20:05 INFO - Running post-action listener: _resource_record_post_action 03:20:05 INFO - [mozharness: 2017-09-15 10:20:05.137202Z] Finished read-buildbot-config step (success) 03:20:05 INFO - [mozharness: 2017-09-15 10:20:05.137462Z] Running download-and-extract step. 03:20:05 INFO - Running pre-action listener: _resource_record_pre_action 03:20:05 INFO - Running main action method: download_and_extract 03:20:05 INFO - mkdir: /builds/slave/test/build/tests 03:20: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')]} 03:20:05 INFO - trying https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.test_packages.json 03:20:05 INFO - Downloading https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:20:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:20:05 INFO - Downloaded 989 bytes. 03:20:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:20:05 INFO - Using the following test package requirements: 03:20:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:20:05 INFO - u'common': [u'target.common.tests.zip'], 03:20:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:20:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:20:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:20:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:20:05 INFO - u'mozbase': [u'target.common.tests.zip'], 03:20:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:20:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:20:05 INFO - u'web-platform': [u'target.common.tests.zip', 03:20:05 INFO - u'target.web-platform.tests.tar.gz'], 03:20:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:20:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:20:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.common.tests.zip 03:20:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:20:05 INFO - Fetch https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.common.tests.zip into memory 03:20:07 INFO - Content-Length response header: 55327223 03:20:07 INFO - Bytes received: 55327223 03:20:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.talos.tests.zip 03:20:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:20:18 INFO - Fetch https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.talos.tests.zip into memory 03:20:19 INFO - Content-Length response header: 14500356 03:20:19 INFO - Bytes received: 14500356 03:20: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')]} 03:20:19 INFO - trying https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.tar.bz2 03:20:19 INFO - Downloading https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:20:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:20:22 INFO - Downloaded 62199272 bytes. 03:20:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.tar.bz2 03:20:22 INFO - mkdir: /builds/slave/test/properties 03:20:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:20:22 INFO - Writing to file /builds/slave/test/properties/build_url 03:20:22 INFO - Contents: 03:20:22 INFO - build_url:https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.tar.bz2 03:20:22 INFO - Running post-action listener: _resource_record_post_action 03:20:22 INFO - Running post-action listener: find_tests_for_verification 03:20:22 INFO - Running post-action listener: set_extra_try_arguments 03:20:22 INFO - [mozharness: 2017-09-15 10:20:22.389058Z] Finished download-and-extract step (success) 03:20:22 INFO - [mozharness: 2017-09-15 10:20:22.389156Z] Running populate-webroot step. 03:20:22 INFO - Running pre-action listener: _resource_record_pre_action 03:20:22 INFO - Running main action method: populate_webroot 03:20:22 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:20:22 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['tresize', 03:20:22 INFO - 'tcanvasmark']}, 03:20:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:20:22 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['dromaeo_css', 03:20:22 INFO - 'kraken']}, 03:20:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:22 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'tests': ['damp', 'tps']}, 03:20:22 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['damp', 'tps']}, 03:20:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:20:22 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['dromaeo_dom']}, 03:20:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:20:22 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['basic_compositor_video', 03:20:22 INFO - 'glvideo']}, 03:20:22 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:20:22 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['ts_paint_webext', 03:20:22 INFO - 'tp5o_webext']}, 03:20:22 INFO - 'other-e10s': {'tests': ['a11yr', 03:20:22 INFO - 'ts_paint', 03:20:22 INFO - 'tpaint', 03:20:22 INFO - 'sessionrestore', 03:20:22 INFO - 'sessionrestore_many_windows', 03:20:22 INFO - 'sessionrestore_no_auto_restore', 03:20:22 INFO - 'tabpaint']}, 03:20:22 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['a11yr', 03:20:22 INFO - 'ts_paint', 03:20:22 INFO - 'tpaint', 03:20:22 INFO - 'sessionrestore', 03:20:22 INFO - 'sessionrestore_many_windows', 03:20:22 INFO - 'sessionrestore_no_auto_restore', 03:20:22 INFO - 'tabpaint']}, 03:20:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:20:22 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:20:22 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['bloom_basic_singleton']}, 03:20:22 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['bloom_basic']}, 03:20:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:20:22 INFO - 'tsvgr_opacity', 03:20:22 INFO - 'tart', 03:20:22 INFO - 'tscrollx', 03:20:22 INFO - 'tsvg_static']}, 03:20:22 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['tsvgx', 03:20:22 INFO - 'tsvgr_opacity', 03:20:22 INFO - 'tart', 03:20:22 INFO - 'tscrollx', 03:20:22 INFO - 'tsvg_static']}, 03:20:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:20:22 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'talos_options': ['--disable-stylo'], 03:20:22 INFO - 'tests': ['tp5o']}, 03:20:22 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:22 INFO - 'talos_options': ['--mitmproxy', 03:20:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:22 INFO - '--firstNonBlankPaint'], 03:20:22 INFO - 'tests': ['tp6_google', 03:20:22 INFO - 'tp6_youtube', 03:20:22 INFO - 'tp6_amazon', 03:20:22 INFO - 'tp6_facebook']}, 03:20:22 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:22 INFO - 'talos_options': ['--disable-stylo', 03:20:22 INFO - '--mitmproxy', 03:20:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:22 INFO - '--firstNonBlankPaint'], 03:20:22 INFO - 'tests': ['tp6_google', 03:20:22 INFO - 'tp6_youtube', 03:20:22 INFO - 'tp6_amazon', 03:20:22 INFO - 'tp6_facebook']}, 03:20:22 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:22 INFO - 'talos_options': ['--stylo-threads=1', 03:20:22 INFO - '--mitmproxy', 03:20:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:22 INFO - '--firstNonBlankPaint'], 03:20:22 INFO - 'tests': ['tp6_google', 03:20:22 INFO - 'tp6_youtube', 03:20:22 INFO - 'tp6_amazon', 03:20:22 INFO - 'tp6_facebook']}, 03:20:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'talos_options': ['--xperf_path', 03:20:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:22 INFO - 'tests': ['tp5n']}, 03:20:22 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:22 INFO - 'talos_options': ['--disable-stylo', 03:20:22 INFO - '--xperf_path', 03:20:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:22 INFO - 'tests': ['tp5n']}}} 03:20:22 INFO - Running post-action listener: _resource_record_post_action 03:20:22 INFO - [mozharness: 2017-09-15 10:20:22.404712Z] Finished populate-webroot step (success) 03:20:22 INFO - [mozharness: 2017-09-15 10:20:22.404801Z] Running create-virtualenv step. 03:20:22 INFO - Running pre-action listener: _resource_record_pre_action 03:20:22 INFO - Running main action method: create_virtualenv 03:20:22 INFO - Creating virtualenv /builds/slave/test/build/venv 03:20:22 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:20:22 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:20:22 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:20:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:20:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:20:23 INFO - Installing distribute.............................................................................................................................................................................................done. 03:20:23 INFO - Installing pip...............done. 03:20:23 INFO - Return code: 0 03:20:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:20:23 INFO - Reading from file tmpfile_stdout 03:20:23 INFO - Output received: 03:20:23 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:20:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:20:23 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')]} 03:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:23 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')]} 03:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:23 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 0x20d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2440090>, '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 0x2440d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243af90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', '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 03:20:23 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 03:20:23 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 03:20:23 INFO - Using env: {'DISPLAY': ':0', 03:20:23 INFO - 'HOME': '/home/cltbld', 03:20:23 INFO - 'LANG': 'en_US.UTF-8', 03:20:23 INFO - 'LANGUAGE': 'en_US:en', 03:20:23 INFO - 'LOGNAME': 'cltbld', 03:20:23 INFO - 'MAIL': '/var/mail/cltbld', 03:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:23 INFO - 'MOZ_NO_REMOTE': '1', 03:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:23 INFO - 'NO_EM_RESTART': '1', 03:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:23 INFO - 'PWD': '/builds/slave/test', 03:20:23 INFO - 'SHELL': '/bin/bash', 03:20:23 INFO - 'SHLVL': '1', 03:20:23 INFO - 'TERM': 'linux', 03:20:23 INFO - 'TMOUT': '86400', 03:20:23 INFO - 'USER': 'cltbld', 03:20:23 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', 03:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:23 INFO - '_': '/tools/buildbot/bin/python'} 03:20:24 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:20:24 INFO - Downloading/unpacking pip>=1.5 03:20:24 INFO - Running setup.py egg_info for package pip 03:20:24 INFO - warning: no files found matching 'pip/cacert.pem' 03:20:24 INFO - warning: no files found matching '*.html' under directory 'docs' 03:20:24 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:20:24 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:20:24 INFO - Installing collected packages: pip 03:20:24 INFO - Found existing installation: pip 1.1 03:20:24 INFO - Uninstalling pip: 03:20:24 INFO - Successfully uninstalled pip 03:20:24 INFO - Running setup.py install for pip 03:20:24 INFO - warning: no files found matching 'pip/cacert.pem' 03:20:24 INFO - warning: no files found matching '*.html' under directory 'docs' 03:20:24 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:20:24 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:20:24 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:20:24 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:20:24 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:20:24 INFO - Successfully installed pip 03:20:24 INFO - Cleaning up... 03:20:24 INFO - Return code: 0 03:20:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:20: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')]} 03:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20: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')]} 03:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20: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', '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 0x20d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2440090>, '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 0x2440d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243af90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', '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 03:20: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:20: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 psutil>=3.1.1 03:20:24 INFO - Using env: {'DISPLAY': ':0', 03:20:24 INFO - 'HOME': '/home/cltbld', 03:20:24 INFO - 'LANG': 'en_US.UTF-8', 03:20:24 INFO - 'LANGUAGE': 'en_US:en', 03:20:24 INFO - 'LOGNAME': 'cltbld', 03:20:24 INFO - 'MAIL': '/var/mail/cltbld', 03:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:24 INFO - 'MOZ_NO_REMOTE': '1', 03:20:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:24 INFO - 'NO_EM_RESTART': '1', 03:20:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:24 INFO - 'PWD': '/builds/slave/test', 03:20:24 INFO - 'SHELL': '/bin/bash', 03:20:24 INFO - 'SHLVL': '1', 03:20:24 INFO - 'TERM': 'linux', 03:20:24 INFO - 'TMOUT': '86400', 03:20:24 INFO - 'USER': 'cltbld', 03:20:24 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', 03:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:24 INFO - '_': '/tools/buildbot/bin/python'} 03:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:24 INFO - Downloading/unpacking psutil>=3.1.1 03:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:20:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:26 INFO - Installing collected packages: psutil 03:20:26 INFO - Running setup.py install for psutil 03:20:26 INFO - building 'psutil._psutil_linux' extension 03:20:26 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 03:20:26 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 03:20:26 INFO - building 'psutil._psutil_posix' extension 03:20:26 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 03:20:26 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 03:20:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:26 INFO - Successfully installed psutil 03:20:26 INFO - Cleaning up... 03:20:26 INFO - Return code: 0 03:20:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:20:26 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')]} 03:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:26 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')]} 03:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:26 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 0x20d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2440090>, '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 0x2440d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243af90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', '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 03:20:26 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 03:20:26 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 03:20:26 INFO - Using env: {'DISPLAY': ':0', 03:20:26 INFO - 'HOME': '/home/cltbld', 03:20:26 INFO - 'LANG': 'en_US.UTF-8', 03:20:26 INFO - 'LANGUAGE': 'en_US:en', 03:20:26 INFO - 'LOGNAME': 'cltbld', 03:20:26 INFO - 'MAIL': '/var/mail/cltbld', 03:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:26 INFO - 'MOZ_NO_REMOTE': '1', 03:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:26 INFO - 'NO_EM_RESTART': '1', 03:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:26 INFO - 'PWD': '/builds/slave/test', 03:20:26 INFO - 'SHELL': '/bin/bash', 03:20:26 INFO - 'SHLVL': '1', 03:20:26 INFO - 'TERM': 'linux', 03:20:26 INFO - 'TMOUT': '86400', 03:20:26 INFO - 'USER': 'cltbld', 03:20:26 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', 03:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:26 INFO - '_': '/tools/buildbot/bin/python'} 03:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:20:26 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 03:20:26 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 03:20:26 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 03:20:26 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 03:20:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:20:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:20:27 INFO - Installing collected packages: mozsystemmonitor 03:20:27 INFO - Running setup.py install for mozsystemmonitor 03:20:28 INFO - Successfully installed mozsystemmonitor 03:20:28 INFO - Cleaning up... 03:20:28 INFO - Return code: 0 03:20:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:28 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 0x20d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2440090>, '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 0x2440d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243af90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', '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 03:20:28 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 03:20:28 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 03:20:28 INFO - Using env: {'DISPLAY': ':0', 03:20:28 INFO - 'HOME': '/home/cltbld', 03:20:28 INFO - 'LANG': 'en_US.UTF-8', 03:20:28 INFO - 'LANGUAGE': 'en_US:en', 03:20:28 INFO - 'LOGNAME': 'cltbld', 03:20:28 INFO - 'MAIL': '/var/mail/cltbld', 03:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:28 INFO - 'MOZ_NO_REMOTE': '1', 03:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:28 INFO - 'NO_EM_RESTART': '1', 03:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:28 INFO - 'PWD': '/builds/slave/test', 03:20:28 INFO - 'SHELL': '/bin/bash', 03:20:28 INFO - 'SHLVL': '1', 03:20:28 INFO - 'TERM': 'linux', 03:20:28 INFO - 'TMOUT': '86400', 03:20:28 INFO - 'USER': 'cltbld', 03:20:28 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', 03:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:28 INFO - '_': '/tools/buildbot/bin/python'} 03:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:28 INFO - Downloading/unpacking jsonschema==2.5.1 03:20:28 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 03:20:28 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 03:20:28 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 03:20:28 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 03:20:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:20:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:29 INFO - Downloading functools32-3.2.3-2.tar.gz 03:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:20:30 INFO - warning: no files found matching '*.txt' 03:20:30 INFO - no previously-included directories found matching 'build' 03:20:30 INFO - no previously-included directories found matching 'dist' 03:20:30 INFO - no previously-included directories found matching '.git*' 03:20:30 INFO - Installing collected packages: jsonschema, functools32 03:20:30 INFO - Running setup.py install for functools32 03:20:30 INFO - warning: no files found matching '*.txt' 03:20:30 INFO - no previously-included directories found matching 'build' 03:20:30 INFO - no previously-included directories found matching 'dist' 03:20:30 INFO - no previously-included directories found matching '.git*' 03:20:30 INFO - Successfully installed jsonschema functools32 03:20:30 INFO - Cleaning up... 03:20:30 INFO - Return code: 0 03:20:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:20:30 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')]} 03:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:30 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')]} 03:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:30 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 0x20d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2440090>, '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 0x2440d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243af90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', '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 03:20:30 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 03:20:30 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 03:20:30 INFO - Using env: {'DISPLAY': ':0', 03:20:30 INFO - 'HOME': '/home/cltbld', 03:20:30 INFO - 'LANG': 'en_US.UTF-8', 03:20:30 INFO - 'LANGUAGE': 'en_US:en', 03:20:30 INFO - 'LOGNAME': 'cltbld', 03:20:30 INFO - 'MAIL': '/var/mail/cltbld', 03:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:30 INFO - 'MOZ_NO_REMOTE': '1', 03:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:30 INFO - 'NO_EM_RESTART': '1', 03:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:30 INFO - 'PWD': '/builds/slave/test', 03:20:30 INFO - 'SHELL': '/bin/bash', 03:20:30 INFO - 'SHLVL': '1', 03:20:30 INFO - 'TERM': 'linux', 03:20:30 INFO - 'TMOUT': '86400', 03:20:30 INFO - 'USER': 'cltbld', 03:20:30 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', 03:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:30 INFO - '_': '/tools/buildbot/bin/python'} 03:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:20:31 INFO - Cleaning up... 03:20:31 INFO - Return code: 0 03:20:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2440090>, '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 0x2440d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243af90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', '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 03:20:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:20:31 INFO - Using env: {'DISPLAY': ':0', 03:20:31 INFO - 'HOME': '/home/cltbld', 03:20:31 INFO - 'LANG': 'en_US.UTF-8', 03:20:31 INFO - 'LANGUAGE': 'en_US:en', 03:20:31 INFO - 'LOGNAME': 'cltbld', 03:20:31 INFO - 'MAIL': '/var/mail/cltbld', 03:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:31 INFO - 'MOZ_NO_REMOTE': '1', 03:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:31 INFO - 'NO_EM_RESTART': '1', 03:20:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:31 INFO - 'PWD': '/builds/slave/test', 03:20:31 INFO - 'SHELL': '/bin/bash', 03:20:31 INFO - 'SHLVL': '1', 03:20:31 INFO - 'TERM': 'linux', 03:20:31 INFO - 'TMOUT': '86400', 03:20:31 INFO - 'USER': 'cltbld', 03:20:31 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', 03:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:31 INFO - '_': '/tools/buildbot/bin/python'} 03:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:31 INFO - Downloading/unpacking blobuploader==1.2.4 03:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:32 INFO - Downloading blobuploader-1.2.4.tar.gz 03:20:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:20:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:20:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:32 INFO - Downloading docopt-0.6.1.tar.gz 03:20:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:20:33 INFO - Installing collected packages: blobuploader, requests, docopt 03:20:33 INFO - Running setup.py install for blobuploader 03:20:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:20:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:20:33 INFO - Running setup.py install for requests 03:20:33 INFO - Running setup.py install for docopt 03:20:33 INFO - Successfully installed blobuploader requests docopt 03:20:33 INFO - Cleaning up... 03:20:33 INFO - Return code: 0 03:20:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:33 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 0x20d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2440090>, '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 0x2440d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243af90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', '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 03:20:33 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 03:20:33 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 03:20:33 INFO - Using env: {'DISPLAY': ':0', 03:20:33 INFO - 'HOME': '/home/cltbld', 03:20:33 INFO - 'LANG': 'en_US.UTF-8', 03:20:33 INFO - 'LANGUAGE': 'en_US:en', 03:20:33 INFO - 'LOGNAME': 'cltbld', 03:20:33 INFO - 'MAIL': '/var/mail/cltbld', 03:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:33 INFO - 'MOZ_NO_REMOTE': '1', 03:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:33 INFO - 'NO_EM_RESTART': '1', 03:20:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:33 INFO - 'PWD': '/builds/slave/test', 03:20:33 INFO - 'SHELL': '/bin/bash', 03:20:33 INFO - 'SHLVL': '1', 03:20:33 INFO - 'TERM': 'linux', 03:20:33 INFO - 'TMOUT': '86400', 03:20:33 INFO - 'USER': 'cltbld', 03:20:33 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', 03:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:33 INFO - '_': '/tools/buildbot/bin/python'} 03:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:33 INFO - Running setup.py (path:/tmp/pip-b7O64H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:33 INFO - Running setup.py (path:/tmp/pip-bbrtT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:33 INFO - Running setup.py (path:/tmp/pip-JhJmxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:34 INFO - Running setup.py (path:/tmp/pip-7eAC9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:34 INFO - Running setup.py (path:/tmp/pip-ilsJ8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:34 INFO - Running setup.py (path:/tmp/pip-UDuyZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:34 INFO - Running setup.py (path:/tmp/pip-LZlvgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:34 INFO - Running setup.py (path:/tmp/pip-w0oG_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:34 INFO - Running setup.py (path:/tmp/pip-oldjbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:34 INFO - Running setup.py (path:/tmp/pip-YhFSDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:34 INFO - Running setup.py (path:/tmp/pip-cuYa0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:34 INFO - Running setup.py (path:/tmp/pip-cLuyOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:34 INFO - Running setup.py (path:/tmp/pip-IKjRgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:34 INFO - Running setup.py (path:/tmp/pip-kmMNKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:34 INFO - Running setup.py (path:/tmp/pip-f8dOzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:34 INFO - Running setup.py (path:/tmp/pip-UPzrnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:34 INFO - Running setup.py (path:/tmp/pip-3kDkpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:20:35 INFO - Running setup.py install for manifestparser 03:20:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:20:35 INFO - Running setup.py install for mozcrash 03:20:35 INFO - Running setup.py install for mozdebug 03:20:35 INFO - Running setup.py install for mozdevice 03:20:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:20:35 INFO - Running setup.py install for mozfile 03:20:35 INFO - Running setup.py install for mozhttpd 03:20:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:20:35 INFO - Running setup.py install for mozinfo 03:20:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:20:35 INFO - Running setup.py install for mozInstall 03:20:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:20:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:20:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:20:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:20:35 INFO - Running setup.py install for mozleak 03:20:35 INFO - Running setup.py install for mozlog 03:20:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:20:36 INFO - Running setup.py install for moznetwork 03:20:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:20:36 INFO - Running setup.py install for mozprocess 03:20:36 INFO - Running setup.py install for mozprofile 03:20:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:20:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:20:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:20:36 INFO - Running setup.py install for mozrunner 03:20:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:20:36 INFO - Running setup.py install for mozscreenshot 03:20:36 INFO - Running setup.py install for moztest 03:20:36 INFO - Running setup.py install for mozversion 03:20:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:20:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:20:36 INFO - Cleaning up... 03:20:36 INFO - Return code: 0 03:20:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:36 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 0x20d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2440090>, '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 0x2440d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243af90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', '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 03:20:36 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 03:20:36 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 03:20:36 INFO - Using env: {'DISPLAY': ':0', 03:20:36 INFO - 'HOME': '/home/cltbld', 03:20:36 INFO - 'LANG': 'en_US.UTF-8', 03:20:36 INFO - 'LANGUAGE': 'en_US:en', 03:20:36 INFO - 'LOGNAME': 'cltbld', 03:20:36 INFO - 'MAIL': '/var/mail/cltbld', 03:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:36 INFO - 'MOZ_NO_REMOTE': '1', 03:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:36 INFO - 'NO_EM_RESTART': '1', 03:20:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:36 INFO - 'PWD': '/builds/slave/test', 03:20:36 INFO - 'SHELL': '/bin/bash', 03:20:36 INFO - 'SHLVL': '1', 03:20:36 INFO - 'TERM': 'linux', 03:20:36 INFO - 'TMOUT': '86400', 03:20:36 INFO - 'USER': 'cltbld', 03:20:36 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', 03:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:36 INFO - '_': '/tools/buildbot/bin/python'} 03:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:37 INFO - Running setup.py (path:/tmp/pip-fg5y5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:37 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)) 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:37 INFO - Running setup.py (path:/tmp/pip-Nwxi4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:37 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)) 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:37 INFO - Running setup.py (path:/tmp/pip-DSsXMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:37 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)) 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:37 INFO - Running setup.py (path:/tmp/pip-tD4agP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:37 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)) 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:37 INFO - Running setup.py (path:/tmp/pip-xjVwB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:37 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)) 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:37 INFO - Running setup.py (path:/tmp/pip-C1dJ9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:37 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)) 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:37 INFO - Running setup.py (path:/tmp/pip-MnueN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:37 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)) 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:37 INFO - Running setup.py (path:/tmp/pip-R_vDEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:37 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)) 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:37 INFO - Running setup.py (path:/tmp/pip-ExFLDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:37 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)) 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:37 INFO - Running setup.py (path:/tmp/pip-thJ6t4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:37 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)) 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:37 INFO - Running setup.py (path:/tmp/pip-nbGeEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:37 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)) 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:37 INFO - Running setup.py (path:/tmp/pip-ALbrxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:37 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)) 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:37 INFO - Running setup.py (path:/tmp/pip-q398kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:37 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)) 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:37 INFO - Running setup.py (path:/tmp/pip-5VkJxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:38 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)) 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:38 INFO - Running setup.py (path:/tmp/pip-sA7PfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:38 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)) 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:38 INFO - Running setup.py (path:/tmp/pip-Rbfysf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:38 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)) 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:38 INFO - Running setup.py (path:/tmp/pip-qLLt_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:38 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)) 03:20:38 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)) 03:20:38 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)) 03:20:38 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)) 03:20:38 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)) 03:20:38 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)) 03:20:38 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)) 03:20:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:39 INFO - Downloading blessings-1.6.tar.gz 03:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:20:39 INFO - Installing collected packages: blessings 03:20:39 INFO - Running setup.py install for blessings 03:20:39 INFO - Successfully installed blessings 03:20:39 INFO - Cleaning up... 03:20:39 INFO - Return code: 0 03:20:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:20:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:39 INFO - Reading from file tmpfile_stdout 03:20:39 INFO - Current package versions: 03:20:39 INFO - argparse == 1.2.1 03:20:39 INFO - blessings == 1.6 03:20:39 INFO - blobuploader == 1.2.4 03:20:39 INFO - docopt == 0.6.1 03:20:39 INFO - functools32 == 3.2.3-2 03:20:39 INFO - jsonschema == 2.5.1 03:20:39 INFO - manifestparser == 1.1 03:20:39 INFO - mozInstall == 1.13 03:20:39 INFO - mozcrash == 1.0 03:20:39 INFO - mozdebug == 0.1 03:20:39 INFO - mozdevice == 0.51 03:20:39 INFO - mozfile == 1.2 03:20:39 INFO - mozhttpd == 0.7 03:20:39 INFO - mozinfo == 0.10 03:20:39 INFO - mozleak == 0.1 03:20:39 INFO - mozlog == 3.5 03:20:39 INFO - moznetwork == 0.27 03:20:39 INFO - mozprocess == 0.25 03:20:39 INFO - mozprofile == 0.28 03:20:39 INFO - mozrunner == 6.13 03:20:39 INFO - mozscreenshot == 0.1 03:20:39 INFO - mozsystemmonitor == 0.3 03:20:39 INFO - moztest == 0.8 03:20:39 INFO - mozversion == 1.4 03:20:39 INFO - psutil == 3.1.1 03:20:39 INFO - requests == 1.2.3 03:20:39 INFO - wsgiref == 0.1.2 03:20:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:39 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')]} 03:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:39 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')]} 03:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:39 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 0x20d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2440090>, '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 0x2440d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243af90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', '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 03:20:39 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 03:20:39 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 03:20:39 INFO - Using env: {'DISPLAY': ':0', 03:20:39 INFO - 'HOME': '/home/cltbld', 03:20:39 INFO - 'LANG': 'en_US.UTF-8', 03:20:39 INFO - 'LANGUAGE': 'en_US:en', 03:20:39 INFO - 'LOGNAME': 'cltbld', 03:20:39 INFO - 'MAIL': '/var/mail/cltbld', 03:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:39 INFO - 'MOZ_NO_REMOTE': '1', 03:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:39 INFO - 'NO_EM_RESTART': '1', 03:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:39 INFO - 'PWD': '/builds/slave/test', 03:20:39 INFO - 'SHELL': '/bin/bash', 03:20:39 INFO - 'SHLVL': '1', 03:20:39 INFO - 'TERM': 'linux', 03:20:39 INFO - 'TMOUT': '86400', 03:20:39 INFO - 'USER': 'cltbld', 03:20:39 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', 03:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:39 INFO - '_': '/tools/buildbot/bin/python'} 03:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:40 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)) 03:20:40 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)) 03:20:40 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)) 03:20:40 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)) 03:20:40 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)) 03:20:40 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)) 03:20:40 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)) 03:20:40 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)) 03:20:40 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)) 03:20:40 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:20:41 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)) 03:20:41 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)) 03:20:41 INFO - Installing collected packages: simplejson 03:20:41 INFO - Running setup.py install for simplejson 03:20:41 INFO - building 'simplejson._speedups' extension 03:20:41 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 03:20:42 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 03:20:42 INFO - Successfully installed simplejson 03:20:42 INFO - Cleaning up... 03:20:42 INFO - Return code: 0 03:20:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:20: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')]} 03:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20: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')]} 03:20:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:42 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 0x20d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2440090>, '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 0x2440d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243af90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', '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 03:20:42 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 03:20:42 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 03:20:42 INFO - Using env: {'DISPLAY': ':0', 03:20:42 INFO - 'HOME': '/home/cltbld', 03:20:42 INFO - 'LANG': 'en_US.UTF-8', 03:20:42 INFO - 'LANGUAGE': 'en_US:en', 03:20:42 INFO - 'LOGNAME': 'cltbld', 03:20:42 INFO - 'MAIL': '/var/mail/cltbld', 03:20:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:42 INFO - 'MOZ_NO_REMOTE': '1', 03:20:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:42 INFO - 'NO_EM_RESTART': '1', 03:20:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:42 INFO - 'PWD': '/builds/slave/test', 03:20:42 INFO - 'SHELL': '/bin/bash', 03:20:42 INFO - 'SHLVL': '1', 03:20:42 INFO - 'TERM': 'linux', 03:20:42 INFO - 'TMOUT': '86400', 03:20:42 INFO - 'USER': 'cltbld', 03:20:42 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', 03:20:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:42 INFO - '_': '/tools/buildbot/bin/python'} 03:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:20:42 INFO - Cleaning up... 03:20:42 INFO - Return code: 0 03:20:42 INFO - Running post-action listener: _resource_record_post_action 03:20:42 INFO - Running post-action listener: _start_resource_monitoring 03:20:42 INFO - Starting resource monitoring. 03:20:42 INFO - [mozharness: 2017-09-15 10:20:42.517910Z] Finished create-virtualenv step (success) 03:20:42 INFO - [mozharness: 2017-09-15 10:20:42.518373Z] Running install step. 03:20:42 INFO - Running pre-action listener: _resource_record_pre_action 03:20:42 INFO - Running main action method: install 03:20:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:42 INFO - Reading from file tmpfile_stdout 03:20:42 INFO - Detecting whether we're running mozinstall >=1.0... 03:20:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:20:42 INFO - Reading from file tmpfile_stdout 03:20:42 INFO - Output received: 03:20:42 INFO - Usage: mozinstall [options] installer 03:20:42 INFO - Options: 03:20:42 INFO - -h, --help show this help message and exit 03:20:42 INFO - -d DEST, --destination=DEST 03:20:42 INFO - Directory to install application into. [default: 03:20:42 INFO - "/builds/slave/test"] 03:20:42 INFO - --app=APP Application being installed. [default: firefox] 03:20:42 INFO - mkdir: /builds/slave/test/build/application 03:20:42 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'] 03:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:21:00 INFO - Reading from file tmpfile_stdout 03:21:00 INFO - Output received: 03:21:00 INFO - /builds/slave/test/build/application/firefox/firefox 03:21:00 INFO - Running post-action listener: _resource_record_post_action 03:21:00 INFO - [mozharness: 2017-09-15 10:21:00.424700Z] Finished install step (success) 03:21:00 INFO - [mozharness: 2017-09-15 10:21:00.424849Z] Running setup-mitmproxy step. 03:21:00 INFO - Running pre-action listener: _resource_record_pre_action 03:21:00 INFO - Running main action method: setup_mitmproxy 03:21:00 INFO - Skipping: mitmproxy is not required 03:21:00 INFO - Running post-action listener: _resource_record_post_action 03:21:00 INFO - [mozharness: 2017-09-15 10:21:00.425659Z] Finished setup-mitmproxy step (success) 03:21:00 INFO - [mozharness: 2017-09-15 10:21:00.425879Z] Running run-tests step. 03:21:00 INFO - Running pre-action listener: _resource_record_pre_action 03:21:00 INFO - Running pre-action listener: _set_gcov_prefix 03:21:00 INFO - Running main action method: run_tests 03:21:00 WARNING - Try message not found. 03:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:21:00 INFO - Python 2.7.3 03:21:00 INFO - Return code: 0 03:21:00 INFO - grabbing minidump binary from tooltool 03:21:00 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')]} 03:21:00 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 0x2440090>, '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 0x2440d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:21:00 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 03:21:00 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 03:21:00 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 03:21:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:21:00 INFO - Return code: 0 03:21:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:21:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:21:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:21:00 INFO - ENV: RUST_BACKTRACE is now full 03:21:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:21:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 03:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --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 03:21:00 INFO - Using env: {'DISPLAY': ':0', 03:21:00 INFO - 'HOME': '/home/cltbld', 03:21:00 INFO - 'LANG': 'en_US.UTF-8', 03:21:00 INFO - 'LANGUAGE': 'en_US:en', 03:21:00 INFO - 'LOGNAME': 'cltbld', 03:21:00 INFO - 'MAIL': '/var/mail/cltbld', 03:21:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:00 INFO - 'MOZ_NO_REMOTE': '1', 03:21:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:00 INFO - 'NO_EM_RESTART': '1', 03:21:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:00 INFO - 'PWD': '/builds/slave/test', 03:21:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:00 INFO - 'RUST_BACKTRACE': 'full', 03:21:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:21:00 INFO - 'SHELL': '/bin/bash', 03:21:00 INFO - 'SHLVL': '1', 03:21:00 INFO - 'TERM': 'linux', 03:21:00 INFO - 'TMOUT': '86400', 03:21:00 INFO - 'USER': 'cltbld', 03:21:00 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', 03:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:00 INFO - '_': '/tools/buildbot/bin/python'} 03:21:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 03:21:00 INFO - mozversion application_buildid: 20170915090318 03:21:00 INFO - mozversion application_changeset: f36106f3f52a9bb2769860d20568c589fc2498d0 03:21:00 INFO - mozversion application_display_name: Nightly 03:21:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:21:00 INFO - mozversion application_name: Firefox 03:21:00 INFO - mozversion application_remotingname: firefox 03:21:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:21:00 INFO - mozversion application_vendor: Mozilla 03:21:00 INFO - mozversion application_version: 57.0a1 03:21:00 INFO - mozversion platform_buildid: 20170915090318 03:21:00 INFO - mozversion platform_changeset: f36106f3f52a9bb2769860d20568c589fc2498d0 03:21:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:21:00 INFO - mozversion platform_version: 57.0a1 03:21:00 INFO - using testdate: 1505470860 03:21:00 INFO - actual date: 1505470860 03:21:00 INFO - starting webserver on 'localhost:51324' 03:21:00 INFO - SUITE-START | Running 2 tests 03:21:00 INFO - TEST-START | dromaeo_css 03:21:00 INFO - Initialising browser for dromaeo_css test... 03:21:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51324/getInfo.html -profile /tmp/tmpiVabhB/profile 03:21:00 INFO - TEST-INFO | started process 403 (/builds/slave/test/build/application/firefox/firefox http://localhost:51324/getInfo.html) 03:21:06 INFO - TEST-INFO | 403: exit 0 03:21:06 INFO - Browser initialized. 03:21:06 INFO - Running cycle 1/1 for dromaeo_css test... 03:21:06 INFO - Using env: {'DISPLAY': ':0', 03:21:06 INFO - 'HOME': '/home/cltbld', 03:21:06 INFO - 'JSGC_DISABLE_POISONING': '1', 03:21:06 INFO - 'LANG': 'en_US.UTF-8', 03:21:06 INFO - 'LANGUAGE': 'en_US:en', 03:21:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:21:06 INFO - 'LOGNAME': 'cltbld', 03:21:06 INFO - 'MAIL': '/var/mail/cltbld', 03:21:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:06 INFO - 'MOZ_CRASHREPORTER': '1', 03:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:21:06 INFO - 'MOZ_NO_REMOTE': '1', 03:21:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:06 INFO - 'NO_EM_RESTART': '1', 03:21:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:06 INFO - 'PWD': '/builds/slave/test', 03:21:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:06 INFO - 'RUST_BACKTRACE': 'full', 03:21:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:21:06 INFO - 'SHELL': '/bin/bash', 03:21:06 INFO - 'SHLVL': '1', 03:21:06 INFO - 'STYLO_FORCE_DISABLED': '1', 03:21:06 INFO - 'TERM': 'linux', 03:21:06 INFO - 'TMOUT': '86400', 03:21:06 INFO - 'USER': 'cltbld', 03:21:06 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', 03:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:06 INFO - '_': '/tools/buildbot/bin/python'} 03:21:06 INFO - TEST-INFO | started process 643 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiVabhB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:07 INFO - PID 643 | 03:21:07 INFO - PID 643 | (/builds/slave/test/build/application/firefox/firefox:693): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:21:07 INFO - PID 643 | 03:21:17 INFO - PID 643 | RSS: Main: 164651008 03:21:17 INFO - PID 643 | 03:24:15 INFO - PID 643 | Cycle 1(1): loaded http://localhost:51324/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51324/tests/dromaeo/cssquery-ext.html) 03:24:16 INFO - PID 643 | RSS: Main: 168730624 03:24:16 INFO - PID 643 | 03:27:18 INFO - PID 643 | Cycle 1(1): loaded http://localhost:51324/tests/dromaeo/cssquery-ext.html (next: http://localhost:51324/tests/dromaeo/cssquery-jquery.html) 03:27:18 INFO - PID 643 | RSS: Main: 164659200 03:27:18 INFO - PID 643 | 03:30:20 INFO - PID 643 | Cycle 1(1): loaded http://localhost:51324/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51324/tests/dromaeo/cssquery-mootools.html) 03:30:21 INFO - PID 643 | RSS: Main: 167661568 03:30:21 INFO - PID 643 | 03:33:22 INFO - PID 643 | Cycle 1(1): loaded http://localhost:51324/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51324/tests/dromaeo/cssquery-prototype.html) 03:33:23 INFO - PID 643 | RSS: Main: 165765120 03:33:23 INFO - PID 643 | 03:36:26 INFO - PID 643 | Cycle 1(1): loaded http://localhost:51324/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51324/tests/dromaeo/cssquery-yui.html) 03:36:26 INFO - PID 643 | RSS: Main: 167526400 03:36:26 INFO - PID 643 | 03:39:28 INFO - PID 643 | Cycle 1(1): loaded http://localhost:51324/tests/dromaeo/cssquery-yui.html (next: http://localhost:51324/tests/dromaeo/cssquery-dojo.html) 03:39:28 INFO - PID 643 | RSS: Main: 170508288 03:39:28 INFO - PID 643 | 03:39:28 INFO - PID 643 | __start_tp_report 03:39:28 INFO - PID 643 | _x_x_mozilla_page_load 03:39:28 INFO - PID 643 | _x_x_mozilla_page_load_details 03:39:28 INFO - PID 643 | |i|pagename|runs| 03:39:28 INFO - PID 643 | |0;dojo.html;3809.885703428898;3831.4444405561194;3838.5393752749674;3855.0940528975684;3861.2277544491076;6080.422359875815;6084.8478788030325;6085.269767627879;6099.207103076599;6164.9691751541295;6113.69431528423;6179.721912513936;6183.196184496021;6191.257049154096;6238.656873871935;5526.281583394153;5565.332160140789;5592.6085174037835;5600.1599760035915;5616.3260408751;5438.157085651711;5537.529310008654;5539.9169012464845;5614.073677843151;5625.46558076982;5484.314460692413;5531.889362212753;5549.056660367747;5573.5819813513945;5583.944160558383;5507.834764957058;5524;5531.695756733378;5577.358603760579;5609.439056094398;5460.153676180198;5472.206530053159;5503.587230957694;5515.09001014832;5517.44825517449;6099.878002439927;6126.326104128542;6140.662263575501;6182.1345011698395;6186.257649082094;6591.406773390418;6601.042848786947;6681.732730690766;6688.3646053624825;6689.163854518185;6606.306337834554;6626.503012274099;6644.634545100018;6718.731250749964;6727.66361681914;6142.662153581551;6177.69111544421;6194.566380353377;6199.535034872402;6205.162303089025;6782.966085169543;6820.35206655367;6836.589804611739;6843.965780171166;6859.7256109756045;6573.5069869759;6603.900941485882;6616.239132499728;6658.600483970978;6661.833454163685;6618.503612229102;6652.234992975773;6652.401283884474;6683.933160668331;6714.194296684332;6573.769918052845;6582.045603387482;6620.437262832713;6622.536422450382;6662.600243985376;6506.739730410731;6561.409473147344;6654.73381064752;6678;6683.365080317362;4865.464798872121;4893.877653058631;4939.481354457802;4947.90104197914;4947.975260123676;4425.645948324126;4429.601335879722;4447;4480.395146655225;4484.753338566345;6129.969350153221;6133.877322453526;6174.043023331391;6188.690565471798;6196.1635179251125;6695.397414232742;6714;6751.797446076625;6752.189737231563;6760.1549806274215;6099.176611157525;6111.35830737775;6119.724612392364;6182.969085154546;6199.411055949678;5328.813491527778;5341.3857406398765;5343.278657381204;5435.483629055233;5436.592255580847;6806.897896531556;6893.276205998298;6900.2409734929115;6901.102856628606;6916;6562.606243625398;6563.146790917151;6586.110875031809;6671.299513551007;6673.299303573055;6712.295209002984;6851.760188393382;6852.486063545154;6897.931020689729;6948.791536253921;6572.112764776885;6579.046038324321;6587.604743715392;6592;6610.8016759497295;6586.209654841449;6589.604623722592;6636.336366363325;6686.364795344434;6700.899486507804;6356.586821856749;6410.743570257137;6474.967625162032;6485.416312531895;6487.253965793994;6406.167198264196;6465.838354041187;6482.546221764431;6484.319146489551;6504.577202481823;6351.777687780906;6356.841078973062;6357.110004599453;6450.741970321134;6455.515836312389;6384.7446102157255;6407.295197528175;6455.838604034937;6462.547621666438;6557.770478033246;6233.532485063729;6260.593061450991;6291.591046581958;6309.4952403806665;6329.49364050884 03:39:28 INFO - PID 643 | |1;ext.html;959.6785076999206;983.6213057972678;984.217547050095;984.556949372782;984.9113579777819;43199.13601727968;43952.78023609878;44319.77840110803;44397.55602443975;44505.77747111268;41329.79335103328;41671.374929376085;41715;41752;41758.37362439566;7287.417006639456;7454.813629659275;7577.734779282726;7603.847923041536;7610.809729756773;7422.814429639248;7560.848783024364;7563.092428908539;7565.35694465971;7569.356604688608;7541.396688264926;8099.757007289791;8290.129536398681;8326.417150799447;8327.583620818965;8225.712100076498;8245.093039765621;8265.338772898183;8286.129956354556;8291.83416331673;8052.718154864551;8123.350131989486;8131.186881311881;8144.714934977306;8154.633041513087;40835.59164408348;41125.58874411278;41173.58826411727;41186.38220426696;41298.79350603228;3754.3054534910857;3780.621937806225;3801.77189368636;3803.866864659751;3810;33652.495212571834;33947.321053579035;33981.83009084963;34032.82983585091;34053.14867128317;5499.945000550023;5510.559155267569;5602.13166959122;5616.269884914935;5641.5204707599905;223727;224934;225869;225982.87008565015;226280;44875;45570;50351.496485035415;50665.24002139971;51320;54526;54622;54715.45284547104;54726.72636636791;54762.45237547653;15128.848711512965;15193.6201594961;15263.542093737206;15279.92360038215;15328.923355383151;12258.81611775824;12286.938565307117;12299.077569182347;12327.69180770488;12345.93827030859;14528.346224419927;14561.92719036398;14580.031695720942;14620;14680.706385872223;5746.67259759798;5786.971065144648;5809.099589563624;5809.82570522885;5817.214676018683;1121.955121795119;1132.932024078558;1133.6089049277987;1142.0806250967885;1142.6115120858947;25660.230193094238;25828.48343033129;25880.352991175372;26077;26136;1230.3971054183564;1233.2230694662485;1243.8942689871462;1244.7572723318865;1251.3305381620971;13668;13690.589282321545;13958.23229722375;14036.789448158286;14139.363728632236;274711;276067;276461;276726;277910;58449.70775146182;58458.415415846146;58548.70725646344;58592.7070364654;58884;1489.4414594527052;1552.9301181446863;1563.2887036398638;1568.5372815019596;1569.4271590869478;25514.617280741175;25558.23325300244;25572.488550229264;25679.10123145681;25803.870980644977;42468.36297455479;42493;42503.7874810624;42541.787291063345;42557.14885702207;225293;226629;226918;227592;227809;36354.636453635125;38482;39085.804570976965;39536.2092758149;39627.60372396355;49868.75065624794;50991;51499.22751158661;51888.74055629698;52159.2176117351;37431;37527.43708844315;37529.81235093807;37655.435168471944;37671;36369.45445818262;37143.814280928425;37273.25453490969;37365;37395.252094958494;41669.79165104155;42945.785271073444;43181.13637727291;43351.34972975471;43550;35181.29637407186;35646.10884727903;35701;35960.5615775366;36001.81999089988;26474.602880956416;26528.734712653397;26600.467990640467;26697;26864.731352686224 03:39:28 INFO - PID 643 | |2;jquery.html;590.7548367427518;603.4629180029772;605.3794860268227;612.9019356902895;621.3506885304857;23032.76967230327;24030.879845600768;24037.879810600924;24045.759542404572;24099.638505422434;19842.503937401572;20707.171713131458;20735.481612959684;20846.89576552119;20932.37202883916;6378.489720822335;6516.250631177404;6523.771667991621;6525.445337146324;6533.640649764261;6412.807615771534;6438.356164383547;6522.282548919615;6691.866162676743;6714.664266786665;6655.567388119781;6660.400563949243;6661.300563440842;6662.20053593567;6664.03371511133;6580.638064906452;6649.202095748493;6671.933280667204;6677.766278180265;6677.93322066778;6245.656488893109;6250.7812226572305;6255.437010669016;6260.15487909131;6269.279032911228;28305.433891322264;29215.561766573304;29292.560611590845;29482.410351792845;29946.10161695131;2281;2303.2974942642486;2326.8254880884;2335.9532809343887;2336;19708.70436943447;20287.28994485186;20320.49198770028;20343;20378.898105509525;2440.9633855492184;2490.9003639854386;2547.1467058535413;2574.5623244048556;2583.3670750666206;130232;137290.3135484326;139633;144732.99999999895;150794;15504.457343993132;15775.447859325099;16032.278547465392;16150.273237704096;16466.42367517155;25434.745652543606;25585.360365990626;25606.231813045637;25617.231483055537;25672.48655026889;9755.317127801127;9926.702198934043;10110.797784044278;10167.593296268215;10277.280590358752;8840.646374145092;8977.32670049749;9054;9086.045965173562;9131.086891310815;9426.387284826464;9552.665656702122;9582.520873956275;9778.95110524457;9789.51052447389;2810.3255218747354;2847.9145625631263;2874.4825931332143;2916.606258155164;2923.9707602924123;1037.1391744851755;1060.04066319979;1061.193492945367;1061.6125114333213;1062.2829590026702;20366.6516809032;20416.489587760425;20495.180192792122;20611.4847128823;21080.894595527232;1101.1356085472864;1101.4878081692052;1110.9444527773578;1115.286216821235;1118.183725880112;11330.150238731963;11360.545578176945;11469.655910322703;11555.480003399867;11590.304581724955;543552;551954;569822;570233;574316;120000;125628;126305.36847315889;127529.36235318764;127943;1197.3004539967906;1197.6646538969103;1228.177121328712;1232.4022848918266;1236.110000799441;18055.368062117763;18139.27442902269;18357.265709371477;18461.07694615291;18597.628047438706;61073.08390374059;61653.38346616476;62452.68773656103;62964;63523.682381587794;77010;77049.2295077042;77163.61418192873;77330.6133469329;80105.5994720046;15011.399544018117;15127.848721513084;15267.3893044277;15369.538913832603;15377.308021139299;23422.297331080095;23474.882625586764;23500.882495588095;23611.763882360956;23677.763222367557;18514.259429622663;18862.43412697621;18931.526711832314;19057.523561911064;19064.142113605198;16873.662526749642;17389.739153912953;17582.648347032733;17605.383811566535;17774.733378999583;19911.60176796485;19987.500312492302;20149.59700806005;20168.697469538263;20216.49458763484;14324.713505730035;15051.849481505484;15125.54623361301;15138.243087845784;15148;19568.412947611596;19719.507012324808;19735.90132049388;19745.70381444308;19770 03:39:28 INFO - PID 643 | |3;mootools.html;1467.4277031957536;1493.671392293695;1504.3606467251416;1514.1672080355802;1536.3854458216713;16658.91670541647;17303.307867685293;17355.999999999985;17413.216405261763;17418.129093545336;16841.578960525992;16871.83128168721;16998.660026799458;17006.82993170068;17068.914655426706;2837.8439185844773;2877.381363006953;2896.666883308415;2906.4187162567464;2915.11089117819;2820.830750154987;2870.2393865625627;2884.8557572121413;2886.5092934201234;2890.927726806826;2786.860656967154;2825.251308403275;2875.324298789783;2875.3530455647415;2876.8993085242023;2861.77105831533;2885.365219651673;2895.391967686799;2896.0732565579024;2898.3913378190605;2683.0609286749677;2724.9046283379985;2729.781617470617;2729.959050614242;2731.6721993360725;16321.673566528721;16701.749473757904;16759.581010474714;16771.413000545046;16783.580410489714;8414.915850841475;8648.43785153963;8707.390482666216;8715.825683486295;8718.34612404066;5890.528757699374;6002.099685047234;6104.481119104881;6263.404976527223;6296.433321001132;2103.3269353806786;2103.9263625773024;2110.2719561751173;2146.098638571804;2160.60028894655;29587.70412295871;29954.55068173979;29996.400071998654;30087.247818804488;30117.69882301171;7174.426045916314;7354.926450735531;7361.963190184015;7376.542907283472;7432.479726419207;19045.523861903563;19094.809051909582;19106.904465477583;19264.32574859873;19308.32420865291;8594.398392112616;8856.64573417069;8857.335699822539;8859.11408859122;8860.64557417709;7490.700371985168;7627.084749830056;7630.656620452093;7689.577073261024;7696.153423123452;5642.125470552071;5896.115582662549;5904.022152578934;5915.112733090071;5930.673812940329;1684.0990070312569;1695.4574536148561;1725.9223334949957;1727.2141175764996;1738.3741852932933;837.844998675247;947.1948843482984;980.1815484070738;982.1553464020936;990.8711867457184;9778.559964801601;9795.608175672893;9879.703608891745;10094.293399462114;10122.392656440637;1035.223582313265;1069.6095924987324;1071.4321409652896;1076.725435014082;1081.324172392255;5608.261438953856;5837.503812175928;5846.444587764156;5951.583389162717;6180.876382472416;24223.51552968966;24232.394190145387;24617.13840015591;25273.368165795633;25521.36196595063;24433.144839930515;24754.628680569807;24980.750192498206;25071.749282507306;25106.24681259565;12528.30263793027;12573.93713031429;12692.619221423187;12724.491020359266;12732.299723515296;9457.668981585612;9489.667861625087;9510.714678559654;9548.61805527799;9580.66467673628;20480.48798779983;20602.69095963592;20748;21202.72783632987;21529.569408612053;21715.565688685823;21783.673244901656;21979.120835166414;22023.348248881077;22165;11989.700257493632;12032.037437005194;12127.818082728943;12134.271943683407;12142.635720928387;15333.310001050202;15435.305411256295;15512.069275843485;15536.766948495555;15569.68860622804;12516.624501264976;12548;12582.496700132258;12636.30500322491;12816.231026138461;12273.324967126893;12462.189957652723;12464.065195110585;12714.682132946751;12838.35808209567;10908.454577271263;10996.065334446661;11045.668629941114;11053.502592383202;11062.22564420483;8069.31410830086;8153.22544358285;8205.097439281555;8212.876806847782;8223.09545949957;8209.302209312274;8277.503349799032;8305.875411868949;8358.456700314704;8435.915640843514 03:39:28 INFO - PID 643 | |4;prototype.html;551.8123837895115;561.096634418586;582.9941700582995;584.6057153688457;587.4947545111206;6175.845603859906;6210.316865144836;6241.126242326078;6249.781257655977;6345.809625711225;6204.658743769102;6226.750929962796;6231.252249730027;6287.434130928215;6316.936830631692;5103.494469131615;5126.103341763553;5137.332146820927;5156.639035267533;5163.896722065557;4822.252550854623;5004.649674522785;5008.3238762767105;5140.640155189139;5148.794048238066;4960.578350840183;4975.427825800025;4989.380575198032;5017.096922553938;5031.245313203012;4948.529889660476;4976.975115124437;4983.9252411213865;4994.425641051271;5012.298278241049;4447.822087116544;4459.687821852472;4461.1040307869025;4509.143262780061;4516.841910533116;6062.757489700407;6125.326214116443;6149.431894866825;6172;6184.07238914162;5825.708714564297;5911.586188966774;5927.347991720907;5933.643981361132;5949.6727679977585;6692.297308782557;6716.798496045127;6720.193576770819;6725.226598941086;6750.493712971547;4856.39295088114;5056.82301119459;5059.772310246011;5090.465501122366;5094.31226784383;6695.397414232693;6777.831633545334;6862.382385585272;6902.99999999995;7001.474889383266;5157.845264641992;5173.948260517347;5193.5585475234275;5208.817691380784;5211.244369566468;5169.65588946869;5264.92102618461;5271.024860400838;5283.339582552181;5298.841034768963;5848.53211743068;5871.6183448075735;5880.147378630075;5910.763569457259;5915.852103697442;6662.167229096363;6668.266490686021;6714.29499902513;6722;6752.932470675329;1811.9094045297682;1819.2359209132196;1820.0808591661125;1822.298415110192;1838.8528917686554;1238.6903274181454;1277.2591896699892;1299.389287035092;1304.8303720516271;1311.4950743963643;6175.44421002112;6186.536009799193;6223.284322302993;6253.218347706536;6281.120643109968;6033.879322413527;6734.215432910282;6789.898151527731;6796.9804529321;6837.179538455417;6127.387261273926;6156;6189.226346706661;6227.408396202353;6264.780732674334;3561.4479755637917;3566.8394922228044;3623.8188090595363;3634.4019420773243;3636.61815509373;6982.33667801558;7051.576905385693;7052.788416347517;7076.12482692087;7113.288671132846;6751.594904305757;6764.594124352555;6773.356531129535;6822.3859852613505;6899.65366797103;6789.524733268624;6840.589564626139;6848.657567121723;6867.2102708188195;7032.789016329519;6669.933300666931;6673.499487538551;6750.189977202767;6798.286179951232;6846.281140480178;6648.601083934979;6677.198736151693;6715.697793599202;6791.505868708876;6797.456203503609;6919.464428457113;6940.757073502403;6946.79159625212;6963.79108626742;6975.372216500539;5167.22491626244;5169.147090729987;5179.8446046618665;5190.40310364313;5202.531772140525;6473.838154046187;6692.364225398774;6848.178218613599;6860.588364698134;6899.103116594811;6490;6513.772017979538;6516.478681705547;6598.967005165136;6621.470282377302;6354.17395738551;6434.324395938359;6461.224653041665;6490.772822951174;6518.217813862367;6451.935480645134;6504.284528701934;6510.869782604226;6547.639879806657;6550.737970481127;6615.5038372123245;6633.734650614115;6662.733490660513;6666.699998500176;6676.632785196861;6402.935970640234;6432.614043157426;6451.645159516272;6514.57655252407;6530.608163510205 03:39:28 INFO - PID 643 | |5;yui.html;967.3615413826867;1000.2348203624226;1004.6433516101783;1005.1054561440315;1018.6638409324921;18138.455846324614;18585.72121418178;18616.534586635342;18646.81353186468;18781.154848031838;18765.155567999438;19002.80997190028;19319.903400483014;19978.600427991467;20201.49496262594;1024.2778840917135;1053.7207639975413;1053.9156867450586;1054.2409465185056;1054.4253381906879;1013.1793247469536;1051.143318195672;1063.8457423673563;1065.2277099103128;1067;1127.5489804078393;1128.06370712309;1131.3381671722052;1133.3879704959313;1134.568863831747;1076.8007918535095;1116.2576886370555;1119.36755733011;1120.5741818109148;1122.8035093858582;808.9919100808976;809.6154326694832;813.5891374855719;814.4136221920209;815.2133191470259;21334.893325533427;21687.67468487974;21747.13011479539;21776.128954841788;21809.454763630878;22159.889200554055;23831.52336953251;23868.40328991772;23885.402864928343;23962.28113156608;17073.317067317417;17719.645607087914;17909.10454477271;17911.014894180815;17931.73102403465;3943.250782351373;3948.526176858795;3962.702797290186;3973.662238709713;3976.5228172619472;160897;161336;163972.18013909855;165291;167056.16471917683;17905.462836114937;18112;18193.181306841223;18524.536886577942;18628.441146765617;34729;35170.47244291286;35211.29577408489;35215;35603.287934241685;8425.70510032146;8485.830283394422;8503.404761666625;8513.787155321043;8516.74449766508;4210.6841986851105;4263.509696384894;4272.423222864935;4328.653707703376;4391.165678521071;5968.910466343008;6072;6104.17593624855;6122.571420000557;6141.7543298267565;1100.1638754546602;1108.684025052856;1131.8302254661867;1133.6145710458484;1133.9886601134049;678.4402867634221;703.1737708192956;711.7615100508871;716.5700579652167;720.0243669827413;11968.341741204144;12045.63863084109;12358.876411235953;12982.480700772052;13457.663558411117;680.3502654964497;692.3491917597443;696.8048946295046;697.1007400453358;708.5429897715944;5619.241402410704;5629.915551266734;5696.629719068247;5768.855778605484;5768.942310576925;147242.26378868037;147286;147431;148706;152935;130212;131616.3419182917;132174.33912830375;133051;136885;115229.4238528802;115569.99999999831;115762.42118789352;116180;117521;10758.354498730101;10860.294080884718;10861.891381086403;10890.292131011776;11032;54101.18848217201;55473.72263138658;55489;55598;55924;69215.30784692088;69515;69578.30421695719;69746;70162.29837701762;16064.43774467888;16326.346946122023;16488.587785304982;16526.66946661036;16763.49709508717;18240.270389184283;18294.817051829312;18332.633347333245;18471.815281847008;18492.445226642685;15861.762073568674;15917.204139792733;15935.36258549645;15994.840051599334;16059.437919672755;16078.839211608201;16225;16306;16311.26599303058;16416;15061.472848450252;15159.166245856584;15182.46861359847;15194;15196.468123615621;11270;11397.772044559228;11490.138239631893;11666.183367164216;11771.941140294586;11340.262882912584;11377.658670239905;11472.655820325404;11581.768364632828;11583.478743456733 03:39:28 INFO - PID 643 | __end_tp_report 03:39:28 INFO - PID 643 | __start_cc_report 03:39:28 INFO - PID 643 | _x_x_mozilla_cycle_collect,353 03:39:28 INFO - PID 643 | __end_cc_report 03:39:28 INFO - PID 643 | __startTimestamp1505471968431__endTimestamp 03:39:28 INFO - PID 643 | 03:39:28 INFO - PID 643 | ------- Summary: start ------- 03:39:28 INFO - PID 643 | Number of tests: 6 03:39:28 INFO - PID 643 | 03:39:28 INFO - PID 643 | [#0] dojo.html Cycles:165 Average:6128.65 Median:6356.84 stddev:709.04 (11.2%) stddev-sans-first:687.49 03:39:28 INFO - PID 643 | Values: 3809.9 3831.4 3838.5 3855.1 3861.2 6080.4 6084.8 6085.3 6099.2 6165.0 6113.7 6179.7 6183.2 6191.3 6238.7 5526.3 5565.3 5592.6 5600.2 5616.3 5438.2 5537.5 5539.9 5614.1 5625.5 5484.3 5531.9 5549.1 5573.6 5583.9 5507.8 5524.0 5531.7 5577.4 5609.4 5460.2 5472.2 5503.6 5515.1 5517.4 6099.9 6126.3 6140.7 6182.1 6186.3 6591.4 6601.0 6681.7 6688.4 6689.2 6606.3 6626.5 6644.6 6718.7 6727.7 6142.7 6177.7 6194.6 6199.5 6205.2 6783.0 6820.4 6836.6 6844.0 6859.7 6573.5 6603.9 6616.2 6658.6 6661.8 6618.5 6652.2 6652.4 6683.9 6714.2 6573.8 6582.0 6620.4 6622.5 6662.6 6506.7 6561.4 6654.7 6678.0 6683.4 4865.5 4893.9 4939.5 4947.9 4948.0 4425.6 4429.6 4447.0 4480.4 4484.8 6130.0 6133.9 6174.0 6188.7 6196.2 6695.4 6714.0 6751.8 6752.2 6760.2 6099.2 6111.4 6119.7 6183.0 6199.4 5328.8 5341.4 5343.3 5435.5 5436.6 6806.9 6893.3 6900.2 6901.1 6916.0 6562.6 6563.1 6586.1 6671.3 6673.3 6712.3 6851.8 6852.5 6897.9 6948.8 6572.1 6579.0 6587.6 6592.0 6610.8 6586.2 6589.6 6636.3 6686.4 6700.9 6356.6 6410.7 6475.0 6485.4 6487.3 6406.2 6465.8 6482.5 6484.3 6504.6 6351.8 6356.8 6357.1 6450.7 6455.5 6384.7 6407.3 6455.8 6462.5 6557.8 6233.5 6260.6 6291.6 6309.5 6329.5 03:39:28 INFO - PID 643 | 03:39:28 INFO - PID 643 | [#1] ext.html Cycles:180 Average:42519.76 Median:21146.00 stddev:63403.69 (299.8%) stddev-sans-first:63504.76 03:39:28 INFO - PID 643 | Values: 959.7 983.6 984.2 984.6 984.9 43199.1 43952.8 44319.8 44397.6 44505.8 41329.8 41671.4 41715.0 41752.0 41758.4 7287.4 7454.8 7577.7 7603.8 7610.8 7422.8 7560.8 7563.1 7565.4 7569.4 7541.4 8099.8 8290.1 8326.4 8327.6 8225.7 8245.1 8265.3 8286.1 8291.8 8052.7 8123.4 8131.2 8144.7 8154.6 40835.6 41125.6 41173.6 41186.4 41298.8 3754.3 3780.6 3801.8 3803.9 3810.0 33652.5 33947.3 33981.8 34032.8 34053.1 5499.9 5510.6 5602.1 5616.3 5641.5 223727.0 224934.0 225869.0 225982.9 226280.0 44875.0 45570.0 50351.5 50665.2 51320.0 54526.0 54622.0 54715.5 54726.7 54762.5 15128.8 15193.6 15263.5 15279.9 15328.9 12258.8 12286.9 12299.1 12327.7 12345.9 14528.3 14561.9 14580.0 14620.0 14680.7 5746.7 5787.0 5809.1 5809.8 5817.2 1122.0 1132.9 1133.6 1142.1 1142.6 25660.2 25828.5 25880.4 26077.0 26136.0 1230.4 1233.2 1243.9 1244.8 1251.3 13668.0 13690.6 13958.2 14036.8 14139.4 274711.0 276067.0 276461.0 276726.0 277910.0 58449.7 58458.4 58548.7 58592.7 58884.0 1489.4 1552.9 1563.3 1568.5 1569.4 25514.6 25558.2 25572.5 25679.1 25803.9 42468.4 42493.0 42503.8 42541.8 42557.1 225293.0 226629.0 226918.0 227592.0 227809.0 36354.6 38482.0 39085.8 39536.2 39627.6 49868.8 50991.0 51499.2 51888.7 52159.2 37431.0 37527.4 37529.8 37655.4 37671.0 36369.5 37143.8 37273.3 37365.0 37395.3 41669.8 42945.8 43181.1 43351.3 43550.0 35181.3 35646.1 35701.0 35960.6 36001.8 26474.6 26528.7 26600.5 26697.0 26864.7 03:39:28 INFO - PID 643 | 03:39:28 INFO - PID 643 | [#2] jquery.html Cycles:180 Average:37688.77 Median:12679.80 stddev:94150.37 (742.5%) stddev-sans-first:94373.28 03:39:28 INFO - PID 643 | Values: 590.8 603.5 605.4 612.9 621.4 23032.8 24030.9 24037.9 24045.8 24099.6 19842.5 20707.2 20735.5 20846.9 20932.4 6378.5 6516.3 6523.8 6525.4 6533.6 6412.8 6438.4 6522.3 6691.9 6714.7 6655.6 6660.4 6661.3 6662.2 6664.0 6580.6 6649.2 6671.9 6677.8 6677.9 6245.7 6250.8 6255.4 6260.2 6269.3 28305.4 29215.6 29292.6 29482.4 29946.1 2281.0 2303.3 2326.8 2336.0 2336.0 19708.7 20287.3 20320.5 20343.0 20378.9 2441.0 2490.9 2547.1 2574.6 2583.4 130232.0 137290.3 139633.0 144733.0 150794.0 15504.5 15775.4 16032.3 16150.3 16466.4 25434.7 25585.4 25606.2 25617.2 25672.5 9755.3 9926.7 10110.8 10167.6 10277.3 8840.6 8977.3 9054.0 9086.0 9131.1 9426.4 9552.7 9582.5 9779.0 9789.5 2810.3 2847.9 2874.5 2916.6 2924.0 1037.1 1060.0 1061.2 1061.6 1062.3 20366.7 20416.5 20495.2 20611.5 21080.9 1101.1 1101.5 1110.9 1115.3 1118.2 11330.2 11360.5 11469.7 11555.5 11590.3 543552.0 551954.0 569822.0 570233.0 574316.0 120000.0 125628.0 126305.4 127529.4 127943.0 1197.3 1197.7 1228.2 1232.4 1236.1 18055.4 18139.3 18357.3 18461.1 18597.6 61073.1 61653.4 62452.7 62964.0 63523.7 77010.0 77049.2 77163.6 77330.6 80105.6 15011.4 15127.8 15267.4 15369.5 15377.3 23422.3 23474.9 23500.9 23611.8 23677.8 18514.3 18862.4 18931.5 19057.5 19064.1 16873.7 17389.7 17582.6 17605.4 17774.7 19911.6 19987.5 20149.6 20168.7 20216.5 14324.7 15051.8 15125.5 15138.2 15148.0 19568.4 19719.5 19735.9 19745.7 19770.0 03:39:28 INFO - PID 643 | 03:39:28 INFO - PID 643 | [#3] mootools.html Cycles:180 Average:10462.00 Median:25397.37 stddev:7602.74 (29.9%) stddev-sans-first:7594.04 03:39:28 INFO - PID 643 | Values: 1467.4 1493.7 1504.4 1514.2 1536.4 16658.9 17303.3 17356.0 17413.2 17418.1 16841.6 16871.8 16998.7 17006.8 17068.9 2837.8 2877.4 2896.7 2906.4 2915.1 2820.8 2870.2 2884.9 2886.5 2890.9 2786.9 2825.3 2875.3 2875.4 2876.9 2861.8 2885.4 2895.4 2896.1 2898.4 2683.1 2724.9 2729.8 2730.0 2731.7 16321.7 16701.7 16759.6 16771.4 16783.6 8414.9 8648.4 8707.4 8715.8 8718.3 5890.5 6002.1 6104.5 6263.4 6296.4 2103.3 2103.9 2110.3 2146.1 2160.6 29587.7 29954.6 29996.4 30087.2 30117.7 7174.4 7354.9 7362.0 7376.5 7432.5 19045.5 19094.8 19106.9 19264.3 19308.3 8594.4 8856.6 8857.3 8859.1 8860.6 7490.7 7627.1 7630.7 7689.6 7696.2 5642.1 5896.1 5904.0 5915.1 5930.7 1684.1 1695.5 1725.9 1727.2 1738.4 837.8 947.2 980.2 982.2 990.9 9778.6 9795.6 9879.7 10094.3 10122.4 1035.2 1069.6 1071.4 1076.7 1081.3 5608.3 5837.5 5846.4 5951.6 6180.9 24223.5 24232.4 24617.1 25273.4 25521.4 24433.1 24754.6 24980.8 25071.7 25106.2 12528.3 12573.9 12692.6 12724.5 12732.3 9457.7 9489.7 9510.7 9548.6 9580.7 20480.5 20602.7 20748.0 21202.7 21529.6 21715.6 21783.7 21979.1 22023.3 22165.0 11989.7 12032.0 12127.8 12134.3 12142.6 15333.3 15435.3 15512.1 15536.8 15569.7 12516.6 12548.0 12582.5 12636.3 12816.2 12273.3 12462.2 12464.1 12714.7 12838.4 10908.5 10996.1 11045.7 11053.5 11062.2 8069.3 8153.2 8205.1 8212.9 8223.1 8209.3 8277.5 8305.9 8358.5 8435.9 03:39:28 INFO - PID 643 | 03:39:28 INFO - PID 643 | [#4] prototype.html Cycles:180 Average:5635.22 Median:6227.08 stddev:1568.01 (25.2%) stddev-sans-first:1525.28 03:39:28 INFO - PID 643 | Values: 551.8 561.1 583.0 584.6 587.5 6175.8 6210.3 6241.1 6249.8 6345.8 6204.7 6226.8 6231.3 6287.4 6316.9 5103.5 5126.1 5137.3 5156.6 5163.9 4822.3 5004.6 5008.3 5140.6 5148.8 4960.6 4975.4 4989.4 5017.1 5031.2 4948.5 4977.0 4983.9 4994.4 5012.3 4447.8 4459.7 4461.1 4509.1 4516.8 6062.8 6125.3 6149.4 6172.0 6184.1 5825.7 5911.6 5927.3 5933.6 5949.7 6692.3 6716.8 6720.2 6725.2 6750.5 4856.4 5056.8 5059.8 5090.5 5094.3 6695.4 6777.8 6862.4 6903.0 7001.5 5157.8 5173.9 5193.6 5208.8 5211.2 5169.7 5264.9 5271.0 5283.3 5298.8 5848.5 5871.6 5880.1 5910.8 5915.9 6662.2 6668.3 6714.3 6722.0 6752.9 1811.9 1819.2 1820.1 1822.3 1838.9 1238.7 1277.3 1299.4 1304.8 1311.5 6175.4 6186.5 6223.3 6253.2 6281.1 6033.9 6734.2 6789.9 6797.0 6837.2 6127.4 6156.0 6189.2 6227.4 6264.8 3561.4 3566.8 3623.8 3634.4 3636.6 6982.3 7051.6 7052.8 7076.1 7113.3 6751.6 6764.6 6773.4 6822.4 6899.7 6789.5 6840.6 6848.7 6867.2 7032.8 6669.9 6673.5 6750.2 6798.3 6846.3 6648.6 6677.2 6715.7 6791.5 6797.5 6919.5 6940.8 6946.8 6963.8 6975.4 5167.2 5169.1 5179.8 5190.4 5202.5 6473.8 6692.4 6848.2 6860.6 6899.1 6490.0 6513.8 6516.5 6599.0 6621.5 6354.2 6434.3 6461.2 6490.8 6518.2 6451.9 6504.3 6510.9 6547.6 6550.7 6615.5 6633.7 6662.7 6666.7 6676.6 6402.9 6432.6 6451.6 6514.6 6530.6 03:39:28 INFO - PID 643 | 03:39:28 INFO - PID 643 | [#5] yui.html Cycles:180 Average:27956.42 Median:17812.55 stddev:42781.97 (240.2%) stddev-sans-first:42853.99 03:39:28 INFO - PID 643 | Values: 967.4 1000.2 1004.6 1005.1 1018.7 18138.5 18585.7 18616.5 18646.8 18781.2 18765.2 19002.8 19319.9 19978.6 20201.5 1024.3 1053.7 1053.9 1054.2 1054.4 1013.2 1051.1 1063.8 1065.2 1067.0 1127.5 1128.1 1131.3 1133.4 1134.6 1076.8 1116.3 1119.4 1120.6 1122.8 809.0 809.6 813.6 814.4 815.2 21334.9 21687.7 21747.1 21776.1 21809.5 22159.9 23831.5 23868.4 23885.4 23962.3 17073.3 17719.6 17909.1 17911.0 17931.7 3943.3 3948.5 3962.7 3973.7 3976.5 160897.0 161336.0 163972.2 165291.0 167056.2 17905.5 18112.0 18193.2 18524.5 18628.4 34729.0 35170.5 35211.3 35215.0 35603.3 8425.7 8485.8 8503.4 8513.8 8516.7 4210.7 4263.5 4272.4 4328.7 4391.2 5968.9 6072.0 6104.2 6122.6 6141.8 1100.2 1108.7 1131.8 1133.6 1134.0 678.4 703.2 711.8 716.6 720.0 11968.3 12045.6 12358.9 12982.5 13457.7 680.4 692.3 696.8 697.1 708.5 5619.2 5629.9 5696.6 5768.9 5768.9 147242.3 147286.0 147431.0 148706.0 152935.0 130212.0 131616.3 132174.3 133051.0 136885.0 115229.4 115570.0 115762.4 116180.0 117521.0 10758.4 10860.3 10861.9 10890.3 11032.0 54101.2 55473.7 55489.0 55598.0 55924.0 69215.3 69515.0 69578.3 69746.0 70162.3 16064.4 16326.3 16488.6 16526.7 16763.5 18240.3 18294.8 18332.6 18471.8 18492.4 15861.8 15917.2 15935.4 15994.8 16059.4 16078.8 16225.0 16306.0 16311.3 16416.0 15061.5 15159.2 15182.5 15194.0 15196.5 11270.0 11397.8 11490.1 11666.2 11771.9 11340.3 11377.7 11472.7 11581.8 11583.5 03:39:28 INFO - PID 643 | -------- Summary: end -------- 03:39:28 INFO - PID 643 | 03:39:29 INFO - TEST-INFO | 643: exit 0 03:39:29 INFO - TEST-OK | dromaeo_css | took 1108320ms 03:39:29 INFO - TEST-START | kraken 03:39:29 INFO - Initialising browser for kraken test... 03:39:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51324/getInfo.html -profile /tmp/tmpV1_ZbS/profile 03:39:29 INFO - TEST-INFO | started process 1020 (/builds/slave/test/build/application/firefox/firefox http://localhost:51324/getInfo.html) 03:39:34 INFO - TEST-INFO | 1020: exit 0 03:39:34 INFO - Browser initialized. 03:39:34 INFO - Running cycle 1/1 for kraken test... 03:39:34 INFO - Using env: {'DISPLAY': ':0', 03:39:34 INFO - 'HOME': '/home/cltbld', 03:39:34 INFO - 'JSGC_DISABLE_POISONING': '1', 03:39:34 INFO - 'LANG': 'en_US.UTF-8', 03:39:34 INFO - 'LANGUAGE': 'en_US:en', 03:39:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:39:34 INFO - 'LOGNAME': 'cltbld', 03:39:34 INFO - 'MAIL': '/var/mail/cltbld', 03:39:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:39:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:39:34 INFO - 'MOZ_CRASHREPORTER': '1', 03:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:39:34 INFO - 'MOZ_NO_REMOTE': '1', 03:39:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:34 INFO - 'NO_EM_RESTART': '1', 03:39:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:34 INFO - 'PWD': '/builds/slave/test', 03:39:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:39:34 INFO - 'RUST_BACKTRACE': 'full', 03:39:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:39:34 INFO - 'SHELL': '/bin/bash', 03:39:34 INFO - 'SHLVL': '1', 03:39:34 INFO - 'STYLO_FORCE_DISABLED': '1', 03:39:34 INFO - 'TERM': 'linux', 03:39:34 INFO - 'TMOUT': '86400', 03:39:34 INFO - 'USER': 'cltbld', 03:39:34 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966', 03:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:34 INFO - '_': '/tools/buildbot/bin/python'} 03:39:34 INFO - TEST-INFO | started process 1340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV1_ZbS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:35 INFO - PID 1340 | 03:39:35 INFO - PID 1340 | (/builds/slave/test/build/application/firefox/firefox:1389): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:39:35 INFO - PID 1340 | 03:39:45 INFO - PID 1340 | RSS: Main: 164614144 03:39:45 INFO - PID 1340 | 03:39:48 INFO - PID 1340 | Cycle 1(1): loaded http://localhost:51324/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51324/tests/kraken/driver.html?testName=audio-beat-detection) 03:39:49 INFO - PID 1340 | RSS: Main: 169390080 03:39:49 INFO - PID 1340 | 03:39:51 INFO - PID 1340 | Cycle 1(1): loaded http://localhost:51324/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51324/tests/kraken/driver.html?testName=audio-dft) 03:39:52 INFO - PID 1340 | RSS: Main: 169897984 03:39:52 INFO - PID 1340 | 03:39:55 INFO - PID 1340 | Cycle 1(1): loaded http://localhost:51324/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51324/tests/kraken/driver.html?testName=audio-fft) 03:39:56 INFO - PID 1340 | RSS: Main: 165634048 03:39:56 INFO - PID 1340 | 03:39:58 INFO - PID 1340 | Cycle 1(1): loaded http://localhost:51324/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51324/tests/kraken/driver.html?testName=audio-oscillator) 03:39:58 INFO - PID 1340 | RSS: Main: 166936576 03:39:58 INFO - PID 1340 | 03:40:00 INFO - PID 1340 | Cycle 1(1): loaded http://localhost:51324/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51324/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:40:01 INFO - PID 1340 | RSS: Main: 167104512 03:40:01 INFO - PID 1340 | 03:40:04 INFO - PID 1340 | Cycle 1(1): loaded http://localhost:51324/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51324/tests/kraken/driver.html?testName=imaging-darkroom) 03:40:05 INFO - PID 1340 | RSS: Main: 168632320 03:40:05 INFO - PID 1340 | 03:40:08 INFO - PID 1340 | Cycle 1(1): loaded http://localhost:51324/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51324/tests/kraken/driver.html?testName=imaging-desaturate) 03:40:09 INFO - PID 1340 | RSS: Main: 169668608 03:40:09 INFO - PID 1340 | 03:40:12 INFO - PID 1340 | Cycle 1(1): loaded http://localhost:51324/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51324/tests/kraken/driver.html?testName=json-parse-financial) 03:40:12 INFO - PID 1340 | RSS: Main: 169934848 03:40:12 INFO - PID 1340 | 03:40:14 INFO - PID 1340 | Cycle 1(1): loaded http://localhost:51324/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51324/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:40:14 INFO - PID 1340 | RSS: Main: 169721856 03:40:14 INFO - PID 1340 | 03:40:16 INFO - PID 1340 | Cycle 1(1): loaded http://localhost:51324/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51324/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:40:17 INFO - PID 1340 | RSS: Main: 169562112 03:40:17 INFO - PID 1340 | 03:40:19 INFO - PID 1340 | Cycle 1(1): loaded http://localhost:51324/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51324/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:40:19 INFO - PID 1340 | RSS: Main: 166768640 03:40:19 INFO - PID 1340 | 03:40:22 INFO - PID 1340 | Cycle 1(1): loaded http://localhost:51324/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:40:22 INFO - PID 1340 | RSS: Main: 166760448 03:40:22 INFO - PID 1340 | 03:40:25 INFO - PID 1340 | Cycle 1(1): loaded http://localhost:51324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:40:26 INFO - PID 1340 | RSS: Main: 167084032 03:40:26 INFO - PID 1340 | 03:40:27 INFO - PID 1340 | Cycle 1(1): loaded http://localhost:51324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51324/tests/kraken/driver.html?testName=ai-astar) 03:40:28 INFO - PID 1340 | RSS: Main: 169017344 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | __start_tp_report 03:40:28 INFO - PID 1340 | _x_x_mozilla_page_load 03:40:28 INFO - PID 1340 | _x_x_mozilla_page_load_details 03:40:28 INFO - PID 1340 | |i|pagename|runs| 03:40:28 INFO - PID 1340 | |0;ai-astar;104;105;106;104;105;107;105;106;106;105 03:40:28 INFO - PID 1340 | |1;audio-beat-detection;113;113;112;114;112;114;113;113;112;112 03:40:28 INFO - PID 1340 | |2;audio-dft;162;162;163;161;161;162;162;162;164;164 03:40:28 INFO - PID 1340 | |3;audio-fft;72;72;72;73;72;72;73;75;72;74 03:40:28 INFO - PID 1340 | |4;audio-oscillator;77;78;78;78;78;77;77;77;78;78 03:40:28 INFO - PID 1340 | |5;imaging-gaussian-blur;113;114;114;114;113;114;114;110;114;111 03:40:28 INFO - PID 1340 | |6;imaging-darkroom;149;150;148;150;150;149;148;150;149;150 03:40:28 INFO - PID 1340 | |7;imaging-desaturate;94;94;94;94;93;94;93;94;96;94 03:40:28 INFO - PID 1340 | |8;json-parse-financial;45;44;45;44;55;46;47;43;46;48 03:40:28 INFO - PID 1340 | |9;json-stringify-tinderbox;38;38;38;38;40;38;38;38;39;38 03:40:28 INFO - PID 1340 | |10;stanford-crypto-aes;71;72;72;74;69;73;72;71;75;73 03:40:28 INFO - PID 1340 | |11;stanford-crypto-ccm;107;105;108;104;105;105;108;111;111;101 03:40:28 INFO - PID 1340 | |12;stanford-crypto-pbkdf2;160;175;157;163;148;157;150;151;162;157 03:40:28 INFO - PID 1340 | |13;stanford-crypto-sha256-iterative;59;58;62;59;62;60;67;64;61;59 03:40:28 INFO - PID 1340 | __end_tp_report 03:40:28 INFO - PID 1340 | __start_cc_report 03:40:28 INFO - PID 1340 | _x_x_mozilla_cycle_collect,878 03:40:28 INFO - PID 1340 | __end_cc_report 03:40:28 INFO - PID 1340 | __startTimestamp1505472028198__endTimestamp 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | ------- Summary: start ------- 03:40:28 INFO - PID 1340 | Number of tests: 14 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | [#0] ai-astar Cycles:10 Average:105.30 Median:105.50 stddev:0.95 (0.9%) stddev-sans-first:0.88 03:40:28 INFO - PID 1340 | Values: 104.0 105.0 106.0 104.0 105.0 107.0 105.0 106.0 106.0 105.0 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | [#1] audio-beat-detection Cycles:10 Average:112.80 Median:113.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 03:40:28 INFO - PID 1340 | Values: 113.0 113.0 112.0 114.0 112.0 114.0 113.0 113.0 112.0 112.0 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 03:40:28 INFO - PID 1340 | Values: 162.0 162.0 163.0 161.0 161.0 162.0 162.0 162.0 164.0 164.0 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | [#3] audio-fft Cycles:10 Average:72.70 Median:72.50 stddev:1.06 (1.5%) stddev-sans-first:1.09 03:40:28 INFO - PID 1340 | Values: 72.0 72.0 72.0 73.0 72.0 72.0 73.0 75.0 72.0 74.0 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:78.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 03:40:28 INFO - PID 1340 | Values: 77.0 78.0 78.0 78.0 78.0 77.0 77.0 77.0 78.0 78.0 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:114.00 stddev:1.45 (1.3%) stddev-sans-first:1.54 03:40:28 INFO - PID 1340 | Values: 113.0 114.0 114.0 114.0 113.0 114.0 114.0 110.0 114.0 111.0 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:150.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 03:40:28 INFO - PID 1340 | Values: 149.0 150.0 148.0 150.0 150.0 149.0 148.0 150.0 149.0 150.0 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 03:40:28 INFO - PID 1340 | Values: 94.0 94.0 94.0 94.0 93.0 94.0 93.0 94.0 96.0 94.0 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | [#8] json-parse-financial Cycles:10 Average:46.30 Median:46.00 stddev:3.40 (7.4%) stddev-sans-first:3.57 03:40:28 INFO - PID 1340 | Values: 45.0 44.0 45.0 44.0 55.0 46.0 47.0 43.0 46.0 48.0 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | [#9] json-stringify-tinderbox Cycles:10 Average:38.30 Median:38.00 stddev:0.67 (1.8%) stddev-sans-first:0.71 03:40:28 INFO - PID 1340 | Values: 38.0 38.0 38.0 38.0 40.0 38.0 38.0 38.0 39.0 38.0 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | [#10] stanford-crypto-aes Cycles:10 Average:72.20 Median:72.50 stddev:1.69 (2.3%) stddev-sans-first:1.73 03:40:28 INFO - PID 1340 | Values: 71.0 72.0 72.0 74.0 69.0 73.0 72.0 71.0 75.0 73.0 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | [#11] stanford-crypto-ccm Cycles:10 Average:106.50 Median:107.50 stddev:3.14 (2.9%) stddev-sans-first:3.32 03:40:28 INFO - PID 1340 | Values: 107.0 105.0 108.0 104.0 105.0 105.0 108.0 111.0 111.0 101.0 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:158.50 stddev:7.82 (4.9%) stddev-sans-first:8.26 03:40:28 INFO - PID 1340 | Values: 160.0 175.0 157.0 163.0 148.0 157.0 150.0 151.0 162.0 157.0 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.50 stddev:2.77 (4.5%) stddev-sans-first:2.83 03:40:28 INFO - PID 1340 | Values: 59.0 58.0 62.0 59.0 62.0 60.0 67.0 64.0 61.0 59.0 03:40:28 INFO - PID 1340 | -------- Summary: end -------- 03:40:28 INFO - PID 1340 | 03:40:28 INFO - PID 1340 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:40:28 INFO - TEST-INFO | 1340: exit 0 03:40:28 INFO - TEST-OK | kraken | took 59790ms 03:40:28 INFO - SUITE-END | took 1168s 03:40:29 INFO - Completed test suite (00:19:28) 03:40:29 INFO - javascript benchmark 03:40:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8961.276997814039, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3809.885703428898, 3831.4444405561194, 3838.5393752749674, 3855.0940528975684, 3861.2277544491076, 6080.422359875815, 6084.8478788030325, 6085.269767627879, 6099.207103076599, 6164.9691751541295, 6113.69431528423, 6179.721912513936, 6183.196184496021, 6191.257049154096, 6238.656873871935, 5526.281583394153, 5565.332160140789, 5592.6085174037835, 5600.1599760035915, 5616.3260408751, 5438.157085651711, 5537.529310008654, 5539.9169012464845, 5614.073677843151, 5625.46558076982, 5484.314460692413, 5531.889362212753, 5549.056660367747, 5573.5819813513945, 5583.944160558383, 5507.834764957058, 5524.0, 5531.695756733378, 5577.358603760579, 5609.439056094398, 5460.153676180198, 5472.206530053159, 5503.587230957694, 5515.09001014832, 5517.44825517449, 6099.878002439927, 6126.326104128542, 6140.662263575501, 6182.1345011698395, 6186.257649082094, 6591.406773390418, 6601.042848786947, 6681.732730690766, 6688.3646053624825, 6689.163854518185, 6606.306337834554, 6626.503012274099, 6644.634545100018, 6718.731250749964, 6727.66361681914, 6142.662153581551, 6177.69111544421, 6194.566380353377, 6199.535034872402, 6205.162303089025, 6782.966085169543, 6820.35206655367, 6836.589804611739, 6843.965780171166, 6859.7256109756045, 6573.5069869759, 6603.900941485882, 6616.239132499728, 6658.600483970978, 6661.833454163685, 6618.503612229102, 6652.234992975773, 6652.401283884474, 6683.933160668331, 6714.194296684332, 6573.769918052845, 6582.045603387482, 6620.437262832713, 6622.536422450382, 6662.600243985376, 6506.739730410731, 6561.409473147344, 6654.73381064752, 6678.0, 6683.365080317362, 4865.464798872121, 4893.877653058631, 4939.481354457802, 4947.90104197914, 4947.975260123676, 4425.645948324126, 4429.601335879722, 4447.0, 4480.395146655225, 4484.753338566345, 6129.969350153221, 6133.877322453526, 6174.043023331391, 6188.690565471798, 6196.1635179251125, 6695.397414232742, 6714.0, 6751.797446076625, 6752.189737231563, 6760.1549806274215, 6099.176611157525, 6111.35830737775, 6119.724612392364, 6182.969085154546, 6199.411055949678, 5328.813491527778, 5341.3857406398765, 5343.278657381204, 5435.483629055233, 5436.592255580847, 6806.897896531556, 6893.276205998298, 6900.2409734929115, 6901.102856628606, 6916.0, 6562.606243625398, 6563.146790917151, 6586.110875031809, 6671.299513551007, 6673.299303573055, 6712.295209002984, 6851.760188393382, 6852.486063545154, 6897.931020689729, 6948.791536253921, 6572.112764776885, 6579.046038324321, 6587.604743715392, 6592.0, 6610.8016759497295, 6586.209654841449, 6589.604623722592, 6636.336366363325, 6686.364795344434, 6700.899486507804, 6356.586821856749, 6410.743570257137, 6474.967625162032, 6485.416312531895, 6487.253965793994, 6406.167198264196, 6465.838354041187, 6482.546221764431, 6484.319146489551, 6504.577202481823, 6351.777687780906, 6356.841078973062, 6357.110004599453, 6450.741970321134, 6455.515836312389, 6384.7446102157255, 6407.295197528175, 6455.838604034937, 6462.547621666438, 6557.770478033246, 6233.532485063729, 6260.593061450991, 6291.591046581958, 6309.4952403806665, 6329.49364050884], "value": 6081.781179967877, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [959.6785076999206, 983.6213057972678, 984.217547050095, 984.556949372782, 984.9113579777819, 43199.13601727968, 43952.78023609878, 44319.77840110803, 44397.55602443975, 44505.77747111268, 41329.79335103328, 41671.374929376085, 41715.0, 41752.0, 41758.37362439566, 7287.417006639456, 7454.813629659275, 7577.734779282726, 7603.847923041536, 7610.809729756773, 7422.814429639248, 7560.848783024364, 7563.092428908539, 7565.35694465971, 7569.356604688608, 7541.396688264926, 8099.757007289791, 8290.129536398681, 8326.417150799447, 8327.583620818965, 8225.712100076498, 8245.093039765621, 8265.338772898183, 8286.129956354556, 8291.83416331673, 8052.718154864551, 8123.350131989486, 8131.186881311881, 8144.714934977306, 8154.633041513087, 40835.59164408348, 41125.58874411278, 41173.58826411727, 41186.38220426696, 41298.79350603228, 3754.3054534910857, 3780.621937806225, 3801.77189368636, 3803.866864659751, 3810.0, 33652.495212571834, 33947.321053579035, 33981.83009084963, 34032.82983585091, 34053.14867128317, 5499.945000550023, 5510.559155267569, 5602.13166959122, 5616.269884914935, 5641.5204707599905, 223727.0, 224934.0, 225869.0, 225982.87008565015, 226280.0, 44875.0, 45570.0, 50351.496485035415, 50665.24002139971, 51320.0, 54526.0, 54622.0, 54715.45284547104, 54726.72636636791, 54762.45237547653, 15128.848711512965, 15193.6201594961, 15263.542093737206, 15279.92360038215, 15328.923355383151, 12258.81611775824, 12286.938565307117, 12299.077569182347, 12327.69180770488, 12345.93827030859, 14528.346224419927, 14561.92719036398, 14580.031695720942, 14620.0, 14680.706385872223, 5746.67259759798, 5786.971065144648, 5809.099589563624, 5809.82570522885, 5817.214676018683, 1121.955121795119, 1132.932024078558, 1133.6089049277987, 1142.0806250967885, 1142.6115120858947, 25660.230193094238, 25828.48343033129, 25880.352991175372, 26077.0, 26136.0, 1230.3971054183564, 1233.2230694662485, 1243.8942689871462, 1244.7572723318865, 1251.3305381620971, 13668.0, 13690.589282321545, 13958.23229722375, 14036.789448158286, 14139.363728632236, 274711.0, 276067.0, 276461.0, 276726.0, 277910.0, 58449.70775146182, 58458.415415846146, 58548.70725646344, 58592.7070364654, 58884.0, 1489.4414594527052, 1552.9301181446863, 1563.2887036398638, 1568.5372815019596, 1569.4271590869478, 25514.617280741175, 25558.23325300244, 25572.488550229264, 25679.10123145681, 25803.870980644977, 42468.36297455479, 42493.0, 42503.7874810624, 42541.787291063345, 42557.14885702207, 225293.0, 226629.0, 226918.0, 227592.0, 227809.0, 36354.636453635125, 38482.0, 39085.804570976965, 39536.2092758149, 39627.60372396355, 49868.75065624794, 50991.0, 51499.22751158661, 51888.74055629698, 52159.2176117351, 37431.0, 37527.43708844315, 37529.81235093807, 37655.435168471944, 37671.0, 36369.45445818262, 37143.814280928425, 37273.25453490969, 37365.0, 37395.252094958494, 41669.79165104155, 42945.785271073444, 43181.13637727291, 43351.34972975471, 43550.0, 35181.29637407186, 35646.10884727903, 35701.0, 35960.5615775366, 36001.81999089988, 26474.602880956416, 26528.734712653397, 26600.467990640467, 26697.0, 26864.731352686224], "value": 18645.581634215396, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.7548367427518, 603.4629180029772, 605.3794860268227, 612.9019356902895, 621.3506885304857, 23032.76967230327, 24030.879845600768, 24037.879810600924, 24045.759542404572, 24099.638505422434, 19842.503937401572, 20707.171713131458, 20735.481612959684, 20846.89576552119, 20932.37202883916, 6378.489720822335, 6516.250631177404, 6523.771667991621, 6525.445337146324, 6533.640649764261, 6412.807615771534, 6438.356164383547, 6522.282548919615, 6691.866162676743, 6714.664266786665, 6655.567388119781, 6660.400563949243, 6661.300563440842, 6662.20053593567, 6664.03371511133, 6580.638064906452, 6649.202095748493, 6671.933280667204, 6677.766278180265, 6677.93322066778, 6245.656488893109, 6250.7812226572305, 6255.437010669016, 6260.15487909131, 6269.279032911228, 28305.433891322264, 29215.561766573304, 29292.560611590845, 29482.410351792845, 29946.10161695131, 2281.0, 2303.2974942642486, 2326.8254880884, 2335.9532809343887, 2336.0, 19708.70436943447, 20287.28994485186, 20320.49198770028, 20343.0, 20378.898105509525, 2440.9633855492184, 2490.9003639854386, 2547.1467058535413, 2574.5623244048556, 2583.3670750666206, 130232.0, 137290.3135484326, 139633.0, 144732.99999999895, 150794.0, 15504.457343993132, 15775.447859325099, 16032.278547465392, 16150.273237704096, 16466.42367517155, 25434.745652543606, 25585.360365990626, 25606.231813045637, 25617.231483055537, 25672.48655026889, 9755.317127801127, 9926.702198934043, 10110.797784044278, 10167.593296268215, 10277.280590358752, 8840.646374145092, 8977.32670049749, 9054.0, 9086.045965173562, 9131.086891310815, 9426.387284826464, 9552.665656702122, 9582.520873956275, 9778.95110524457, 9789.51052447389, 2810.3255218747354, 2847.9145625631263, 2874.4825931332143, 2916.606258155164, 2923.9707602924123, 1037.1391744851755, 1060.04066319979, 1061.193492945367, 1061.6125114333213, 1062.2829590026702, 20366.6516809032, 20416.489587760425, 20495.180192792122, 20611.4847128823, 21080.894595527232, 1101.1356085472864, 1101.4878081692052, 1110.9444527773578, 1115.286216821235, 1118.183725880112, 11330.150238731963, 11360.545578176945, 11469.655910322703, 11555.480003399867, 11590.304581724955, 543552.0, 551954.0, 569822.0, 570233.0, 574316.0, 120000.0, 125628.0, 126305.36847315889, 127529.36235318764, 127943.0, 1197.3004539967906, 1197.6646538969103, 1228.177121328712, 1232.4022848918266, 1236.110000799441, 18055.368062117763, 18139.27442902269, 18357.265709371477, 18461.07694615291, 18597.628047438706, 61073.08390374059, 61653.38346616476, 62452.68773656103, 62964.0, 63523.682381587794, 77010.0, 77049.2295077042, 77163.61418192873, 77330.6133469329, 80105.5994720046, 15011.399544018117, 15127.848721513084, 15267.3893044277, 15369.538913832603, 15377.308021139299, 23422.297331080095, 23474.882625586764, 23500.882495588095, 23611.763882360956, 23677.763222367557, 18514.259429622663, 18862.43412697621, 18931.526711832314, 19057.523561911064, 19064.142113605198, 16873.662526749642, 17389.739153912953, 17582.648347032733, 17605.383811566535, 17774.733378999583, 19911.60176796485, 19987.500312492302, 20149.59700806005, 20168.697469538263, 20216.49458763484, 14324.713505730035, 15051.849481505484, 15125.54623361301, 15138.243087845784, 15148.0, 19568.412947611596, 19719.507012324808, 19735.90132049388, 19745.70381444308, 19770.0], "value": 12441.51180299325, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.4277031957536, 1493.671392293695, 1504.3606467251416, 1514.1672080355802, 1536.3854458216713, 16658.91670541647, 17303.307867685293, 17355.999999999985, 17413.216405261763, 17418.129093545336, 16841.578960525992, 16871.83128168721, 16998.660026799458, 17006.82993170068, 17068.914655426706, 2837.8439185844773, 2877.381363006953, 2896.666883308415, 2906.4187162567464, 2915.11089117819, 2820.830750154987, 2870.2393865625627, 2884.8557572121413, 2886.5092934201234, 2890.927726806826, 2786.860656967154, 2825.251308403275, 2875.324298789783, 2875.3530455647415, 2876.8993085242023, 2861.77105831533, 2885.365219651673, 2895.391967686799, 2896.0732565579024, 2898.3913378190605, 2683.0609286749677, 2724.9046283379985, 2729.781617470617, 2729.959050614242, 2731.6721993360725, 16321.673566528721, 16701.749473757904, 16759.581010474714, 16771.413000545046, 16783.580410489714, 8414.915850841475, 8648.43785153963, 8707.390482666216, 8715.825683486295, 8718.34612404066, 5890.528757699374, 6002.099685047234, 6104.481119104881, 6263.404976527223, 6296.433321001132, 2103.3269353806786, 2103.9263625773024, 2110.2719561751173, 2146.098638571804, 2160.60028894655, 29587.70412295871, 29954.55068173979, 29996.400071998654, 30087.247818804488, 30117.69882301171, 7174.426045916314, 7354.926450735531, 7361.963190184015, 7376.542907283472, 7432.479726419207, 19045.523861903563, 19094.809051909582, 19106.904465477583, 19264.32574859873, 19308.32420865291, 8594.398392112616, 8856.64573417069, 8857.335699822539, 8859.11408859122, 8860.64557417709, 7490.700371985168, 7627.084749830056, 7630.656620452093, 7689.577073261024, 7696.153423123452, 5642.125470552071, 5896.115582662549, 5904.022152578934, 5915.112733090071, 5930.673812940329, 1684.0990070312569, 1695.4574536148561, 1725.9223334949957, 1727.2141175764996, 1738.3741852932933, 837.844998675247, 947.1948843482984, 980.1815484070738, 982.1553464020936, 990.8711867457184, 9778.559964801601, 9795.608175672893, 9879.703608891745, 10094.293399462114, 10122.392656440637, 1035.223582313265, 1069.6095924987324, 1071.4321409652896, 1076.725435014082, 1081.324172392255, 5608.261438953856, 5837.503812175928, 5846.444587764156, 5951.583389162717, 6180.876382472416, 24223.51552968966, 24232.394190145387, 24617.13840015591, 25273.368165795633, 25521.36196595063, 24433.144839930515, 24754.628680569807, 24980.750192498206, 25071.749282507306, 25106.24681259565, 12528.30263793027, 12573.93713031429, 12692.619221423187, 12724.491020359266, 12732.299723515296, 9457.668981585612, 9489.667861625087, 9510.714678559654, 9548.61805527799, 9580.66467673628, 20480.48798779983, 20602.69095963592, 20748.0, 21202.72783632987, 21529.569408612053, 21715.565688685823, 21783.673244901656, 21979.120835166414, 22023.348248881077, 22165.0, 11989.700257493632, 12032.037437005194, 12127.818082728943, 12134.271943683407, 12142.635720928387, 15333.310001050202, 15435.305411256295, 15512.069275843485, 15536.766948495555, 15569.68860622804, 12516.624501264976, 12548.0, 12582.496700132258, 12636.30500322491, 12816.231026138461, 12273.324967126893, 12462.189957652723, 12464.065195110585, 12714.682132946751, 12838.35808209567, 10908.454577271263, 10996.065334446661, 11045.668629941114, 11053.502592383202, 11062.22564420483, 8069.31410830086, 8153.22544358285, 8205.097439281555, 8212.876806847782, 8223.09545949957, 8209.302209312274, 8277.503349799032, 8305.875411868949, 8358.456700314704, 8435.915640843514], "value": 7397.300834284413, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.8123837895115, 561.096634418586, 582.9941700582995, 584.6057153688457, 587.4947545111206, 6175.845603859906, 6210.316865144836, 6241.126242326078, 6249.781257655977, 6345.809625711225, 6204.658743769102, 6226.750929962796, 6231.252249730027, 6287.434130928215, 6316.936830631692, 5103.494469131615, 5126.103341763553, 5137.332146820927, 5156.639035267533, 5163.896722065557, 4822.252550854623, 5004.649674522785, 5008.3238762767105, 5140.640155189139, 5148.794048238066, 4960.578350840183, 4975.427825800025, 4989.380575198032, 5017.096922553938, 5031.245313203012, 4948.529889660476, 4976.975115124437, 4983.9252411213865, 4994.425641051271, 5012.298278241049, 4447.822087116544, 4459.687821852472, 4461.1040307869025, 4509.143262780061, 4516.841910533116, 6062.757489700407, 6125.326214116443, 6149.431894866825, 6172.0, 6184.07238914162, 5825.708714564297, 5911.586188966774, 5927.347991720907, 5933.643981361132, 5949.6727679977585, 6692.297308782557, 6716.798496045127, 6720.193576770819, 6725.226598941086, 6750.493712971547, 4856.39295088114, 5056.82301119459, 5059.772310246011, 5090.465501122366, 5094.31226784383, 6695.397414232693, 6777.831633545334, 6862.382385585272, 6902.99999999995, 7001.474889383266, 5157.845264641992, 5173.948260517347, 5193.5585475234275, 5208.817691380784, 5211.244369566468, 5169.65588946869, 5264.92102618461, 5271.024860400838, 5283.339582552181, 5298.841034768963, 5848.53211743068, 5871.6183448075735, 5880.147378630075, 5910.763569457259, 5915.852103697442, 6662.167229096363, 6668.266490686021, 6714.29499902513, 6722.0, 6752.932470675329, 1811.9094045297682, 1819.2359209132196, 1820.0808591661125, 1822.298415110192, 1838.8528917686554, 1238.6903274181454, 1277.2591896699892, 1299.389287035092, 1304.8303720516271, 1311.4950743963643, 6175.44421002112, 6186.536009799193, 6223.284322302993, 6253.218347706536, 6281.120643109968, 6033.879322413527, 6734.215432910282, 6789.898151527731, 6796.9804529321, 6837.179538455417, 6127.387261273926, 6156.0, 6189.226346706661, 6227.408396202353, 6264.780732674334, 3561.4479755637917, 3566.8394922228044, 3623.8188090595363, 3634.4019420773243, 3636.61815509373, 6982.33667801558, 7051.576905385693, 7052.788416347517, 7076.12482692087, 7113.288671132846, 6751.594904305757, 6764.594124352555, 6773.356531129535, 6822.3859852613505, 6899.65366797103, 6789.524733268624, 6840.589564626139, 6848.657567121723, 6867.2102708188195, 7032.789016329519, 6669.933300666931, 6673.499487538551, 6750.189977202767, 6798.286179951232, 6846.281140480178, 6648.601083934979, 6677.198736151693, 6715.697793599202, 6791.505868708876, 6797.456203503609, 6919.464428457113, 6940.757073502403, 6946.79159625212, 6963.79108626742, 6975.372216500539, 5167.22491626244, 5169.147090729987, 5179.8446046618665, 5190.40310364313, 5202.531772140525, 6473.838154046187, 6692.364225398774, 6848.178218613599, 6860.588364698134, 6899.103116594811, 6490.0, 6513.772017979538, 6516.478681705547, 6598.967005165136, 6621.470282377302, 6354.17395738551, 6434.324395938359, 6461.224653041665, 6490.772822951174, 6518.217813862367, 6451.935480645134, 6504.284528701934, 6510.869782604226, 6547.639879806657, 6550.737970481127, 6615.5038372123245, 6633.734650614115, 6662.733490660513, 6666.699998500176, 6676.632785196861, 6402.935970640234, 6432.614043157426, 6451.645159516272, 6514.57655252407, 6530.608163510205], "value": 5186.624255339614, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [967.3615413826867, 1000.2348203624226, 1004.6433516101783, 1005.1054561440315, 1018.6638409324921, 18138.455846324614, 18585.72121418178, 18616.534586635342, 18646.81353186468, 18781.154848031838, 18765.155567999438, 19002.80997190028, 19319.903400483014, 19978.600427991467, 20201.49496262594, 1024.2778840917135, 1053.7207639975413, 1053.9156867450586, 1054.2409465185056, 1054.4253381906879, 1013.1793247469536, 1051.143318195672, 1063.8457423673563, 1065.2277099103128, 1067.0, 1127.5489804078393, 1128.06370712309, 1131.3381671722052, 1133.3879704959313, 1134.568863831747, 1076.8007918535095, 1116.2576886370555, 1119.36755733011, 1120.5741818109148, 1122.8035093858582, 808.9919100808976, 809.6154326694832, 813.5891374855719, 814.4136221920209, 815.2133191470259, 21334.893325533427, 21687.67468487974, 21747.13011479539, 21776.128954841788, 21809.454763630878, 22159.889200554055, 23831.52336953251, 23868.40328991772, 23885.402864928343, 23962.28113156608, 17073.317067317417, 17719.645607087914, 17909.10454477271, 17911.014894180815, 17931.73102403465, 3943.250782351373, 3948.526176858795, 3962.702797290186, 3973.662238709713, 3976.5228172619472, 160897.0, 161336.0, 163972.18013909855, 165291.0, 167056.16471917683, 17905.462836114937, 18112.0, 18193.181306841223, 18524.536886577942, 18628.441146765617, 34729.0, 35170.47244291286, 35211.29577408489, 35215.0, 35603.287934241685, 8425.70510032146, 8485.830283394422, 8503.404761666625, 8513.787155321043, 8516.74449766508, 4210.6841986851105, 4263.509696384894, 4272.423222864935, 4328.653707703376, 4391.165678521071, 5968.910466343008, 6072.0, 6104.17593624855, 6122.571420000557, 6141.7543298267565, 1100.1638754546602, 1108.684025052856, 1131.8302254661867, 1133.6145710458484, 1133.9886601134049, 678.4402867634221, 703.1737708192956, 711.7615100508871, 716.5700579652167, 720.0243669827413, 11968.341741204144, 12045.63863084109, 12358.876411235953, 12982.480700772052, 13457.663558411117, 680.3502654964497, 692.3491917597443, 696.8048946295046, 697.1007400453358, 708.5429897715944, 5619.241402410704, 5629.915551266734, 5696.629719068247, 5768.855778605484, 5768.942310576925, 147242.26378868037, 147286.0, 147431.0, 148706.0, 152935.0, 130212.0, 131616.3419182917, 132174.33912830375, 133051.0, 136885.0, 115229.4238528802, 115569.99999999831, 115762.42118789352, 116180.0, 117521.0, 10758.354498730101, 10860.294080884718, 10861.891381086403, 10890.292131011776, 11032.0, 54101.18848217201, 55473.72263138658, 55489.0, 55598.0, 55924.0, 69215.30784692088, 69515.0, 69578.30421695719, 69746.0, 70162.29837701762, 16064.43774467888, 16326.346946122023, 16488.587785304982, 16526.66946661036, 16763.49709508717, 18240.270389184283, 18294.817051829312, 18332.633347333245, 18471.815281847008, 18492.445226642685, 15861.762073568674, 15917.204139792733, 15935.36258549645, 15994.840051599334, 16059.437919672755, 16078.839211608201, 16225.0, 16306.0, 16311.26599303058, 16416.0, 15061.472848450252, 15159.166245856584, 15182.46861359847, 15194.0, 15196.468123615621, 11270.0, 11397.772044559228, 11490.138239631893, 11666.183367164216, 11771.941140294586, 11340.262882912584, 11377.658670239905, 11472.655820325404, 11581.768364632828, 11583.478743456733], "value": 9566.537970556716, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1369.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 105.0, 106.0, 104.0, 105.0, 107.0, 105.0, 106.0, 106.0, 105.0], "value": 105.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 114.0, 112.0, 114.0, 113.0, 113.0, 112.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 161.0, 162.0, 162.0, 162.0, 164.0, 164.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 73.0, 72.0, 72.0, 73.0, 75.0, 72.0, 74.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 78.0, 78.0, 77.0, 77.0, 77.0, 78.0, 78.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 110.0, 114.0, 111.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 148.0, 150.0, 150.0, 149.0, 148.0, 150.0, 149.0, 150.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 96.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 44.0, 45.0, 44.0, 55.0, 46.0, 47.0, 43.0, 46.0, 48.0], "value": 46.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 40.0, 38.0, 38.0, 38.0, 39.0, 38.0], "value": 38.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 72.0, 74.0, 69.0, 73.0, 72.0, 71.0, 75.0, 73.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 108.0, 104.0, 105.0, 105.0, 108.0, 111.0, 111.0, 101.0], "value": 106.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 175.0, 157.0, 163.0, 148.0, 157.0, 150.0, 151.0, 162.0, 157.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 62.0, 59.0, 62.0, 60.0, 67.0, 64.0, 61.0, 59.0], "value": 61.1, "unit": "score"}]}]} 03:40:29 INFO - Return code: 0 03:40:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:40:29 INFO - # TBPL SUCCESS # 03:40:29 INFO - Running post-action listener: _package_coverage_data 03:40:29 INFO - Running post-action listener: _resource_record_post_action 03:40:29 INFO - [mozharness: 2017-09-15 10:40:29.492595Z] Finished run-tests step (success) 03:40:29 INFO - Running post-run listener: _resource_record_post_run 03:40:29 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 336404480; Read time: 184; Write time: 219644 03:40:29 INFO - TinderboxPrint: CPU usage
13.1% 03:40:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 184 03:40:29 INFO - TinderboxPrint: I/O write bytes / time
336,404,480 / 219,644 03:40:29 INFO - TinderboxPrint: CPU idle
8,220.0 (86.9%) 03:40:29 INFO - TinderboxPrint: CPU user
1,188.0 (12.6%) 03:40:29 INFO - TinderboxPrint: Swap in / out
0 / 0 03:40:29 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9379840; Read time: 0; Write time: 824 03:40:29 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:40:29 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326631424; Read time: 184; Write time: 218796 03:40:30 INFO - Running post-run listener: _upload_blobber_files 03:40:30 INFO - Blob upload gear active. 03:40:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:40:30 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 03:40:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:40:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:40:30 INFO - (blobuploader) - INFO - Open directory for files ... 03:40:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:40:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:40:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:31 INFO - (blobuploader) - INFO - Done attempting. 03:40:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:40:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:40:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:32 INFO - (blobuploader) - INFO - Done attempting. 03:40:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:40:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:40:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:33 INFO - (blobuploader) - INFO - Done attempting. 03:40:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:40:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:40:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:40 INFO - (blobuploader) - INFO - Done attempting. 03:40:40 INFO - (blobuploader) - INFO - Iteration through files over. 03:40:40 INFO - Return code: 0 03:40:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:40:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:40:40 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd5c373fdc0db22159a02a1fddddcc08c82843bce3cb2c2aa5e9a1224c5179eaae762c7defcfc352a6f930e3d42ffe6ed69dd1f102f1a388e6dbe0252a4508bd", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3b992499eece0431aee914ab1e3c1a94f758f0fe8a3e4edbf86635c2f71489047777f21bcdfaa5917578966b1d9354f13ce5aa0b66e57467a76acd8054800b9", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0035e7204ddb51b98b4339ce67ee7a22792e161c8f08cb8a6fc1c430114adea0429b78b094641c494381bff6fdfdc154bf66d43ce448cd68b4ec5d32d98dec92", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43aec6071c7ebd9effb6008d49cd19562ce42c49734d0a2a2c453ffaebb420774495b79de4d01f9d7ffeb226d17bb0bf49f7994e1900a8ceddef8ca860b1d4b4"} 03:40:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:40:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:40:40 INFO - Contents: 03:40:40 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd5c373fdc0db22159a02a1fddddcc08c82843bce3cb2c2aa5e9a1224c5179eaae762c7defcfc352a6f930e3d42ffe6ed69dd1f102f1a388e6dbe0252a4508bd", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3b992499eece0431aee914ab1e3c1a94f758f0fe8a3e4edbf86635c2f71489047777f21bcdfaa5917578966b1d9354f13ce5aa0b66e57467a76acd8054800b9", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0035e7204ddb51b98b4339ce67ee7a22792e161c8f08cb8a6fc1c430114adea0429b78b094641c494381bff6fdfdc154bf66d43ce448cd68b4ec5d32d98dec92", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43aec6071c7ebd9effb6008d49cd19562ce42c49734d0a2a2c453ffaebb420774495b79de4d01f9d7ffeb226d17bb0bf49f7994e1900a8ceddef8ca860b1d4b4"} 03:40:40 INFO - Running post-run listener: copy_logs_to_upload_dir 03:40:40 INFO - Copying logs to upload dir... 03:40:40 INFO - mkdir: /builds/slave/test/build/upload/logs 03:40:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.328849 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-15 03:40:40.870339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 03:40:40.874061) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd5c373fdc0db22159a02a1fddddcc08c82843bce3cb2c2aa5e9a1224c5179eaae762c7defcfc352a6f930e3d42ffe6ed69dd1f102f1a388e6dbe0252a4508bd", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3b992499eece0431aee914ab1e3c1a94f758f0fe8a3e4edbf86635c2f71489047777f21bcdfaa5917578966b1d9354f13ce5aa0b66e57467a76acd8054800b9", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0035e7204ddb51b98b4339ce67ee7a22792e161c8f08cb8a6fc1c430114adea0429b78b094641c494381bff6fdfdc154bf66d43ce448cd68b4ec5d32d98dec92", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43aec6071c7ebd9effb6008d49cd19562ce42c49734d0a2a2c453ffaebb420774495b79de4d01f9d7ffeb226d17bb0bf49f7994e1900a8ceddef8ca860b1d4b4"} build_url:https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/GEzbUQjLSKKZw0Ok6RZgng/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd5c373fdc0db22159a02a1fddddcc08c82843bce3cb2c2aa5e9a1224c5179eaae762c7defcfc352a6f930e3d42ffe6ed69dd1f102f1a388e6dbe0252a4508bd", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3b992499eece0431aee914ab1e3c1a94f758f0fe8a3e4edbf86635c2f71489047777f21bcdfaa5917578966b1d9354f13ce5aa0b66e57467a76acd8054800b9", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0035e7204ddb51b98b4339ce67ee7a22792e161c8f08cb8a6fc1c430114adea0429b78b094641c494381bff6fdfdc154bf66d43ce448cd68b4ec5d32d98dec92", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43aec6071c7ebd9effb6008d49cd19562ce42c49734d0a2a2c453ffaebb420774495b79de4d01f9d7ffeb226d17bb0bf49f7994e1900a8ceddef8ca860b1d4b4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 03:40:40.902269) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:40:40.902600) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1505469784.190999-1316534966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:40:40.986703) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 03:40:40.987027) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 03:40:40.987355) ========= ========= Total master_lag: 0.20 =========