builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-083 starttime: 1505730270.42 results: success (0) revision: ffe6cc09ccf38cca6f0e727837bbc6cb722d1e71 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 03:24:30.419712) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 03:24:30.420193) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 03:24:30.420517) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 03:24:30.501411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:24:30.501875) ========= 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=3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 03:24:30-- 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% 26.9M=0s 2017-09-18 03:24:30 (26.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101123 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:24:30.637842) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:24:30.638144) ========= 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=3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020609 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:24:30.697118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:24:30.697433) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ffe6cc09ccf38cca6f0e727837bbc6cb722d1e71 --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 ffe6cc09ccf38cca6f0e727837bbc6cb722d1e71 --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=3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 03:24:30,765 truncating revision to first 12 chars 2017-09-18 03:24:30,765 Setting DEBUG logging. 2017-09-18 03:24:30,765 attempt 1/10 2017-09-18 03:24:30,765 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ffe6cc09ccf3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 03:24:31,025 unpacking tar archive at: mozilla-central-ffe6cc09ccf3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618494 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:24:31.347504) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 03:24:31.347813) ========= script_repo_revision: ffe6cc09ccf38cca6f0e727837bbc6cb722d1e71 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 03:24:31.348237) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 03:24:31.348544) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 03:24:31.361626) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-18 03:24:31.361978) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-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-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=3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:24:31 INFO - MultiFileLogger online at 20170918 03:24:31 in /builds/slave/test 03:24:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:24:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:24:31 INFO - {'append_to_log': False, 03:24:31 INFO - 'base_work_dir': '/builds/slave/test', 03:24:31 INFO - 'blob_upload_branch': 'Firefox', 03:24:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:24:31 INFO - 'branch': 'Firefox', 03:24:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:24:31 INFO - 'code_coverage': False, 03:24:31 INFO - 'config_files': ('talos/linux_config.py',), 03:24:31 INFO - 'default_actions': ('clobber', 03:24:31 INFO - 'read-buildbot-config', 03:24:31 INFO - 'download-and-extract', 03:24:31 INFO - 'populate-webroot', 03:24:31 INFO - 'create-virtualenv', 03:24:31 INFO - 'install', 03:24:31 INFO - 'setup-mitmproxy', 03:24:31 INFO - 'run-tests'), 03:24:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:24:31 INFO - 'disable_ccov_upload': False, 03:24:31 INFO - 'disable_stylo': False, 03:24:31 INFO - 'download_minidump_stackwalk': True, 03:24:31 INFO - 'download_symbols': 'ondemand', 03:24:31 INFO - 'enable_stylo': False, 03:24:31 INFO - 'enable_webrender': False, 03:24:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:24:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:24:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:24:31 INFO - 'gecko_profile': False, 03:24:31 INFO - 'gecko_profile_interval': 0, 03:24:31 INFO - 'installer_path': 'installer.exe', 03:24:31 INFO - 'log_level': 'info', 03:24:31 INFO - 'log_name': 'talos', 03:24:31 INFO - 'log_to_console': True, 03:24:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:24:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:24:31 INFO - 'opt_config_files': (), 03:24:31 INFO - 'pip_index': False, 03:24:31 INFO - 'suite': 'dromaeojs-e10s', 03:24:31 INFO - 'system_bits': '32', 03:24:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:24:31 INFO - 'title': 'talos-linux64-ix-083', 03:24:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:24:31 INFO - 'use_talos_json': True, 03:24:31 INFO - 'verify': 'False', 03:24:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:24:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:24:31 INFO - 'work_dir': 'build'} 03:24:31 INFO - [mozharness: 2017-09-18 10:24:31.555149Z] Running clobber step. 03:24:31 INFO - Running pre-action listener: _resource_record_pre_action 03:24:31 INFO - Running main action method: clobber 03:24:31 INFO - rmtree: /builds/slave/test/build 03:24:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:24:33 INFO - Running post-action listener: _resource_record_post_action 03:24:33 INFO - [mozharness: 2017-09-18 10:24:33.070487Z] Finished clobber step (success) 03:24:33 INFO - [mozharness: 2017-09-18 10:24:33.070583Z] Running read-buildbot-config step. 03:24:33 INFO - Running pre-action listener: _resource_record_pre_action 03:24:33 INFO - Running main action method: read_buildbot_config 03:24:33 INFO - Using buildbot properties: 03:24:33 INFO - { 03:24:33 INFO - "project": "", 03:24:33 INFO - "product": "firefox", 03:24:33 INFO - "who": "archaeopteryx@coole-files.de", 03:24:33 INFO - "installer_path": "public/build/target.tar.bz2", 03:24:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:24:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:24:33 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:24:33 INFO - "stage_platform": "linux64-qr", 03:24:33 INFO - "basedir": "/builds/slave/test", 03:24:33 INFO - "buildnumber": 63, 03:24:33 INFO - "platform": "ubuntu64_hw_qr", 03:24:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:24:33 INFO - "slavebuilddir": "test", 03:24:33 INFO - "taskId": "SkQk4LNSQ4OiyRJTMoECMw", 03:24:33 INFO - "branch": "mozilla-central", 03:24:33 INFO - "script_repo_revision": "production", 03:24:33 INFO - "revision": "ffe6cc09ccf38cca6f0e727837bbc6cb722d1e71", 03:24:33 INFO - "slavename": "talos-linux64-ix-083", 03:24:33 INFO - "repo_path": "mozilla-central" 03:24:33 INFO - } 03:24:33 INFO - Finding installer, test and symbols from parent task. 03:24:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SkQk4LNSQ4OiyRJTMoECMw'}, attempt #1 03:24:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SkQk4LNSQ4OiyRJTMoECMw'}, attempt #1 03:24:33 INFO - Task dependencies: L5VTY1pKRgOdH0QnkhRnug 03:24:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug'}, attempt #1 03:24:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.tar.bz2 03:24:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.test_packages.json 03:24:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.crashreporter-symbols.zip 03:24:34 INFO - Running post-action listener: _resource_record_post_action 03:24:34 INFO - [mozharness: 2017-09-18 10:24:34.426824Z] Finished read-buildbot-config step (success) 03:24:34 INFO - [mozharness: 2017-09-18 10:24:34.427042Z] Running download-and-extract step. 03:24:34 INFO - Running pre-action listener: _resource_record_pre_action 03:24:34 INFO - Running main action method: download_and_extract 03:24:34 INFO - mkdir: /builds/slave/test/build/tests 03:24:34 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:24:34 INFO - trying https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.test_packages.json 03:24:34 INFO - Downloading https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:24:34 INFO - Downloaded 989 bytes. 03:24:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:24:34 INFO - Using the following test package requirements: 03:24:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:24:34 INFO - u'common': [u'target.common.tests.zip'], 03:24:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:24:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:24:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:24:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:24:34 INFO - u'mozbase': [u'target.common.tests.zip'], 03:24:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:24:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:24:34 INFO - u'web-platform': [u'target.common.tests.zip', 03:24:34 INFO - u'target.web-platform.tests.tar.gz'], 03:24:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:24:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:24:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.common.tests.zip 03:24:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:24:34 INFO - Fetch https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.common.tests.zip into memory 03:24:36 INFO - Content-Length response header: 54731218 03:24:36 INFO - Bytes received: 54731218 03:24:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.talos.tests.zip 03:24:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:24:47 INFO - Fetch https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.talos.tests.zip into memory 03:24:49 INFO - Content-Length response header: 14508748 03:24:49 INFO - Bytes received: 14508748 03:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:49 INFO - trying https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.tar.bz2 03:24:49 INFO - Downloading https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:24:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:24:51 INFO - Downloaded 61588572 bytes. 03:24:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.tar.bz2 03:24:51 INFO - mkdir: /builds/slave/test/properties 03:24:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:24:51 INFO - Writing to file /builds/slave/test/properties/build_url 03:24:51 INFO - Contents: 03:24:51 INFO - build_url:https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.tar.bz2 03:24:51 INFO - Running post-action listener: _resource_record_post_action 03:24:51 INFO - Running post-action listener: find_tests_for_verification 03:24:51 INFO - Running post-action listener: set_extra_try_arguments 03:24:51 INFO - [mozharness: 2017-09-18 10:24:51.880070Z] Finished download-and-extract step (success) 03:24:51 INFO - [mozharness: 2017-09-18 10:24:51.880300Z] Running populate-webroot step. 03:24:51 INFO - Running pre-action listener: _resource_record_pre_action 03:24:51 INFO - Running main action method: populate_webroot 03:24:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:24:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:24:51 INFO - 'tests': ['tresize', 03:24:51 INFO - 'tcanvasmark']}, 03:24:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:24:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:24:51 INFO - 'tests': ['dromaeo_css', 03:24:51 INFO - 'kraken']}, 03:24:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:24:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:24:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:24:51 INFO - 'talos_options': ['--disable-stylo'], 03:24:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:24:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:24:51 INFO - 'tests': ['damp', 'tps']}, 03:24:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:24:51 INFO - 'talos_options': ['--disable-stylo'], 03:24:51 INFO - 'tests': ['damp', 'tps']}, 03:24:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:24:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:24:51 INFO - 'tests': ['dromaeo_dom']}, 03:24:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:24:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:24:51 INFO - 'tests': ['basic_compositor_video', 03:24:51 INFO - 'glvideo']}, 03:24:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:24:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:24:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:24:51 INFO - 'talos_options': ['--disable-stylo'], 03:24:51 INFO - 'tests': ['ts_paint_webext', 03:24:51 INFO - 'tp5o_webext']}, 03:24:51 INFO - 'other-e10s': {'tests': ['a11yr', 03:24:51 INFO - 'ts_paint', 03:24:51 INFO - 'tpaint', 03:24:51 INFO - 'sessionrestore', 03:24:51 INFO - 'sessionrestore_many_windows', 03:24:51 INFO - 'sessionrestore_no_auto_restore', 03:24:51 INFO - 'tabpaint']}, 03:24:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:24:51 INFO - 'tests': ['a11yr', 03:24:51 INFO - 'ts_paint', 03:24:51 INFO - 'tpaint', 03:24:51 INFO - 'sessionrestore', 03:24:51 INFO - 'sessionrestore_many_windows', 03:24:51 INFO - 'sessionrestore_no_auto_restore', 03:24:51 INFO - 'tabpaint']}, 03:24:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:24:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:24:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:24:51 INFO - 'tests': ['perf_reftest_singletons']}, 03:24:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:24:51 INFO - 'tests': ['bloom_basic']}, 03:24:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:24:51 INFO - 'tsvgr_opacity', 03:24:51 INFO - 'tart', 03:24:51 INFO - 'tscrollx', 03:24:51 INFO - 'tsvg_static']}, 03:24:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:24:51 INFO - 'tests': ['tsvgx', 03:24:51 INFO - 'tsvgr_opacity', 03:24:51 INFO - 'tart', 03:24:51 INFO - 'tscrollx', 03:24:51 INFO - 'tsvg_static']}, 03:24:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:24:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:24:51 INFO - 'talos_options': ['--disable-stylo'], 03:24:51 INFO - 'tests': ['tp5o']}, 03:24:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:24:51 INFO - 'talos_options': ['--mitmproxy', 03:24:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:24:51 INFO - '--firstNonBlankPaint'], 03:24:51 INFO - 'tests': ['tp6_google', 03:24:51 INFO - 'tp6_youtube', 03:24:51 INFO - 'tp6_amazon', 03:24:51 INFO - 'tp6_facebook']}, 03:24:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:24:51 INFO - 'talos_options': ['--disable-stylo', 03:24:51 INFO - '--mitmproxy', 03:24:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:24:51 INFO - '--firstNonBlankPaint'], 03:24:51 INFO - 'tests': ['tp6_google', 03:24:51 INFO - 'tp6_youtube', 03:24:51 INFO - 'tp6_amazon', 03:24:51 INFO - 'tp6_facebook']}, 03:24:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:24:51 INFO - 'talos_options': ['--stylo-threads=1', 03:24:51 INFO - '--mitmproxy', 03:24:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:24:51 INFO - '--firstNonBlankPaint'], 03:24:51 INFO - 'tests': ['tp6_google', 03:24:51 INFO - 'tp6_youtube', 03:24:51 INFO - 'tp6_amazon', 03:24:51 INFO - 'tp6_facebook']}, 03:24:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:24:51 INFO - 'talos_options': ['--xperf_path', 03:24:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:24:51 INFO - 'tests': ['tp5n']}, 03:24:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:24:51 INFO - 'talos_options': ['--disable-stylo', 03:24:51 INFO - '--xperf_path', 03:24:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:24:51 INFO - 'tests': ['tp5n']}}} 03:24:51 INFO - Running post-action listener: _resource_record_post_action 03:24:51 INFO - [mozharness: 2017-09-18 10:24:51.907088Z] Finished populate-webroot step (success) 03:24:51 INFO - [mozharness: 2017-09-18 10:24:51.907178Z] Running create-virtualenv step. 03:24:51 INFO - Running pre-action listener: _resource_record_pre_action 03:24:51 INFO - Running main action method: create_virtualenv 03:24:51 INFO - Creating virtualenv /builds/slave/test/build/venv 03:24:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:24:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:24:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:24:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:24:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:24:52 INFO - Installing distribute.............................................................................................................................................................................................done. 03:24:52 INFO - Installing pip...............done. 03:24:52 INFO - Return code: 0 03:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:24:52 INFO - Reading from file tmpfile_stdout 03:24:52 INFO - Output received: 03:24:52 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:24:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:24:52 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:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:52 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:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:52 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 0x21d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548090>, '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 0x2548d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2542f90>, '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': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', '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:24:52 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:24:52 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:24:52 INFO - Using env: {'DISPLAY': ':0', 03:24:52 INFO - 'HOME': '/home/cltbld', 03:24:52 INFO - 'LANG': 'en_US.UTF-8', 03:24:52 INFO - 'LANGUAGE': 'en_US:en', 03:24:52 INFO - 'LOGNAME': 'cltbld', 03:24:52 INFO - 'MAIL': '/var/mail/cltbld', 03:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:52 INFO - 'MOZ_NO_REMOTE': '1', 03:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:52 INFO - 'NO_EM_RESTART': '1', 03:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:52 INFO - 'PWD': '/builds/slave/test', 03:24:52 INFO - 'SHELL': '/bin/bash', 03:24:52 INFO - 'SHLVL': '1', 03:24:52 INFO - 'TERM': 'linux', 03:24:52 INFO - 'TMOUT': '86400', 03:24:52 INFO - 'USER': 'cltbld', 03:24:52 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', 03:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:52 INFO - '_': '/tools/buildbot/bin/python'} 03:24:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:24:54 INFO - Downloading/unpacking pip>=1.5 03:24:54 INFO - Running setup.py egg_info for package pip 03:24:54 INFO - warning: no files found matching 'pip/cacert.pem' 03:24:54 INFO - warning: no files found matching '*.html' under directory 'docs' 03:24:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:24:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:24:54 INFO - Installing collected packages: pip 03:24:54 INFO - Found existing installation: pip 1.1 03:24:54 INFO - Uninstalling pip: 03:24:54 INFO - Successfully uninstalled pip 03:24:54 INFO - Running setup.py install for pip 03:24:54 INFO - warning: no files found matching 'pip/cacert.pem' 03:24:54 INFO - warning: no files found matching '*.html' under directory 'docs' 03:24:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:24:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:24:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:24:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:24:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:24:54 INFO - Successfully installed pip 03:24:54 INFO - Cleaning up... 03:24:54 INFO - Return code: 0 03:24:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:24:54 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:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:54 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:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:54 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 0x21d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548090>, '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 0x2548d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2542f90>, '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': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', '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:24:54 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:24:54 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:24:54 INFO - Using env: {'DISPLAY': ':0', 03:24:54 INFO - 'HOME': '/home/cltbld', 03:24:54 INFO - 'LANG': 'en_US.UTF-8', 03:24:54 INFO - 'LANGUAGE': 'en_US:en', 03:24:54 INFO - 'LOGNAME': 'cltbld', 03:24:54 INFO - 'MAIL': '/var/mail/cltbld', 03:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:54 INFO - 'MOZ_NO_REMOTE': '1', 03:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:54 INFO - 'NO_EM_RESTART': '1', 03:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:54 INFO - 'PWD': '/builds/slave/test', 03:24:54 INFO - 'SHELL': '/bin/bash', 03:24:54 INFO - 'SHLVL': '1', 03:24:54 INFO - 'TERM': 'linux', 03:24:54 INFO - 'TMOUT': '86400', 03:24:54 INFO - 'USER': 'cltbld', 03:24:54 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', 03:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:54 INFO - '_': '/tools/buildbot/bin/python'} 03:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:54 INFO - Downloading/unpacking psutil>=3.1.1 03:24:54 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:24:54 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:24:54 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:24:54 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:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:24:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:24:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:24:55 INFO - Installing collected packages: psutil 03:24:55 INFO - Running setup.py install for psutil 03:24:55 INFO - building 'psutil._psutil_linux' extension 03:24:55 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:24:55 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:24:55 INFO - building 'psutil._psutil_posix' extension 03:24:55 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:24:55 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:24:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:24:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:24:56 INFO - Successfully installed psutil 03:24:56 INFO - Cleaning up... 03:24:56 INFO - Return code: 0 03:24:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:56 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 0x21d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548090>, '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 0x2548d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2542f90>, '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': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', '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:24:56 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:24:56 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:24:56 INFO - Using env: {'DISPLAY': ':0', 03:24:56 INFO - 'HOME': '/home/cltbld', 03:24:56 INFO - 'LANG': 'en_US.UTF-8', 03:24:56 INFO - 'LANGUAGE': 'en_US:en', 03:24:56 INFO - 'LOGNAME': 'cltbld', 03:24:56 INFO - 'MAIL': '/var/mail/cltbld', 03:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:56 INFO - 'MOZ_NO_REMOTE': '1', 03:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:56 INFO - 'NO_EM_RESTART': '1', 03:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:56 INFO - 'PWD': '/builds/slave/test', 03:24:56 INFO - 'SHELL': '/bin/bash', 03:24:56 INFO - 'SHLVL': '1', 03:24:56 INFO - 'TERM': 'linux', 03:24:56 INFO - 'TMOUT': '86400', 03:24:56 INFO - 'USER': 'cltbld', 03:24:56 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', 03:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:56 INFO - '_': '/tools/buildbot/bin/python'} 03:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:24:56 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:24:56 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:24:56 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:24:56 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:24:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:24:57 INFO - Installing collected packages: mozsystemmonitor 03:24:57 INFO - Running setup.py install for mozsystemmonitor 03:24:57 INFO - Successfully installed mozsystemmonitor 03:24:57 INFO - Cleaning up... 03:24:58 INFO - Return code: 0 03:24:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548090>, '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 0x2548d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2542f90>, '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': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', '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:24:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:24:58 INFO - Using env: {'DISPLAY': ':0', 03:24:58 INFO - 'HOME': '/home/cltbld', 03:24:58 INFO - 'LANG': 'en_US.UTF-8', 03:24:58 INFO - 'LANGUAGE': 'en_US:en', 03:24:58 INFO - 'LOGNAME': 'cltbld', 03:24:58 INFO - 'MAIL': '/var/mail/cltbld', 03:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:58 INFO - 'MOZ_NO_REMOTE': '1', 03:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:58 INFO - 'NO_EM_RESTART': '1', 03:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:58 INFO - 'PWD': '/builds/slave/test', 03:24:58 INFO - 'SHELL': '/bin/bash', 03:24:58 INFO - 'SHLVL': '1', 03:24:58 INFO - 'TERM': 'linux', 03:24:58 INFO - 'TMOUT': '86400', 03:24:58 INFO - 'USER': 'cltbld', 03:24:58 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', 03:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:58 INFO - '_': '/tools/buildbot/bin/python'} 03:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:58 INFO - Downloading/unpacking jsonschema==2.5.1 03:24:58 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:24:58 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:24:58 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:24:58 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:24:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:25:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:25:00 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:25:00 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:25:00 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:25:00 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:25:00 INFO - Downloading functools32-3.2.3-2.tar.gz 03:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:25:00 INFO - warning: no files found matching '*.txt' 03:25:00 INFO - no previously-included directories found matching 'build' 03:25:00 INFO - no previously-included directories found matching 'dist' 03:25:00 INFO - no previously-included directories found matching '.git*' 03:25:00 INFO - Installing collected packages: jsonschema, functools32 03:25:00 INFO - Running setup.py install for functools32 03:25:00 INFO - warning: no files found matching '*.txt' 03:25:00 INFO - no previously-included directories found matching 'build' 03:25:00 INFO - no previously-included directories found matching 'dist' 03:25:00 INFO - no previously-included directories found matching '.git*' 03:25:00 INFO - Successfully installed jsonschema functools32 03:25:00 INFO - Cleaning up... 03:25:00 INFO - Return code: 0 03:25:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:25: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:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25: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:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:00 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 0x21d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548090>, '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 0x2548d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2542f90>, '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': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', '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:25:00 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:25:00 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:25:00 INFO - Using env: {'DISPLAY': ':0', 03:25:00 INFO - 'HOME': '/home/cltbld', 03:25:00 INFO - 'LANG': 'en_US.UTF-8', 03:25:00 INFO - 'LANGUAGE': 'en_US:en', 03:25:00 INFO - 'LOGNAME': 'cltbld', 03:25:00 INFO - 'MAIL': '/var/mail/cltbld', 03:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:00 INFO - 'MOZ_NO_REMOTE': '1', 03:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:00 INFO - 'NO_EM_RESTART': '1', 03:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:00 INFO - 'PWD': '/builds/slave/test', 03:25:00 INFO - 'SHELL': '/bin/bash', 03:25:00 INFO - 'SHLVL': '1', 03:25:00 INFO - 'TERM': 'linux', 03:25:00 INFO - 'TMOUT': '86400', 03:25:00 INFO - 'USER': 'cltbld', 03:25:00 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', 03:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:00 INFO - '_': '/tools/buildbot/bin/python'} 03:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:25:00 INFO - Cleaning up... 03:25:00 INFO - Return code: 0 03:25:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:25: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:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25: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:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:00 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 0x21d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548090>, '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 0x2548d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2542f90>, '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': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', '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:25:00 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:25:00 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:25:00 INFO - Using env: {'DISPLAY': ':0', 03:25:00 INFO - 'HOME': '/home/cltbld', 03:25:00 INFO - 'LANG': 'en_US.UTF-8', 03:25:00 INFO - 'LANGUAGE': 'en_US:en', 03:25:00 INFO - 'LOGNAME': 'cltbld', 03:25:00 INFO - 'MAIL': '/var/mail/cltbld', 03:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:00 INFO - 'MOZ_NO_REMOTE': '1', 03:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:00 INFO - 'NO_EM_RESTART': '1', 03:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:00 INFO - 'PWD': '/builds/slave/test', 03:25:00 INFO - 'SHELL': '/bin/bash', 03:25:00 INFO - 'SHLVL': '1', 03:25:00 INFO - 'TERM': 'linux', 03:25:00 INFO - 'TMOUT': '86400', 03:25:00 INFO - 'USER': 'cltbld', 03:25:00 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', 03:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:00 INFO - '_': '/tools/buildbot/bin/python'} 03:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:00 INFO - Downloading/unpacking blobuploader==1.2.4 03:25:00 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:25:00 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:25:00 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:25:00 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:25:02 INFO - Downloading blobuploader-1.2.4.tar.gz 03:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:25:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:25:02 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:25:02 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:25:02 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:25:02 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:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:25:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:25:02 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:25:02 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:25:02 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:25:02 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:25:02 INFO - Downloading docopt-0.6.1.tar.gz 03:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:25:02 INFO - Installing collected packages: blobuploader, requests, docopt 03:25:02 INFO - Running setup.py install for blobuploader 03:25:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:25:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:25:02 INFO - Running setup.py install for requests 03:25:03 INFO - Running setup.py install for docopt 03:25:03 INFO - Successfully installed blobuploader requests docopt 03:25:03 INFO - Cleaning up... 03:25:03 INFO - Return code: 0 03:25:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:03 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 0x21d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548090>, '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 0x2548d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2542f90>, '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': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', '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:25:03 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:25:03 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:25:03 INFO - Using env: {'DISPLAY': ':0', 03:25:03 INFO - 'HOME': '/home/cltbld', 03:25:03 INFO - 'LANG': 'en_US.UTF-8', 03:25:03 INFO - 'LANGUAGE': 'en_US:en', 03:25:03 INFO - 'LOGNAME': 'cltbld', 03:25:03 INFO - 'MAIL': '/var/mail/cltbld', 03:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:03 INFO - 'MOZ_NO_REMOTE': '1', 03:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:03 INFO - 'NO_EM_RESTART': '1', 03:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:03 INFO - 'PWD': '/builds/slave/test', 03:25:03 INFO - 'SHELL': '/bin/bash', 03:25:03 INFO - 'SHLVL': '1', 03:25:03 INFO - 'TERM': 'linux', 03:25:03 INFO - 'TMOUT': '86400', 03:25:03 INFO - 'USER': 'cltbld', 03:25:03 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', 03:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:03 INFO - '_': '/tools/buildbot/bin/python'} 03:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:03 INFO - Running setup.py (path:/tmp/pip-P5Qwmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:03 INFO - Running setup.py (path:/tmp/pip-Z0Ol3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:03 INFO - Running setup.py (path:/tmp/pip-a1xkVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:03 INFO - Running setup.py (path:/tmp/pip-optwTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:03 INFO - Running setup.py (path:/tmp/pip-k9z_kW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:03 INFO - Running setup.py (path:/tmp/pip-4h6_vX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:03 INFO - Running setup.py (path:/tmp/pip-dSrtLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:03 INFO - Running setup.py (path:/tmp/pip-PqYDd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:03 INFO - Running setup.py (path:/tmp/pip-WrhVO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:04 INFO - Running setup.py (path:/tmp/pip-3nVJLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:04 INFO - Running setup.py (path:/tmp/pip-hNZAeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:04 INFO - Running setup.py (path:/tmp/pip-od2Iqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:04 INFO - Running setup.py (path:/tmp/pip-sdVZf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:04 INFO - Running setup.py (path:/tmp/pip-l0Y6RY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:04 INFO - Running setup.py (path:/tmp/pip-Zj7On8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:04 INFO - Running setup.py (path:/tmp/pip-iFUaWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:04 INFO - Running setup.py (path:/tmp/pip-4rPZNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:25:04 INFO - Running setup.py install for manifestparser 03:25:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:25:04 INFO - Running setup.py install for mozcrash 03:25:04 INFO - Running setup.py install for mozdebug 03:25:04 INFO - Running setup.py install for mozdevice 03:25:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:25:05 INFO - Running setup.py install for mozfile 03:25:05 INFO - Running setup.py install for mozhttpd 03:25:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:25:05 INFO - Running setup.py install for mozinfo 03:25:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:25:05 INFO - Running setup.py install for mozInstall 03:25:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:25:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:25:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:25:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:25:05 INFO - Running setup.py install for mozleak 03:25:05 INFO - Running setup.py install for mozlog 03:25:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:25:05 INFO - Running setup.py install for moznetwork 03:25:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:25:05 INFO - Running setup.py install for mozprocess 03:25:05 INFO - Running setup.py install for mozprofile 03:25:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:25:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:25:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:25:05 INFO - Running setup.py install for mozrunner 03:25:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:25:06 INFO - Running setup.py install for mozscreenshot 03:25:06 INFO - Running setup.py install for moztest 03:25:06 INFO - Running setup.py install for mozversion 03:25:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:25:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:25:06 INFO - Cleaning up... 03:25:06 INFO - Return code: 0 03:25:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:06 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:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:06 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:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:06 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 0x21d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548090>, '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 0x2548d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2542f90>, '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': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', '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:25:06 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:25:06 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:25:06 INFO - Using env: {'DISPLAY': ':0', 03:25:06 INFO - 'HOME': '/home/cltbld', 03:25:06 INFO - 'LANG': 'en_US.UTF-8', 03:25:06 INFO - 'LANGUAGE': 'en_US:en', 03:25:06 INFO - 'LOGNAME': 'cltbld', 03:25:06 INFO - 'MAIL': '/var/mail/cltbld', 03:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:06 INFO - 'MOZ_NO_REMOTE': '1', 03:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:06 INFO - 'NO_EM_RESTART': '1', 03:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:06 INFO - 'PWD': '/builds/slave/test', 03:25:06 INFO - 'SHELL': '/bin/bash', 03:25:06 INFO - 'SHLVL': '1', 03:25:06 INFO - 'TERM': 'linux', 03:25:06 INFO - 'TMOUT': '86400', 03:25:06 INFO - 'USER': 'cltbld', 03:25:06 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', 03:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:06 INFO - '_': '/tools/buildbot/bin/python'} 03:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:06 INFO - Running setup.py (path:/tmp/pip-xoDtqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:06 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:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:06 INFO - Running setup.py (path:/tmp/pip-f32QkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:06 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:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:06 INFO - Running setup.py (path:/tmp/pip-00DhmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:06 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:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:06 INFO - Running setup.py (path:/tmp/pip-MJ0FOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:06 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:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:06 INFO - Running setup.py (path:/tmp/pip-bzVLGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:06 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:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:06 INFO - Running setup.py (path:/tmp/pip-CSrbw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:07 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:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:07 INFO - Running setup.py (path:/tmp/pip-qapEvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:07 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:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:07 INFO - Running setup.py (path:/tmp/pip-Hif1Mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:07 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:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:07 INFO - Running setup.py (path:/tmp/pip-t3iz8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:07 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:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:07 INFO - Running setup.py (path:/tmp/pip-FVicBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:07 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:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:07 INFO - Running setup.py (path:/tmp/pip-MDMxx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:07 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:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:07 INFO - Running setup.py (path:/tmp/pip-nWXoUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:07 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:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:07 INFO - Running setup.py (path:/tmp/pip-wPapn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:07 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:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:07 INFO - Running setup.py (path:/tmp/pip-6o_hyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:07 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:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:07 INFO - Running setup.py (path:/tmp/pip-AsHcLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:07 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:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:07 INFO - Running setup.py (path:/tmp/pip-2ErpQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:07 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:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:07 INFO - Running setup.py (path:/tmp/pip-A7sWWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:08 INFO - Downloading blessings-1.6.tar.gz 03:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:25:09 INFO - Installing collected packages: blessings 03:25:09 INFO - Running setup.py install for blessings 03:25:09 INFO - Successfully installed blessings 03:25:09 INFO - Cleaning up... 03:25:09 INFO - Return code: 0 03:25:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:25:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:09 INFO - Reading from file tmpfile_stdout 03:25:09 INFO - Current package versions: 03:25:09 INFO - argparse == 1.2.1 03:25:09 INFO - blessings == 1.6 03:25:09 INFO - blobuploader == 1.2.4 03:25:09 INFO - docopt == 0.6.1 03:25:09 INFO - functools32 == 3.2.3-2 03:25:09 INFO - jsonschema == 2.5.1 03:25:09 INFO - manifestparser == 1.1 03:25:09 INFO - mozInstall == 1.13 03:25:09 INFO - mozcrash == 1.0 03:25:09 INFO - mozdebug == 0.1 03:25:09 INFO - mozdevice == 0.51 03:25:09 INFO - mozfile == 1.2 03:25:09 INFO - mozhttpd == 0.7 03:25:09 INFO - mozinfo == 0.10 03:25:09 INFO - mozleak == 0.1 03:25:09 INFO - mozlog == 3.5 03:25:09 INFO - moznetwork == 0.27 03:25:09 INFO - mozprocess == 0.25 03:25:09 INFO - mozprofile == 0.28 03:25:09 INFO - mozrunner == 6.13 03:25:09 INFO - mozscreenshot == 0.1 03:25:09 INFO - mozsystemmonitor == 0.3 03:25:09 INFO - moztest == 0.8 03:25:09 INFO - mozversion == 1.4 03:25:09 INFO - psutil == 3.1.1 03:25:09 INFO - requests == 1.2.3 03:25:09 INFO - wsgiref == 0.1.2 03:25:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:09 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 0x21d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548090>, '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 0x2548d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2542f90>, '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': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', '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:25:09 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:25:09 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:25:09 INFO - Using env: {'DISPLAY': ':0', 03:25:09 INFO - 'HOME': '/home/cltbld', 03:25:09 INFO - 'LANG': 'en_US.UTF-8', 03:25:09 INFO - 'LANGUAGE': 'en_US:en', 03:25:09 INFO - 'LOGNAME': 'cltbld', 03:25:09 INFO - 'MAIL': '/var/mail/cltbld', 03:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:09 INFO - 'MOZ_NO_REMOTE': '1', 03:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:09 INFO - 'NO_EM_RESTART': '1', 03:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:09 INFO - 'PWD': '/builds/slave/test', 03:25:09 INFO - 'SHELL': '/bin/bash', 03:25:09 INFO - 'SHLVL': '1', 03:25:09 INFO - 'TERM': 'linux', 03:25:09 INFO - 'TMOUT': '86400', 03:25:09 INFO - 'USER': 'cltbld', 03:25:09 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', 03:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:09 INFO - '_': '/tools/buildbot/bin/python'} 03:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:09 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:25:09 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:25:09 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:25:09 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:25:09 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:25:09 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:25:09 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:25:09 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:25:09 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:25:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:25:09 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:25:09 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:25:09 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:25:09 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:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:25:10 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:25:10 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:25:10 INFO - Installing collected packages: simplejson 03:25:10 INFO - Running setup.py install for simplejson 03:25:10 INFO - building 'simplejson._speedups' extension 03:25:10 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:25:11 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:25:11 INFO - Successfully installed simplejson 03:25:11 INFO - Cleaning up... 03:25:11 INFO - Return code: 0 03:25:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:11 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 0x21d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2544a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548090>, '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 0x2548d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2542f90>, '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': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', '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:25:11 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:25:11 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:25:11 INFO - Using env: {'DISPLAY': ':0', 03:25:11 INFO - 'HOME': '/home/cltbld', 03:25:11 INFO - 'LANG': 'en_US.UTF-8', 03:25:11 INFO - 'LANGUAGE': 'en_US:en', 03:25:11 INFO - 'LOGNAME': 'cltbld', 03:25:11 INFO - 'MAIL': '/var/mail/cltbld', 03:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:11 INFO - 'MOZ_NO_REMOTE': '1', 03:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:11 INFO - 'NO_EM_RESTART': '1', 03:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:11 INFO - 'PWD': '/builds/slave/test', 03:25:11 INFO - 'SHELL': '/bin/bash', 03:25:11 INFO - 'SHLVL': '1', 03:25:11 INFO - 'TERM': 'linux', 03:25:11 INFO - 'TMOUT': '86400', 03:25:11 INFO - 'USER': 'cltbld', 03:25:11 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', 03:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:11 INFO - '_': '/tools/buildbot/bin/python'} 03:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:25:12 INFO - Cleaning up... 03:25:12 INFO - Return code: 0 03:25:12 INFO - Running post-action listener: _resource_record_post_action 03:25:12 INFO - Running post-action listener: _start_resource_monitoring 03:25:12 INFO - Starting resource monitoring. 03:25:12 INFO - [mozharness: 2017-09-18 10:25:12.122237Z] Finished create-virtualenv step (success) 03:25:12 INFO - [mozharness: 2017-09-18 10:25:12.122706Z] Running install step. 03:25:12 INFO - Running pre-action listener: _resource_record_pre_action 03:25:12 INFO - Running main action method: install 03:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:12 INFO - Reading from file tmpfile_stdout 03:25:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:25:12 INFO - Reading from file tmpfile_stdout 03:25:12 INFO - Output received: 03:25:12 INFO - Usage: mozinstall [options] installer 03:25:12 INFO - Options: 03:25:12 INFO - -h, --help show this help message and exit 03:25:12 INFO - -d DEST, --destination=DEST 03:25:12 INFO - Directory to install application into. [default: 03:25:12 INFO - "/builds/slave/test"] 03:25:12 INFO - --app=APP Application being installed. [default: firefox] 03:25:12 INFO - mkdir: /builds/slave/test/build/application 03:25:12 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:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:25:30 INFO - Reading from file tmpfile_stdout 03:25:30 INFO - Output received: 03:25:30 INFO - /builds/slave/test/build/application/firefox/firefox 03:25:30 INFO - Running post-action listener: _resource_record_post_action 03:25:30 INFO - [mozharness: 2017-09-18 10:25:30.992393Z] Finished install step (success) 03:25:30 INFO - [mozharness: 2017-09-18 10:25:30.992644Z] Running setup-mitmproxy step. 03:25:30 INFO - Running pre-action listener: _resource_record_pre_action 03:25:30 INFO - Running main action method: setup_mitmproxy 03:25:30 INFO - Skipping: mitmproxy is not required 03:25:30 INFO - Running post-action listener: _resource_record_post_action 03:25:30 INFO - [mozharness: 2017-09-18 10:25:30.993813Z] Finished setup-mitmproxy step (success) 03:25:30 INFO - [mozharness: 2017-09-18 10:25:30.994033Z] Running run-tests step. 03:25:30 INFO - Running pre-action listener: _resource_record_pre_action 03:25:30 INFO - Running pre-action listener: _set_gcov_prefix 03:25:30 INFO - Running main action method: run_tests 03:25:30 WARNING - Try message not found. 03:25:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:25:31 INFO - Python 2.7.3 03:25:31 INFO - Return code: 0 03:25:31 INFO - grabbing minidump binary from tooltool 03:25: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:25:31 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 0x2548090>, '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 0x2548d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2542f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:25:31 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:25:31 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:25:31 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:25:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:25:31 INFO - Return code: 0 03:25:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:25:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:25:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:25:31 INFO - ENV: RUST_BACKTRACE is now full 03:25:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:25:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:25:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:25:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-083 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:25:31 INFO - Using env: {'DISPLAY': ':0', 03:25:31 INFO - 'HOME': '/home/cltbld', 03:25:31 INFO - 'LANG': 'en_US.UTF-8', 03:25:31 INFO - 'LANGUAGE': 'en_US:en', 03:25:31 INFO - 'LOGNAME': 'cltbld', 03:25:31 INFO - 'MAIL': '/var/mail/cltbld', 03:25:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:25:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:25:31 INFO - 'MOZ_ACCELERATED': '1', 03:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:31 INFO - 'MOZ_NO_REMOTE': '1', 03:25:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:25:31 INFO - 'MOZ_WEBRENDER': '1', 03:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:31 INFO - 'NO_EM_RESTART': '1', 03:25:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:31 INFO - 'PWD': '/builds/slave/test', 03:25:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:25:31 INFO - 'RUST_BACKTRACE': 'full', 03:25:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:25:31 INFO - 'SHELL': '/bin/bash', 03:25:31 INFO - 'SHLVL': '1', 03:25:31 INFO - 'TERM': 'linux', 03:25:31 INFO - 'TMOUT': '86400', 03:25:31 INFO - 'USER': 'cltbld', 03:25:31 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', 03:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:31 INFO - '_': '/tools/buildbot/bin/python'} 03:25:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:25:31 INFO - mozversion application_buildid: 20170918093516 03:25:31 INFO - mozversion application_changeset: ffe6cc09ccf38cca6f0e727837bbc6cb722d1e71 03:25:31 INFO - mozversion application_display_name: Nightly 03:25:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:25:31 INFO - mozversion application_name: Firefox 03:25:31 INFO - mozversion application_remotingname: firefox 03:25:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:25:31 INFO - mozversion application_vendor: Mozilla 03:25:31 INFO - mozversion application_version: 57.0a1 03:25:31 INFO - mozversion platform_buildid: 20170918093516 03:25:31 INFO - mozversion platform_changeset: ffe6cc09ccf38cca6f0e727837bbc6cb722d1e71 03:25:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:25:31 INFO - mozversion platform_version: 57.0a1 03:25:31 INFO - using testdate: 1505730331 03:25:31 INFO - actual date: 1505730331 03:25:31 INFO - starting webserver on 'localhost:48782' 03:25:31 INFO - SUITE-START | Running 2 tests 03:25:31 INFO - TEST-START | dromaeo_css 03:25:31 INFO - Initialising browser for dromaeo_css test... 03:25:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48782/getInfo.html -profile /tmp/tmpaBSpmC/profile 03:25:31 INFO - TEST-INFO | started process 21535 (/builds/slave/test/build/application/firefox/firefox http://localhost:48782/getInfo.html) 03:25:37 INFO - TEST-INFO | 21535: exit 0 03:25:37 INFO - Browser initialized. 03:25:37 INFO - Running cycle 1/1 for dromaeo_css test... 03:25:37 INFO - Using env: {'DISPLAY': ':0', 03:25:37 INFO - 'HOME': '/home/cltbld', 03:25:37 INFO - 'JSGC_DISABLE_POISONING': '1', 03:25:37 INFO - 'LANG': 'en_US.UTF-8', 03:25:37 INFO - 'LANGUAGE': 'en_US:en', 03:25:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:25:37 INFO - 'LOGNAME': 'cltbld', 03:25:37 INFO - 'MAIL': '/var/mail/cltbld', 03:25:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:25:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:25:37 INFO - 'MOZ_ACCELERATED': '1', 03:25:37 INFO - 'MOZ_CRASHREPORTER': '1', 03:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:25:37 INFO - 'MOZ_NO_REMOTE': '1', 03:25:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:25:37 INFO - 'MOZ_WEBRENDER': '1', 03:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:37 INFO - 'NO_EM_RESTART': '1', 03:25:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:37 INFO - 'PWD': '/builds/slave/test', 03:25:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:25:37 INFO - 'RUST_BACKTRACE': 'full', 03:25:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:25:37 INFO - 'SHELL': '/bin/bash', 03:25:37 INFO - 'SHLVL': '1', 03:25:37 INFO - 'TERM': 'linux', 03:25:37 INFO - 'TMOUT': '86400', 03:25:37 INFO - 'USER': 'cltbld', 03:25:37 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', 03:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:37 INFO - '_': '/tools/buildbot/bin/python'} 03:25:37 INFO - TEST-INFO | started process 21773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaBSpmC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:25:38 INFO - PID 21773 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:25:38 INFO - PID 21773 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:25:38 INFO - PID 21773 | 03:25:38 INFO - PID 21773 | (/builds/slave/test/build/application/firefox/firefox:21833): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:25:38 INFO - PID 21773 | 03:25:49 INFO - PID 21773 | RSS: Main: 206905344 03:25:49 INFO - PID 21773 | 03:28:46 INFO - PID 21773 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48782/tests/dromaeo/cssquery-ext.html) 03:28:48 INFO - PID 21773 | RSS: Main: 203313152 03:28:48 INFO - PID 21773 | 03:31:50 INFO - PID 21773 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-ext.html (next: http://localhost:48782/tests/dromaeo/cssquery-jquery.html) 03:31:51 INFO - PID 21773 | RSS: Main: 204509184 03:31:51 INFO - PID 21773 | 03:34:53 INFO - PID 21773 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48782/tests/dromaeo/cssquery-mootools.html) 03:34:53 INFO - PID 21773 | RSS: Main: 203800576 03:34:53 INFO - PID 21773 | 03:37:55 INFO - PID 21773 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48782/tests/dromaeo/cssquery-prototype.html) 03:37:56 INFO - PID 21773 | RSS: Main: 204824576 03:37:56 INFO - PID 21773 | 03:40:59 INFO - PID 21773 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48782/tests/dromaeo/cssquery-yui.html) 03:41:00 INFO - PID 21773 | RSS: Main: 206495744 03:41:00 INFO - PID 21773 | 03:44:02 INFO - PID 21773 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-yui.html (next: http://localhost:48782/tests/dromaeo/cssquery-dojo.html) 03:44:02 INFO - PID 21773 | RSS: Main: 206233600 03:44:02 INFO - PID 21773 | 03:44:02 INFO - PID 21773 | __start_tp_report 03:44:02 INFO - PID 21773 | _x_x_mozilla_page_load 03:44:02 INFO - PID 21773 | _x_x_mozilla_page_load_details 03:44:02 INFO - PID 21773 | |i|pagename|runs| 03:44:02 INFO - PID 21773 | |0;dojo.html;3098.411301852649;3105.130563442236;3133.952990705139;3144.2296637323857;3146.0561831450545;6127.540434467422;6242.1261023456755;6295.276043255021;6330.366963303673;6345.8413539661415;6168.136460895467;6193.721282542285;6246.687665616723;6250.8124756257275;6296.622202667843;5716;5773.48038676519;5774.538036957033;5782.45066718661;5792.507636850873;5850.590458667895;5912.17229587858;5924.792632257871;5933.762649494015;5964.3737407572235;5851.590388672795;5880.088586269135;5915.5859089863725;5916.112583112525;5949.048152295633;5279.577633789288;5630.5495560355075;5678.829635110953;5885.588008839383;5978.432048955364;5765.769369225226;5770.249867517238;5838.124281357788;5856.882862342772;5864.032434648278;6178.320384757673;6275.592086514362;6311.652859092748;6326.43062124411;6397.744090236385;6655.600663960178;6775.661216939183;6801;6802.591844489347;6823.3858952694;6845.315468453165;6858.794236172923;6921.792346229621;6930.237673855871;6935.3411425914455;6283.214598175228;6295.8740825183695;6296.118543403927;6358.078078678612;6405.263394709621;6953.89569156463;6957.1651401831095;7008.088948436671;7042.647867606599;7057.788266352018;6413.16628838248;6447.548671592944;6511.73953041873;6547.738090476423;6599.538032337787;6758.189017317855;6762.222344430355;6796.898046529306;6810.318968103249;6816.829579260559;6755.831104222434;6771;6795.048693182958;6798.796036118924;6821.3519715626935;6736.8989465158065;6752.527323087336;6770.492213084039;6851.040854280404;6851.45188384928;5175.327207463006;5247.344081989751;5340.652857564246;5354.3574771027725;5384.596155288291;4596.149712303235;4627.884302892455;4665.976670116627;4719.38647975761;4731.621470282369;5733.455321744427;5777.942220577825;5790.739416726257;5811.535077193815;5814.883702326015;6745.460363170934;6789.592624442549;6803.251642319341;6813.727450902007;6848.280930502226;5582.8325150245555;5707.200991861143;5709.257796486513;5733.770649173986;5734.827955161351;5744.253247077853;5750.166225897222;5766.88466230673;5801.506871915934;5806.738696758656;6453.193350831146;6491.285958544557;6581.440577550962;6592.208934927743;6643.7674681385915;6767.323267673193;6780.084688566981;6810.931890681129;6844.315568443116;6860.211075726355;6522.05430212607;6541.378569035934;6610.933890661032;6618.90071648916;6624.072629831731;6454.838629034311;6616.569922954993;6626.0392243123515;6631.801045968628;6770.593764374154;6710.127683401127;6711;6742.831429214309;6760.898586521108;6761.628110453972;6421;6504.447121994684;6506.121673574196;6615.702293396905;6620.536562440583;6532.314107018885;6532.738690452519;6603.570767900071;6648.069270302259;6651.33486651331;6316.715747791269;6425.710843012169;6485.77299794505;6538.934610654022;6565;6498.772542960974;6545.509086818603;6566.737330506726;6582.506312026713;6599.835004124935;6337.493000560036;6340.9048864268;6340.9048864268;6362.586431882098;6380.234371875405 03:44:02 INFO - PID 21773 | |1;ext.html;754.8150703077744;773.0645918438696;795.4272923495083;809.8218391953772;810.5460941872552;40945.79527102364;41575.16849663005;41640.58359416401;41762.79118604403;41782.58217417825;37147.62852371475;37424.438633420454;37495.06262343443;37759;37769.62230377695;6905.620190889512;6936.861262774767;6952.200496942841;6965.930340696579;7043.366097051265;6885.621290829003;6969;6978.406835418996;6992.6853291602;6996.475264355168;6922.965385173092;6954.791356259295;7611.885821712651;7839.6472158752995;7855.607219638995;7656.693732250703;7709.38324934004;7717.382609391263;7718.922810771876;7729.768106956744;7577.393808495307;7640.426967977424;7645.923540764632;7650.961745191294;7662.693492260303;37342.62657373419;37688;37716.62283377159;37771;37822;3463.1342164458883;3476.0093373388463;3501.4747787831775;3503.1592417819793;3504.54440922681;31253.843730781202;31265.687343126505;31479.37041259185;31591.684083159103;31626;5139.537441630271;5149.3305870237;5173.17229243323;5201.609879259071;5247.580193584504;181724;182749.0862545692;182840;183098;183266;48287.517124829006;48320.75839620779;48531.757341213066;48539.271910921365;48552.02895942061;50694.239586406235;50736;53361;55045.174322385195;55070.44929550734;14578.198199099152;14601.19693416851;14799.334029968677;14811.88910831692;14816;11853.288802671867;11861.11041671878;11880.287182769061;11922.821157682642;11926.284422934652;14741.92629036848;14932;14957.401703931939;14980;15048.097114172966;5778.5377169826315;5837.270341207349;5996.730147143389;6008.879822403527;6019.819405417757;992.9205663546899;1027.5786927359748;1031.7214352124884;1037.1858091398217;1041.6041904076403;23830.404239893796;23895.641565376533;23960.161394351464;24163.39591510191;24254.636180457306;1093.9935259561064;1113.7215696075982;1122.45560902962;1124.8818874018111;1128.4865386249237;12277.938610306892;12467.376631168405;12499.93750031244;12507.749845003049;12513.49946002168;237814;238015;239289;241128;241289;44089;45317.77341113339;47106.76446617745;47604;47699.76150119297;1309.8821106100497;1439.330711219288;1457.7521821290406;1461.926903654813;1469.6619777451247;26705.19884403471;27464.725352746216;27635.723642763314;27703.168904932885;28028.85985570059;38005.619943801314;38545.22909541737;38568;38623.613763863126;38632.80683596564;204011;205557;205639;205968;206478;34894.825525872206;35122.297554048266;35955.46066809052;36039;36086.27827443489;42932.57067429286;43864.34203486887;44108.779456103795;44248.33627495654;44837.77581112074;32221.838890805397;32250;32795.016149515555;32924.1768955778;33048.173795655304;31717.524237136;31719;32201.711931523412;32233.194170144994;32587.674123258465;36492.27015459729;36733;36869.26261474702;36977.63022369849;36992.81503592465;30192.698073019867;30488.84755576208;30588;31145.8442707785;31583.842080790368;22759.772402275765;22990.770092299532;23222.187223447097;23330.650040249748;23405.76594234104 03:44:02 INFO - PID 21773 | |2;jquery.html;554.4455544455546;567.3560508822485;569.2144840120633;571.3229822660145;573.5211098732558;22101.33695989121;23106.65340019899;23168.65247021296;23216.65175022374;23218.65172022421;22988.1954131605;24152.154674586393;24357.75642243577;24388.512229755393;24575.877120614372;6307.873842523159;6381.298057213703;6437.2275326960835;6482.7406903723795;6510.804675859732;6266.561340706153;6384.744610215585;6385.201849768779;6394.488440924738;6422.100905873182;5995.910061349062;6231.6572588507615;6240.656763877985;6292.465140463043;6346.936530634704;6311.621302721828;6319.65241911697;6336.20797400325;6360.745570177188;6367.872642547146;5887.264091988502;5899.823005309848;5909.143174239711;5923.526117910556;6137.202163718733;27884.721152788414;28494.430111397654;28666.570001449996;28731.712682873112;28770.280742981384;2053.753549574046;2095.0258129969484;2101.243552321163;2102.1066046930146;2107.9578408431744;18254.269829206816;18706.251749929987;18753.437396878115;18884.811151888443;18955;2420.165043060141;2468.4816188600416;2479.466914613367;2481.5781317176125;2488.9004439822384;122423.38788306002;125095.3745231268;125332.37333813273;136056;140489.2975535126;19968.3011094611;20465.795342046687;20775;20853;21410.78589214088;40905;40996.795016025324;41018.58981410207;41063;41098;11262.267952583055;11329.773404531863;11426.828597571042;11475.655730328104;11677;9430.434173949585;9438;9572.473513956798;9639.807203856024;9643.27675424346;10541.262111652111;10566.260361774755;10666.626668066581;10793.460326983619;11251.381174035507;4172.486730255024;4177.8537751178565;4184.665226781911;4191.958080419217;4420.513743488214;964.7829238421299;970.6214576315243;979.588572799426;986.7434467038622;986.9654562090292;18861.622767544573;18947.810521894604;19161.712574311397;19428.805711942983;19855.900720496305;1029.577873072037;1030.644427672452;1046.6336782126348;1055.382601178304;1059.247933966892;10682.57269709203;10728.463576821128;10805.459727013618;10851.891481085246;10884.61903833362;483562;484087;487210;499750;507309;108123.45938270258;108697.4565127185;112088.43955780168;112135.4393228045;114257;1041.8853926068127;1084.6258040975852;1149.1266637355502;1159.7622487390065;1212.484694005062;19754.308599198957;20010.89994550076;20394.69407958852;20428.489287767923;20556.897215513825;54631;54909.725451374085;56498.43501565096;57181.42818571761;57586.424135758105;68938;69377;69537;69955.65022174857;70059;19278.807211927702;19687.70468443003;19795.703064454334;19913.303034393728;20017.899910500353;22336.553268934204;22397.21609743716;22460.663090053335;22777.88611056934;22888.656670149627;17844.732329014816;18043.909780451013;18056.45830625083;18059.2776288947;18252.72620910714;14917.552473425814;15064.096154230781;15563.533094007198;15903.363865445715;16399.83600163983;17224.483265502055;18308.450746477625;18345.449636510926;18463.16915738768;18661.533461663566;19196.80803192006;19219;19256.903715481894;19304.806951930303;19524.8047519523;17694.734578981584;17863.821361786737;17959.730604040687;18076.276948921895;18105.818941810412 03:44:02 INFO - PID 21773 | |3;mootools.html;1282.4805953588798;1350.5205651993542;1367.5282027700443;1367.7401293754192;1379.413749156609;14708.191049492287;15218.23908804558;15282;15290.082595044305;15308.770368444468;15083.09501429915;15199.6960060799;15225.84774152261;15253.69492610147;15259.618509537268;2664.773494252986;2812.02984970185;2819.8026138170335;2829.759470445015;2829.985850070747;2770.598263251827;2777.6389069421048;2786.0109661070333;2794.3153927287844;2794.776417886564;2695.3935364542917;2696.6763988321427;2697.1234348836706;2711.3357227479296;2717.7689896358834;2617.803664725144;2627.0673910761693;2660.827046241998;2661.108528642907;2665.720099389575;2566;2590.5596048671773;2609.9478010439684;2610.673665791776;2619.6594442722326;14524.564263072125;14730.116193028452;14795.926020369938;14801.555953321418;14803.55589332311;7868.685252589889;8168.142345053743;8182.059063207747;8182.140875208136;8185.058718247418;5203.4796520348045;5366.114591092465;5417.726834193962;5595.440455954413;5608.355039170507;1875.5217419557925;1881.313320637971;1894.7063205203078;1916.7699876014829;1947.5423275530238;23858.16496422617;24870;24873.766410366716;25894.352641183934;26617.733822661718;7243.261617211831;7348.853022939511;7359.080114985627;7425.888611670829;7544.622768861535;19949.501262468555;20046.09792559338;20060.69908951367;20109.798902011084;20211;8330.125336839666;8330.250277475056;8391.328693704489;8406.411551191359;8454.15458454162;7368;7584.355329796918;7607.581583012877;7622;7686.57723825195;5478.986387518242;5565.1374037024325;5569.944300556943;5641.266635337462;5685.232493613392;1738.8695847811464;1778.084286592406;1779.24382137591;1793.2020250988185;1796.1019490254873;853.2875049333752;864.3301441382979;881.3213825354442;886.6763631274538;888.9777755556033;8349.791255218668;8484.915150848412;8538.146185381413;8588.355873309527;8646.092160323202;675.5507587454387;715.5742333311671;717.3149642091789;720.218562859293;721.8556288742168;4776.259679749644;4826.300186472942;4859.829905953275;4889.997550502138;4926.6551341406475;20623.58752824935;20770.688439673417;21562.245321413677;21778.34664960054;21964.341069767932;21217;21679.506856711363;21714.782852171593;21811.67282490764;22153.889230553745;10800.45997700112;11198.944005280084;11228.66314010581;11321.603743868925;11415.885841141648;8522.914770852212;8527.91472085296;8570.4000719949;8639.568021599021;8724.214820666171;17594.120293985507;18344.449666510027;18446.723299150253;18597.163127659016;18636.16137273853;18452.446426607225;19093.809061909204;19539.70690439616;19898;20013.199472020955;12150.817737734118;12352.197107188003;12382.133250672367;12386.876131238572;12391.75216495683;13958.371873265525;14019.859801401855;14116.717665646835;14185.36165872559;14256.786148207993;11227.943860280646;11540.711482213012;11731.23746956445;11752.23610465317;11984.40077996114;11098.833517497405;11312.038476729242;11367.658970230576;11431.42842857837;11490.88509114898;9740.318177727491;9950.253730970062;9953.950230248802;9958.302918795614;9980;6969.860602788017;7007.684654190675;7081.539699919489;7191.640417979184;7309.488335816442;6971.163460384786;7178.353948144483;7306.853862922818;7397.149327827368;7412.703491860265 03:44:02 INFO - PID 21773 | |4;prototype.html;481.744675322079;508.3188527373321;509.54904909155397;515.9071367153913;517.6945602094764;6125.326214116443;6193.349698281678;6194.225721784777;6227.314995350508;6270.184875966123;6005.699715014242;6123.724432400541;6148.907766383508;6178.845528861781;6222.471089957359;5060.089183946879;5110.821121260757;5178.042062218502;5180.3265575475325;5181.455947125554;5077.669951453144;5114.974425127869;5153.407358153804;5174.896502069956;5195.324607800981;4691.4604820445575;4886.534039788067;4891.070696567658;4920.655554111196;5100.795968161269;4878.170710979142;4909.337239472661;4909.607231421478;4926.433460152057;4936.851894443173;4341.674374421931;4345.47854257488;4356.194104090753;4388.363687265329;4412.514623391425;5822.330432000332;5931.288245410536;5951.196588460546;6026.879462410771;6087.9650459422;5621.128725047624;5622.550195984311;5653.9151912721345;5661.943380566224;5678.801241956512;6474.773382931622;6489.4483968862705;6514.804555863332;6557.5081868860025;6599.5380323377385;4578.816847326103;4801.495842936476;4814.711117332971;4827.275908613736;4837.879053023667;6604.14146160996;6604.93395066048;6633.734650613969;6779.830504237433;6811.795646130624;4863.221884498464;4928.802847886044;4941.25881117828;4948.579370753454;4992.2511623256805;5005.449400565934;5006.499350064964;5022.9748851256245;5026.4973502649445;5067.3412456381175;5644.125160600113;5658.632188907708;5669.489745922887;5680.517156041783;5700.429957004267;6605.306442823435;6619.172603424572;6624.867502650017;6629.86740265192;6665.966670166715;1722.2938595175917;1742.912854357277;1746.97379539307;1765.7727879123886;1771.070188151231;1158.9337809215374;1177.7408970026581;1199.4122879789015;1210.8002179640437;1213.9575114870938;5474.315710536183;5498.862528436741;5520.66875987442;5567.164925261162;5597.888042239132;6484.859996201242;6550.2794692583775;6601.471882249409;6632.2704502504685;6721.82368085583;5602.383737788921;5619.494245517923;5636.436356364331;5645.604807663506;5679.2333035040565;3474.3051389722154;3476.331360946709;3509;3521.859125634946;3539.150603855056;6216.844578885564;6269.435750782361;6312.400321969406;6373.649449280334;6462.773802916875;6619.338066193439;6644.534882558174;6731.865362692719;6765.830854228684;6791.966040169767;6315.621062736159;6373.808785736435;6381.521385896076;6383.265924418658;6425.710843012076;6068.514518838394;6510.3489651034515;6551.639659818756;6570.244421891352;6627.039079333374;6353.7140828661895;6378.553501254868;6415.6471394071905;6474.967625161844;6482.837929051811;6201.441870231701;6240.344763799736;6246.46905013079;6268.592541484789;6269.592476489013;4833.559052678375;4886.218205087169;4886.560209581155;4919.532644398776;4958.8760280993265;6346.809595712136;6539.378759017885;6555.147830781968;6666.533342665967;6670.366315200048;6288.434040936155;6300.621962682254;6426.4216220540375;6463.741450341934;6489.448396886318;6356.713947872449;6367.42693157618;6384.585001974857;6459.644719540471;6477.8704425912165;6163.568550201443;6183.350748171557;6284.371562843862;6295.213098362705;6307.779227727007;6416.390442907917;6430.2605200400685;6455.580387274812;6514.771982980573;6533;6190.380961903774;6249.18786546047;6270.153529273673;6301.6219026858535;6305.369463053658 03:44:02 INFO - PID 21773 | |5;yui.html;914.6890057380491;920.8020275640736;926.6015613286288;933.9906600933997;941.7410212191648;19216.615667686656;20391.184352625914;20515.794842051593;20551;20566.48583785406;17759;17865;17999.910000449978;18041.7293740594;18053.638927221447;932.659579253571;947.8483442649177;952.4618590496382;955.4840386191448;964.4213471916829;981.3425005246467;983.965561205358;986.8717066781309;987.4272921705393;991.5934466868586;929.7768535551453;1029.474967766437;1032.7418145463635;1038.870141232346;1044.660485342263;1026.7227848480943;1028.1363654530194;1029.135526158027;1030.2221822523945;1030.706248719119;719.6365835253216;755.5957562703927;758.9279018493289;762.142589586715;762.881753328235;20133.295334663362;20401.591968160552;20444.693329600068;20522.486937826674;20577.588448230952;22026;22066.66899996485;22682.546349072927;22736.54526909469;22852.314430566945;17029.65940681192;17085.2311645975;17194.74207886883;17559.385421510313;17743.757936944417;3701.6298370163036;3725.6833169180654;3737.289914916157;3738.345789486856;3741.363968125398;100381;141961;143094.28452857773;143808;144138;16641.334346625998;16864.32542698303;16894.662106757794;16969.15154242283;17010.659786804194;30591.69408305933;31977.20056998547;32111.03666889997;32156.19609509734;32354;8932.285417166611;9062;9085.409448385833;9139.314551408672;9192.81614367709;4293.355996600535;4313.633341165973;4359.346098085249;4391.14372697321;4391.6486681065435;5540.196671482693;5554.444555544494;5578.470045345767;5594.972025139929;5597.468240517144;1089.8692156941217;1112.193659596786;1115.0466351269547;1115.1413411672966;1119.9776004479866;699.6396855619361;706.1138271469273;719.1837264704598;723.2369849808398;723.5767076260447;12010.63968080959;12234.877651223553;12568.74862502763;12847.743045139232;12968.935155324163;673.0745225315192;674.5547938360756;684.6679360510149;693.826543364159;695.1449716848305;5471.388449623576;5478.589105817;5566.248556444909;5612.887742245132;5671.716414179275;120278;127854.36072819577;128123.35938320249;128599;130428;107623;111375.4431227855;112269.43865280622;112382;114980;97318.51340743393;97555;100824.99175008303;102494.97505025004;103027;10447.895521044693;10542.103921166787;10604.8939510607;10608.257421980386;10738.677839664822;44625.33062004008;45695.543044570455;46152.30771538363;46153.307700385194;46836.29745553888;57326;58993.410065900505;59134.40865591289;60695.69652151711;60997.39002609917;15985.280662369989;16035.919820400823;16045;16153.67692646164;16194.109323987293;16948;17057.14714264257;17145.05702186392;17352.39266625662;17564.82435175683;15246.161461119746;15455.304511297243;15520.068795871832;15594.766078509057;15783.763243551586;16831.579210519347;16880.409185678443;16933;16984.66030679404;17239.482815515556;15977.360905564112;16072.839271607134;16082.115483648511;16179.75730364069;16209.918950405172;11549.6535103947;11607.245529040585;11668.70828229301;12106.576269830513;12157.817632735692;12235.510579577074;12251.264924104582;12297.50809967627;12315.93842030784;12500.499980000699 03:44:02 INFO - PID 21773 | __end_tp_report 03:44:02 INFO - PID 21773 | __start_cc_report 03:44:02 INFO - PID 21773 | _x_x_mozilla_cycle_collect,296 03:44:02 INFO - PID 21773 | __end_cc_report 03:44:02 INFO - PID 21773 | __startTimestamp1505731442807__endTimestamp 03:44:02 INFO - PID 21773 | 03:44:02 INFO - PID 21773 | ------- Summary: start ------- 03:44:02 INFO - PID 21773 | Number of tests: 6 03:44:02 INFO - PID 21773 | 03:44:02 INFO - PID 21773 | [#0] dojo.html Cycles:165 Average:6203.87 Median:6421.00 stddev:755.30 (11.8%) stddev-sans-first:717.26 03:44:02 INFO - PID 21773 | Values: 3098.4 3105.1 3134.0 3144.2 3146.1 6127.5 6242.1 6295.3 6330.4 6345.8 6168.1 6193.7 6246.7 6250.8 6296.6 5716.0 5773.5 5774.5 5782.5 5792.5 5850.6 5912.2 5924.8 5933.8 5964.4 5851.6 5880.1 5915.6 5916.1 5949.0 5279.6 5630.5 5678.8 5885.6 5978.4 5765.8 5770.2 5838.1 5856.9 5864.0 6178.3 6275.6 6311.7 6326.4 6397.7 6655.6 6775.7 6801.0 6802.6 6823.4 6845.3 6858.8 6921.8 6930.2 6935.3 6283.2 6295.9 6296.1 6358.1 6405.3 6953.9 6957.2 7008.1 7042.6 7057.8 6413.2 6447.5 6511.7 6547.7 6599.5 6758.2 6762.2 6796.9 6810.3 6816.8 6755.8 6771.0 6795.0 6798.8 6821.4 6736.9 6752.5 6770.5 6851.0 6851.5 5175.3 5247.3 5340.7 5354.4 5384.6 4596.1 4627.9 4666.0 4719.4 4731.6 5733.5 5777.9 5790.7 5811.5 5814.9 6745.5 6789.6 6803.3 6813.7 6848.3 5582.8 5707.2 5709.3 5733.8 5734.8 5744.3 5750.2 5766.9 5801.5 5806.7 6453.2 6491.3 6581.4 6592.2 6643.8 6767.3 6780.1 6810.9 6844.3 6860.2 6522.1 6541.4 6610.9 6618.9 6624.1 6454.8 6616.6 6626.0 6631.8 6770.6 6710.1 6711.0 6742.8 6760.9 6761.6 6421.0 6504.4 6506.1 6615.7 6620.5 6532.3 6532.7 6603.6 6648.1 6651.3 6316.7 6425.7 6485.8 6538.9 6565.0 6498.8 6545.5 6566.7 6582.5 6599.8 6337.5 6340.9 6340.9 6362.6 6380.2 03:44:02 INFO - PID 21773 | 03:44:02 INFO - PID 21773 | [#1] ext.html Cycles:180 Average:37736.41 Median:35538.88 stddev:54575.00 (153.6%) stddev-sans-first:54657.45 03:44:02 INFO - PID 21773 | Values: 754.8 773.1 795.4 809.8 810.5 40945.8 41575.2 41640.6 41762.8 41782.6 37147.6 37424.4 37495.1 37759.0 37769.6 6905.6 6936.9 6952.2 6965.9 7043.4 6885.6 6969.0 6978.4 6992.7 6996.5 6923.0 6954.8 7611.9 7839.6 7855.6 7656.7 7709.4 7717.4 7718.9 7729.8 7577.4 7640.4 7645.9 7651.0 7662.7 37342.6 37688.0 37716.6 37771.0 37822.0 3463.1 3476.0 3501.5 3503.2 3504.5 31253.8 31265.7 31479.4 31591.7 31626.0 5139.5 5149.3 5173.2 5201.6 5247.6 181724.0 182749.1 182840.0 183098.0 183266.0 48287.5 48320.8 48531.8 48539.3 48552.0 50694.2 50736.0 53361.0 55045.2 55070.4 14578.2 14601.2 14799.3 14811.9 14816.0 11853.3 11861.1 11880.3 11922.8 11926.3 14741.9 14932.0 14957.4 14980.0 15048.1 5778.5 5837.3 5996.7 6008.9 6019.8 992.9 1027.6 1031.7 1037.2 1041.6 23830.4 23895.6 23960.2 24163.4 24254.6 1094.0 1113.7 1122.5 1124.9 1128.5 12277.9 12467.4 12499.9 12507.7 12513.5 237814.0 238015.0 239289.0 241128.0 241289.0 44089.0 45317.8 47106.8 47604.0 47699.8 1309.9 1439.3 1457.8 1461.9 1469.7 26705.2 27464.7 27635.7 27703.2 28028.9 38005.6 38545.2 38568.0 38623.6 38632.8 204011.0 205557.0 205639.0 205968.0 206478.0 34894.8 35122.3 35955.5 36039.0 36086.3 42932.6 43864.3 44108.8 44248.3 44837.8 32221.8 32250.0 32795.0 32924.2 33048.2 31717.5 31719.0 32201.7 32233.2 32587.7 36492.3 36733.0 36869.3 36977.6 36992.8 30192.7 30488.8 30588.0 31145.8 31583.8 22759.8 22990.8 23222.2 23330.7 23405.8 03:44:02 INFO - PID 21773 | 03:44:02 INFO - PID 21773 | [#2] jquery.html Cycles:180 Average:35340.16 Median:22218.95 stddev:82415.21 (370.9%) stddev-sans-first:82605.02 03:44:02 INFO - PID 21773 | Values: 554.4 567.4 569.2 571.3 573.5 22101.3 23106.7 23168.7 23216.7 23218.7 22988.2 24152.2 24357.8 24388.5 24575.9 6307.9 6381.3 6437.2 6482.7 6510.8 6266.6 6384.7 6385.2 6394.5 6422.1 5995.9 6231.7 6240.7 6292.5 6346.9 6311.6 6319.7 6336.2 6360.7 6367.9 5887.3 5899.8 5909.1 5923.5 6137.2 27884.7 28494.4 28666.6 28731.7 28770.3 2053.8 2095.0 2101.2 2102.1 2108.0 18254.3 18706.3 18753.4 18884.8 18955.0 2420.2 2468.5 2479.5 2481.6 2488.9 122423.4 125095.4 125332.4 136056.0 140489.3 19968.3 20465.8 20775.0 20853.0 21410.8 40905.0 40996.8 41018.6 41063.0 41098.0 11262.3 11329.8 11426.8 11475.7 11677.0 9430.4 9438.0 9572.5 9639.8 9643.3 10541.3 10566.3 10666.6 10793.5 11251.4 4172.5 4177.9 4184.7 4192.0 4420.5 964.8 970.6 979.6 986.7 987.0 18861.6 18947.8 19161.7 19428.8 19855.9 1029.6 1030.6 1046.6 1055.4 1059.2 10682.6 10728.5 10805.5 10851.9 10884.6 483562.0 484087.0 487210.0 499750.0 507309.0 108123.5 108697.5 112088.4 112135.4 114257.0 1041.9 1084.6 1149.1 1159.8 1212.5 19754.3 20010.9 20394.7 20428.5 20556.9 54631.0 54909.7 56498.4 57181.4 57586.4 68938.0 69377.0 69537.0 69955.7 70059.0 19278.8 19687.7 19795.7 19913.3 20017.9 22336.6 22397.2 22460.7 22777.9 22888.7 17844.7 18043.9 18056.5 18059.3 18252.7 14917.6 15064.1 15563.5 15903.4 16399.8 17224.5 18308.5 18345.4 18463.2 18661.5 19196.8 19219.0 19256.9 19304.8 19524.8 17694.7 17863.8 17959.7 18076.3 18105.8 03:44:02 INFO - PID 21773 | 03:44:02 INFO - PID 21773 | [#3] mootools.html Cycles:180 Average:9463.19 Median:2643.95 stddev:6689.82 (253.0%) stddev-sans-first:6680.35 03:44:02 INFO - PID 21773 | Values: 1282.5 1350.5 1367.5 1367.7 1379.4 14708.2 15218.2 15282.0 15290.1 15308.8 15083.1 15199.7 15225.8 15253.7 15259.6 2664.8 2812.0 2819.8 2829.8 2830.0 2770.6 2777.6 2786.0 2794.3 2794.8 2695.4 2696.7 2697.1 2711.3 2717.8 2617.8 2627.1 2660.8 2661.1 2665.7 2566.0 2590.6 2609.9 2610.7 2619.7 14524.6 14730.1 14795.9 14801.6 14803.6 7868.7 8168.1 8182.1 8182.1 8185.1 5203.5 5366.1 5417.7 5595.4 5608.4 1875.5 1881.3 1894.7 1916.8 1947.5 23858.2 24870.0 24873.8 25894.4 26617.7 7243.3 7348.9 7359.1 7425.9 7544.6 19949.5 20046.1 20060.7 20109.8 20211.0 8330.1 8330.3 8391.3 8406.4 8454.2 7368.0 7584.4 7607.6 7622.0 7686.6 5479.0 5565.1 5569.9 5641.3 5685.2 1738.9 1778.1 1779.2 1793.2 1796.1 853.3 864.3 881.3 886.7 889.0 8349.8 8484.9 8538.1 8588.4 8646.1 675.6 715.6 717.3 720.2 721.9 4776.3 4826.3 4859.8 4890.0 4926.7 20623.6 20770.7 21562.2 21778.3 21964.3 21217.0 21679.5 21714.8 21811.7 22153.9 10800.5 11198.9 11228.7 11321.6 11415.9 8522.9 8527.9 8570.4 8639.6 8724.2 17594.1 18344.4 18446.7 18597.2 18636.2 18452.4 19093.8 19539.7 19898.0 20013.2 12150.8 12352.2 12382.1 12386.9 12391.8 13958.4 14019.9 14116.7 14185.4 14256.8 11227.9 11540.7 11731.2 11752.2 11984.4 11098.8 11312.0 11367.7 11431.4 11490.9 9740.3 9950.3 9954.0 9958.3 9980.0 6969.9 7007.7 7081.5 7191.6 7309.5 6971.2 7178.4 7306.9 7397.1 7412.7 03:44:02 INFO - PID 21773 | 03:44:02 INFO - PID 21773 | [#4] prototype.html Cycles:180 Average:5421.14 Median:6078.24 stddev:1507.51 (24.8%) stddev-sans-first:1465.45 03:44:02 INFO - PID 21773 | Values: 481.7 508.3 509.5 515.9 517.7 6125.3 6193.3 6194.2 6227.3 6270.2 6005.7 6123.7 6148.9 6178.8 6222.5 5060.1 5110.8 5178.0 5180.3 5181.5 5077.7 5115.0 5153.4 5174.9 5195.3 4691.5 4886.5 4891.1 4920.7 5100.8 4878.2 4909.3 4909.6 4926.4 4936.9 4341.7 4345.5 4356.2 4388.4 4412.5 5822.3 5931.3 5951.2 6026.9 6088.0 5621.1 5622.6 5653.9 5661.9 5678.8 6474.8 6489.4 6514.8 6557.5 6599.5 4578.8 4801.5 4814.7 4827.3 4837.9 6604.1 6604.9 6633.7 6779.8 6811.8 4863.2 4928.8 4941.3 4948.6 4992.3 5005.4 5006.5 5023.0 5026.5 5067.3 5644.1 5658.6 5669.5 5680.5 5700.4 6605.3 6619.2 6624.9 6629.9 6666.0 1722.3 1742.9 1747.0 1765.8 1771.1 1158.9 1177.7 1199.4 1210.8 1214.0 5474.3 5498.9 5520.7 5567.2 5597.9 6484.9 6550.3 6601.5 6632.3 6721.8 5602.4 5619.5 5636.4 5645.6 5679.2 3474.3 3476.3 3509.0 3521.9 3539.2 6216.8 6269.4 6312.4 6373.6 6462.8 6619.3 6644.5 6731.9 6765.8 6792.0 6315.6 6373.8 6381.5 6383.3 6425.7 6068.5 6510.3 6551.6 6570.2 6627.0 6353.7 6378.6 6415.6 6475.0 6482.8 6201.4 6240.3 6246.5 6268.6 6269.6 4833.6 4886.2 4886.6 4919.5 4958.9 6346.8 6539.4 6555.1 6666.5 6670.4 6288.4 6300.6 6426.4 6463.7 6489.4 6356.7 6367.4 6384.6 6459.6 6477.9 6163.6 6183.4 6284.4 6295.2 6307.8 6416.4 6430.3 6455.6 6514.8 6533.0 6190.4 6249.2 6270.2 6301.6 6305.4 03:44:02 INFO - PID 21773 | 03:44:02 INFO - PID 21773 | [#5] yui.html Cycles:180 Average:24770.93 Median:18047.68 stddev:35855.08 (198.7%) stddev-sans-first:35910.92 03:44:02 INFO - PID 21773 | Values: 914.7 920.8 926.6 934.0 941.7 19216.6 20391.2 20515.8 20551.0 20566.5 17759.0 17865.0 17999.9 18041.7 18053.6 932.7 947.8 952.5 955.5 964.4 981.3 984.0 986.9 987.4 991.6 929.8 1029.5 1032.7 1038.9 1044.7 1026.7 1028.1 1029.1 1030.2 1030.7 719.6 755.6 758.9 762.1 762.9 20133.3 20401.6 20444.7 20522.5 20577.6 22026.0 22066.7 22682.5 22736.5 22852.3 17029.7 17085.2 17194.7 17559.4 17743.8 3701.6 3725.7 3737.3 3738.3 3741.4 100381.0 141961.0 143094.3 143808.0 144138.0 16641.3 16864.3 16894.7 16969.2 17010.7 30591.7 31977.2 32111.0 32156.2 32354.0 8932.3 9062.0 9085.4 9139.3 9192.8 4293.4 4313.6 4359.3 4391.1 4391.6 5540.2 5554.4 5578.5 5595.0 5597.5 1089.9 1112.2 1115.0 1115.1 1120.0 699.6 706.1 719.2 723.2 723.6 12010.6 12234.9 12568.7 12847.7 12968.9 673.1 674.6 684.7 693.8 695.1 5471.4 5478.6 5566.2 5612.9 5671.7 120278.0 127854.4 128123.4 128599.0 130428.0 107623.0 111375.4 112269.4 112382.0 114980.0 97318.5 97555.0 100825.0 102495.0 103027.0 10447.9 10542.1 10604.9 10608.3 10738.7 44625.3 45695.5 46152.3 46153.3 46836.3 57326.0 58993.4 59134.4 60695.7 60997.4 15985.3 16035.9 16045.0 16153.7 16194.1 16948.0 17057.1 17145.1 17352.4 17564.8 15246.2 15455.3 15520.1 15594.8 15783.8 16831.6 16880.4 16933.0 16984.7 17239.5 15977.4 16072.8 16082.1 16179.8 16209.9 11549.7 11607.2 11668.7 12106.6 12157.8 12235.5 12251.3 12297.5 12315.9 12500.5 03:44:02 INFO - PID 21773 | -------- Summary: end -------- 03:44:02 INFO - PID 21773 | 03:44:03 INFO - TEST-INFO | 21773: exit 0 03:44:03 INFO - TEST-OK | dromaeo_css | took 1112420ms 03:44:03 INFO - TEST-START | kraken 03:44:03 INFO - Initialising browser for kraken test... 03:44:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48782/getInfo.html -profile /tmp/tmpRSUL3R/profile 03:44:03 INFO - TEST-INFO | started process 22150 (/builds/slave/test/build/application/firefox/firefox http://localhost:48782/getInfo.html) 03:44:09 INFO - TEST-INFO | 22150: exit 0 03:44:09 INFO - Browser initialized. 03:44:09 INFO - Running cycle 1/1 for kraken test... 03:44:09 INFO - Using env: {'DISPLAY': ':0', 03:44:09 INFO - 'HOME': '/home/cltbld', 03:44:09 INFO - 'JSGC_DISABLE_POISONING': '1', 03:44:09 INFO - 'LANG': 'en_US.UTF-8', 03:44:09 INFO - 'LANGUAGE': 'en_US:en', 03:44:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:44:09 INFO - 'LOGNAME': 'cltbld', 03:44:09 INFO - 'MAIL': '/var/mail/cltbld', 03:44:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:44:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:44:09 INFO - 'MOZ_ACCELERATED': '1', 03:44:09 INFO - 'MOZ_CRASHREPORTER': '1', 03:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:44:09 INFO - 'MOZ_NO_REMOTE': '1', 03:44:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:44:09 INFO - 'MOZ_WEBRENDER': '1', 03:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:09 INFO - 'NO_EM_RESTART': '1', 03:44:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:09 INFO - 'PWD': '/builds/slave/test', 03:44:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:44:09 INFO - 'RUST_BACKTRACE': 'full', 03:44:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:44:09 INFO - 'SHELL': '/bin/bash', 03:44:09 INFO - 'SHLVL': '1', 03:44:09 INFO - 'TERM': 'linux', 03:44:09 INFO - 'TMOUT': '86400', 03:44:09 INFO - 'USER': 'cltbld', 03:44:09 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892', 03:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:09 INFO - '_': '/tools/buildbot/bin/python'} 03:44:09 INFO - TEST-INFO | started process 22394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRSUL3R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:10 INFO - PID 22394 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:44:10 INFO - PID 22394 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:44:10 INFO - PID 22394 | 03:44:10 INFO - PID 22394 | (/builds/slave/test/build/application/firefox/firefox:22454): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:44:10 INFO - PID 22394 | 03:44:21 INFO - PID 22394 | RSS: Main: 206295040 03:44:21 INFO - PID 22394 | 03:44:24 INFO - PID 22394 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48782/tests/kraken/driver.html?testName=audio-beat-detection) 03:44:25 INFO - PID 22394 | RSS: Main: 208445440 03:44:25 INFO - PID 22394 | 03:44:27 INFO - PID 22394 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48782/tests/kraken/driver.html?testName=audio-dft) 03:44:28 INFO - PID 22394 | RSS: Main: 209399808 03:44:28 INFO - PID 22394 | 03:44:31 INFO - PID 22394 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48782/tests/kraken/driver.html?testName=audio-fft) 03:44:31 INFO - PID 22394 | RSS: Main: 203583488 03:44:31 INFO - PID 22394 | 03:44:34 INFO - PID 22394 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48782/tests/kraken/driver.html?testName=audio-oscillator) 03:44:34 INFO - PID 22394 | RSS: Main: 203870208 03:44:34 INFO - PID 22394 | 03:44:36 INFO - PID 22394 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48782/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:44:37 INFO - PID 22394 | RSS: Main: 204873728 03:44:37 INFO - PID 22394 | 03:44:40 INFO - PID 22394 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48782/tests/kraken/driver.html?testName=imaging-darkroom) 03:44:41 INFO - PID 22394 | RSS: Main: 208478208 03:44:41 INFO - PID 22394 | 03:44:45 INFO - PID 22394 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48782/tests/kraken/driver.html?testName=imaging-desaturate) 03:44:45 INFO - PID 22394 | RSS: Main: 207605760 03:44:45 INFO - PID 22394 | 03:44:48 INFO - PID 22394 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48782/tests/kraken/driver.html?testName=json-parse-financial) 03:44:49 INFO - PID 22394 | RSS: Main: 208637952 03:44:49 INFO - PID 22394 | 03:44:50 INFO - PID 22394 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48782/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:44:51 INFO - PID 22394 | RSS: Main: 208965632 03:44:51 INFO - PID 22394 | 03:44:53 INFO - PID 22394 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:44:53 INFO - PID 22394 | RSS: Main: 205312000 03:44:53 INFO - PID 22394 | 03:44:55 INFO - PID 22394 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:44:56 INFO - PID 22394 | RSS: Main: 206327808 03:44:56 INFO - PID 22394 | 03:44:59 INFO - PID 22394 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:44:59 INFO - PID 22394 | RSS: Main: 206057472 03:44:59 INFO - PID 22394 | 03:45:02 INFO - PID 22394 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:45:03 INFO - PID 22394 | RSS: Main: 206274560 03:45:03 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48782/tests/kraken/driver.html?testName=ai-astar) 03:45:05 INFO - PID 22394 | RSS: Main: 207269888 03:45:05 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | __start_tp_report 03:45:05 INFO - PID 22394 | _x_x_mozilla_page_load 03:45:05 INFO - PID 22394 | _x_x_mozilla_page_load_details 03:45:05 INFO - PID 22394 | |i|pagename|runs| 03:45:05 INFO - PID 22394 | |0;ai-astar;110;113;108;110;110;117;110;122;116;108 03:45:05 INFO - PID 22394 | |1;audio-beat-detection;126;122;118;117;117;123;124;131;123;119 03:45:05 INFO - PID 22394 | |2;audio-dft;161;172;170;162;170;169;166;163;165;162 03:45:05 INFO - PID 22394 | |3;audio-fft;77;83;86;73;79;78;77;77;80;77 03:45:05 INFO - PID 22394 | |4;audio-oscillator;81;80;82;84;81;80;82;84;80;89 03:45:05 INFO - PID 22394 | |5;imaging-gaussian-blur;122;115;119;119;113;123;114;113;117;115 03:45:05 INFO - PID 22394 | |6;imaging-darkroom;151;155;147;159;149;150;151;151;151;147 03:45:05 INFO - PID 22394 | |7;imaging-desaturate;94;96;94;95;104;99;95;94;94;95 03:45:05 INFO - PID 22394 | |8;json-parse-financial;54;53;54;55;62;56;55;54;59;54 03:45:05 INFO - PID 22394 | |9;json-stringify-tinderbox;42;45;39;38;39;38;42;43;38;38 03:45:05 INFO - PID 22394 | |10;stanford-crypto-aes;75;78;73;74;74;75;83;79;80;84 03:45:05 INFO - PID 22394 | |11;stanford-crypto-ccm;115;112;121;117;117;121;122;124;118;117 03:45:05 INFO - PID 22394 | |12;stanford-crypto-pbkdf2;171;179;178;175;173;179;182;169;175;170 03:45:05 INFO - PID 22394 | |13;stanford-crypto-sha256-iterative;68;67;67;65;68;63;64;69;71;65 03:45:05 INFO - PID 22394 | __end_tp_report 03:45:05 INFO - PID 22394 | __start_cc_report 03:45:05 INFO - PID 22394 | _x_x_mozilla_cycle_collect,771 03:45:05 INFO - PID 22394 | __end_cc_report 03:45:05 INFO - PID 22394 | __startTimestamp1505731505617__endTimestamp 03:45:05 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | ------- Summary: start ------- 03:45:05 INFO - PID 22394 | Number of tests: 14 03:45:05 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | [#0] ai-astar Cycles:10 Average:112.40 Median:111.50 stddev:4.58 (4.1%) stddev-sans-first:4.77 03:45:05 INFO - PID 22394 | Values: 110.0 113.0 108.0 110.0 110.0 117.0 110.0 122.0 116.0 108.0 03:45:05 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | [#1] audio-beat-detection Cycles:10 Average:122.00 Median:123.00 stddev:4.45 (3.6%) stddev-sans-first:4.48 03:45:05 INFO - PID 22394 | Values: 126.0 122.0 118.0 117.0 117.0 123.0 124.0 131.0 123.0 119.0 03:45:05 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | [#2] audio-dft Cycles:10 Average:166.00 Median:167.50 stddev:4.00 (2.4%) stddev-sans-first:3.81 03:45:05 INFO - PID 22394 | Values: 161.0 172.0 170.0 162.0 170.0 169.0 166.0 163.0 165.0 162.0 03:45:05 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | [#3] audio-fft Cycles:10 Average:78.70 Median:78.50 stddev:3.62 (4.6%) stddev-sans-first:3.79 03:45:05 INFO - PID 22394 | Values: 77.0 83.0 86.0 73.0 79.0 78.0 77.0 77.0 80.0 77.0 03:45:05 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | [#4] audio-oscillator Cycles:10 Average:82.30 Median:82.00 stddev:2.79 (3.4%) stddev-sans-first:2.92 03:45:05 INFO - PID 22394 | Values: 81.0 80.0 82.0 84.0 81.0 80.0 82.0 84.0 80.0 89.0 03:45:05 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:118.00 stddev:3.62 (3.1%) stddev-sans-first:3.36 03:45:05 INFO - PID 22394 | Values: 122.0 115.0 119.0 119.0 113.0 123.0 114.0 113.0 117.0 115.0 03:45:05 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:3.60 (2.4%) stddev-sans-first:3.82 03:45:05 INFO - PID 22394 | Values: 151.0 155.0 147.0 159.0 149.0 150.0 151.0 151.0 151.0 147.0 03:45:05 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.00 stddev:3.20 (3.4%) stddev-sans-first:3.31 03:45:05 INFO - PID 22394 | Values: 94.0 96.0 94.0 95.0 104.0 99.0 95.0 94.0 94.0 95.0 03:45:05 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:2.80 (5.1%) stddev-sans-first:2.91 03:45:05 INFO - PID 22394 | Values: 54.0 53.0 54.0 55.0 62.0 56.0 55.0 54.0 59.0 54.0 03:45:05 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | [#9] json-stringify-tinderbox Cycles:10 Average:40.20 Median:40.50 stddev:2.57 (6.4%) stddev-sans-first:2.65 03:45:05 INFO - PID 22394 | Values: 42.0 45.0 39.0 38.0 39.0 38.0 42.0 43.0 38.0 38.0 03:45:05 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:78.50 stddev:3.92 (5.0%) stddev-sans-first:4.06 03:45:05 INFO - PID 22394 | Values: 75.0 78.0 73.0 74.0 74.0 75.0 83.0 79.0 80.0 84.0 03:45:05 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:119.50 stddev:3.60 (3.0%) stddev-sans-first:3.60 03:45:05 INFO - PID 22394 | Values: 115.0 112.0 121.0 117.0 117.0 121.0 122.0 124.0 118.0 117.0 03:45:05 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:176.50 stddev:4.36 (2.5%) stddev-sans-first:4.36 03:45:05 INFO - PID 22394 | Values: 171.0 179.0 178.0 175.0 173.0 179.0 182.0 169.0 175.0 170.0 03:45:05 INFO - PID 22394 | 03:45:05 INFO - PID 22394 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.50 stddev:2.45 (3.6%) stddev-sans-first:2.55 03:45:05 INFO - PID 22394 | Values: 68.0 67.0 67.0 65.0 68.0 63.0 64.0 69.0 71.0 65.0 03:45:05 INFO - PID 22394 | -------- Summary: end -------- 03:45:05 INFO - PID 22394 | 03:45:06 INFO - PID 22394 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:45:06 INFO - TEST-INFO | 22394: exit 0 03:45:06 INFO - TEST-OK | kraken | took 62745ms 03:45:06 INFO - SUITE-END | took 1175s 03:45:06 INFO - Completed test suite (00:19:35) 03:45:06 INFO - javascript benchmark 03:45:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8583.011180007212, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3098.411301852649, 3105.130563442236, 3133.952990705139, 3144.2296637323857, 3146.0561831450545, 6127.540434467422, 6242.1261023456755, 6295.276043255021, 6330.366963303673, 6345.8413539661415, 6168.136460895467, 6193.721282542285, 6246.687665616723, 6250.8124756257275, 6296.622202667843, 5716.0, 5773.48038676519, 5774.538036957033, 5782.45066718661, 5792.507636850873, 5850.590458667895, 5912.17229587858, 5924.792632257871, 5933.762649494015, 5964.3737407572235, 5851.590388672795, 5880.088586269135, 5915.5859089863725, 5916.112583112525, 5949.048152295633, 5279.577633789288, 5630.5495560355075, 5678.829635110953, 5885.588008839383, 5978.432048955364, 5765.769369225226, 5770.249867517238, 5838.124281357788, 5856.882862342772, 5864.032434648278, 6178.320384757673, 6275.592086514362, 6311.652859092748, 6326.43062124411, 6397.744090236385, 6655.600663960178, 6775.661216939183, 6801.0, 6802.591844489347, 6823.3858952694, 6845.315468453165, 6858.794236172923, 6921.792346229621, 6930.237673855871, 6935.3411425914455, 6283.214598175228, 6295.8740825183695, 6296.118543403927, 6358.078078678612, 6405.263394709621, 6953.89569156463, 6957.1651401831095, 7008.088948436671, 7042.647867606599, 7057.788266352018, 6413.16628838248, 6447.548671592944, 6511.73953041873, 6547.738090476423, 6599.538032337787, 6758.189017317855, 6762.222344430355, 6796.898046529306, 6810.318968103249, 6816.829579260559, 6755.831104222434, 6771.0, 6795.048693182958, 6798.796036118924, 6821.3519715626935, 6736.8989465158065, 6752.527323087336, 6770.492213084039, 6851.040854280404, 6851.45188384928, 5175.327207463006, 5247.344081989751, 5340.652857564246, 5354.3574771027725, 5384.596155288291, 4596.149712303235, 4627.884302892455, 4665.976670116627, 4719.38647975761, 4731.621470282369, 5733.455321744427, 5777.942220577825, 5790.739416726257, 5811.535077193815, 5814.883702326015, 6745.460363170934, 6789.592624442549, 6803.251642319341, 6813.727450902007, 6848.280930502226, 5582.8325150245555, 5707.200991861143, 5709.257796486513, 5733.770649173986, 5734.827955161351, 5744.253247077853, 5750.166225897222, 5766.88466230673, 5801.506871915934, 5806.738696758656, 6453.193350831146, 6491.285958544557, 6581.440577550962, 6592.208934927743, 6643.7674681385915, 6767.323267673193, 6780.084688566981, 6810.931890681129, 6844.315568443116, 6860.211075726355, 6522.05430212607, 6541.378569035934, 6610.933890661032, 6618.90071648916, 6624.072629831731, 6454.838629034311, 6616.569922954993, 6626.0392243123515, 6631.801045968628, 6770.593764374154, 6710.127683401127, 6711.0, 6742.831429214309, 6760.898586521108, 6761.628110453972, 6421.0, 6504.447121994684, 6506.121673574196, 6615.702293396905, 6620.536562440583, 6532.314107018885, 6532.738690452519, 6603.570767900071, 6648.069270302259, 6651.33486651331, 6316.715747791269, 6425.710843012169, 6485.77299794505, 6538.934610654022, 6565.0, 6498.772542960974, 6545.509086818603, 6566.737330506726, 6582.506312026713, 6599.835004124935, 6337.493000560036, 6340.9048864268, 6340.9048864268, 6362.586431882098, 6380.234371875405], "value": 6145.4274608634405, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.8150703077744, 773.0645918438696, 795.4272923495083, 809.8218391953772, 810.5460941872552, 40945.79527102364, 41575.16849663005, 41640.58359416401, 41762.79118604403, 41782.58217417825, 37147.62852371475, 37424.438633420454, 37495.06262343443, 37759.0, 37769.62230377695, 6905.620190889512, 6936.861262774767, 6952.200496942841, 6965.930340696579, 7043.366097051265, 6885.621290829003, 6969.0, 6978.406835418996, 6992.6853291602, 6996.475264355168, 6922.965385173092, 6954.791356259295, 7611.885821712651, 7839.6472158752995, 7855.607219638995, 7656.693732250703, 7709.38324934004, 7717.382609391263, 7718.922810771876, 7729.768106956744, 7577.393808495307, 7640.426967977424, 7645.923540764632, 7650.961745191294, 7662.693492260303, 37342.62657373419, 37688.0, 37716.62283377159, 37771.0, 37822.0, 3463.1342164458883, 3476.0093373388463, 3501.4747787831775, 3503.1592417819793, 3504.54440922681, 31253.843730781202, 31265.687343126505, 31479.37041259185, 31591.684083159103, 31626.0, 5139.537441630271, 5149.3305870237, 5173.17229243323, 5201.609879259071, 5247.580193584504, 181724.0, 182749.0862545692, 182840.0, 183098.0, 183266.0, 48287.517124829006, 48320.75839620779, 48531.757341213066, 48539.271910921365, 48552.02895942061, 50694.239586406235, 50736.0, 53361.0, 55045.174322385195, 55070.44929550734, 14578.198199099152, 14601.19693416851, 14799.334029968677, 14811.88910831692, 14816.0, 11853.288802671867, 11861.11041671878, 11880.287182769061, 11922.821157682642, 11926.284422934652, 14741.92629036848, 14932.0, 14957.401703931939, 14980.0, 15048.097114172966, 5778.5377169826315, 5837.270341207349, 5996.730147143389, 6008.879822403527, 6019.819405417757, 992.9205663546899, 1027.5786927359748, 1031.7214352124884, 1037.1858091398217, 1041.6041904076403, 23830.404239893796, 23895.641565376533, 23960.161394351464, 24163.39591510191, 24254.636180457306, 1093.9935259561064, 1113.7215696075982, 1122.45560902962, 1124.8818874018111, 1128.4865386249237, 12277.938610306892, 12467.376631168405, 12499.93750031244, 12507.749845003049, 12513.49946002168, 237814.0, 238015.0, 239289.0, 241128.0, 241289.0, 44089.0, 45317.77341113339, 47106.76446617745, 47604.0, 47699.76150119297, 1309.8821106100497, 1439.330711219288, 1457.7521821290406, 1461.926903654813, 1469.6619777451247, 26705.19884403471, 27464.725352746216, 27635.723642763314, 27703.168904932885, 28028.85985570059, 38005.619943801314, 38545.22909541737, 38568.0, 38623.613763863126, 38632.80683596564, 204011.0, 205557.0, 205639.0, 205968.0, 206478.0, 34894.825525872206, 35122.297554048266, 35955.46066809052, 36039.0, 36086.27827443489, 42932.57067429286, 43864.34203486887, 44108.779456103795, 44248.33627495654, 44837.77581112074, 32221.838890805397, 32250.0, 32795.016149515555, 32924.1768955778, 33048.173795655304, 31717.524237136, 31719.0, 32201.711931523412, 32233.194170144994, 32587.674123258465, 36492.27015459729, 36733.0, 36869.26261474702, 36977.63022369849, 36992.81503592465, 30192.698073019867, 30488.84755576208, 30588.0, 31145.8442707785, 31583.842080790368, 22759.772402275765, 22990.770092299532, 23222.187223447097, 23330.650040249748, 23405.76594234104], "value": 17022.7965639207, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.4455544455546, 567.3560508822485, 569.2144840120633, 571.3229822660145, 573.5211098732558, 22101.33695989121, 23106.65340019899, 23168.65247021296, 23216.65175022374, 23218.65172022421, 22988.1954131605, 24152.154674586393, 24357.75642243577, 24388.512229755393, 24575.877120614372, 6307.873842523159, 6381.298057213703, 6437.2275326960835, 6482.7406903723795, 6510.804675859732, 6266.561340706153, 6384.744610215585, 6385.201849768779, 6394.488440924738, 6422.100905873182, 5995.910061349062, 6231.6572588507615, 6240.656763877985, 6292.465140463043, 6346.936530634704, 6311.621302721828, 6319.65241911697, 6336.20797400325, 6360.745570177188, 6367.872642547146, 5887.264091988502, 5899.823005309848, 5909.143174239711, 5923.526117910556, 6137.202163718733, 27884.721152788414, 28494.430111397654, 28666.570001449996, 28731.712682873112, 28770.280742981384, 2053.753549574046, 2095.0258129969484, 2101.243552321163, 2102.1066046930146, 2107.9578408431744, 18254.269829206816, 18706.251749929987, 18753.437396878115, 18884.811151888443, 18955.0, 2420.165043060141, 2468.4816188600416, 2479.466914613367, 2481.5781317176125, 2488.9004439822384, 122423.38788306002, 125095.3745231268, 125332.37333813273, 136056.0, 140489.2975535126, 19968.3011094611, 20465.795342046687, 20775.0, 20853.0, 21410.78589214088, 40905.0, 40996.795016025324, 41018.58981410207, 41063.0, 41098.0, 11262.267952583055, 11329.773404531863, 11426.828597571042, 11475.655730328104, 11677.0, 9430.434173949585, 9438.0, 9572.473513956798, 9639.807203856024, 9643.27675424346, 10541.262111652111, 10566.260361774755, 10666.626668066581, 10793.460326983619, 11251.381174035507, 4172.486730255024, 4177.8537751178565, 4184.665226781911, 4191.958080419217, 4420.513743488214, 964.7829238421299, 970.6214576315243, 979.588572799426, 986.7434467038622, 986.9654562090292, 18861.622767544573, 18947.810521894604, 19161.712574311397, 19428.805711942983, 19855.900720496305, 1029.577873072037, 1030.644427672452, 1046.6336782126348, 1055.382601178304, 1059.247933966892, 10682.57269709203, 10728.463576821128, 10805.459727013618, 10851.891481085246, 10884.61903833362, 483562.0, 484087.0, 487210.0, 499750.0, 507309.0, 108123.45938270258, 108697.4565127185, 112088.43955780168, 112135.4393228045, 114257.0, 1041.8853926068127, 1084.6258040975852, 1149.1266637355502, 1159.7622487390065, 1212.484694005062, 19754.308599198957, 20010.89994550076, 20394.69407958852, 20428.489287767923, 20556.897215513825, 54631.0, 54909.725451374085, 56498.43501565096, 57181.42818571761, 57586.424135758105, 68938.0, 69377.0, 69537.0, 69955.65022174857, 70059.0, 19278.807211927702, 19687.70468443003, 19795.703064454334, 19913.303034393728, 20017.899910500353, 22336.553268934204, 22397.21609743716, 22460.663090053335, 22777.88611056934, 22888.656670149627, 17844.732329014816, 18043.909780451013, 18056.45830625083, 18059.2776288947, 18252.72620910714, 14917.552473425814, 15064.096154230781, 15563.533094007198, 15903.363865445715, 16399.83600163983, 17224.483265502055, 18308.450746477625, 18345.449636510926, 18463.16915738768, 18661.533461663566, 19196.80803192006, 19219.0, 19256.903715481894, 19304.806951930303, 19524.8047519523, 17694.734578981584, 17863.821361786737, 17959.730604040687, 18076.276948921895, 18105.818941810412], "value": 12566.826841303386, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1282.4805953588798, 1350.5205651993542, 1367.5282027700443, 1367.7401293754192, 1379.413749156609, 14708.191049492287, 15218.23908804558, 15282.0, 15290.082595044305, 15308.770368444468, 15083.09501429915, 15199.6960060799, 15225.84774152261, 15253.69492610147, 15259.618509537268, 2664.773494252986, 2812.02984970185, 2819.8026138170335, 2829.759470445015, 2829.985850070747, 2770.598263251827, 2777.6389069421048, 2786.0109661070333, 2794.3153927287844, 2794.776417886564, 2695.3935364542917, 2696.6763988321427, 2697.1234348836706, 2711.3357227479296, 2717.7689896358834, 2617.803664725144, 2627.0673910761693, 2660.827046241998, 2661.108528642907, 2665.720099389575, 2566.0, 2590.5596048671773, 2609.9478010439684, 2610.673665791776, 2619.6594442722326, 14524.564263072125, 14730.116193028452, 14795.926020369938, 14801.555953321418, 14803.55589332311, 7868.685252589889, 8168.142345053743, 8182.059063207747, 8182.140875208136, 8185.058718247418, 5203.4796520348045, 5366.114591092465, 5417.726834193962, 5595.440455954413, 5608.355039170507, 1875.5217419557925, 1881.313320637971, 1894.7063205203078, 1916.7699876014829, 1947.5423275530238, 23858.16496422617, 24870.0, 24873.766410366716, 25894.352641183934, 26617.733822661718, 7243.261617211831, 7348.853022939511, 7359.080114985627, 7425.888611670829, 7544.622768861535, 19949.501262468555, 20046.09792559338, 20060.69908951367, 20109.798902011084, 20211.0, 8330.125336839666, 8330.250277475056, 8391.328693704489, 8406.411551191359, 8454.15458454162, 7368.0, 7584.355329796918, 7607.581583012877, 7622.0, 7686.57723825195, 5478.986387518242, 5565.1374037024325, 5569.944300556943, 5641.266635337462, 5685.232493613392, 1738.8695847811464, 1778.084286592406, 1779.24382137591, 1793.2020250988185, 1796.1019490254873, 853.2875049333752, 864.3301441382979, 881.3213825354442, 886.6763631274538, 888.9777755556033, 8349.791255218668, 8484.915150848412, 8538.146185381413, 8588.355873309527, 8646.092160323202, 675.5507587454387, 715.5742333311671, 717.3149642091789, 720.218562859293, 721.8556288742168, 4776.259679749644, 4826.300186472942, 4859.829905953275, 4889.997550502138, 4926.6551341406475, 20623.58752824935, 20770.688439673417, 21562.245321413677, 21778.34664960054, 21964.341069767932, 21217.0, 21679.506856711363, 21714.782852171593, 21811.67282490764, 22153.889230553745, 10800.45997700112, 11198.944005280084, 11228.66314010581, 11321.603743868925, 11415.885841141648, 8522.914770852212, 8527.91472085296, 8570.4000719949, 8639.568021599021, 8724.214820666171, 17594.120293985507, 18344.449666510027, 18446.723299150253, 18597.163127659016, 18636.16137273853, 18452.446426607225, 19093.809061909204, 19539.70690439616, 19898.0, 20013.199472020955, 12150.817737734118, 12352.197107188003, 12382.133250672367, 12386.876131238572, 12391.75216495683, 13958.371873265525, 14019.859801401855, 14116.717665646835, 14185.36165872559, 14256.786148207993, 11227.943860280646, 11540.711482213012, 11731.23746956445, 11752.23610465317, 11984.40077996114, 11098.833517497405, 11312.038476729242, 11367.658970230576, 11431.42842857837, 11490.88509114898, 9740.318177727491, 9950.253730970062, 9953.950230248802, 9958.302918795614, 9980.0, 6969.860602788017, 7007.684654190675, 7081.539699919489, 7191.640417979184, 7309.488335816442, 6971.163460384786, 7178.353948144483, 7306.853862922818, 7397.149327827368, 7412.703491860265], "value": 6726.254589950474, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.744675322079, 508.3188527373321, 509.54904909155397, 515.9071367153913, 517.6945602094764, 6125.326214116443, 6193.349698281678, 6194.225721784777, 6227.314995350508, 6270.184875966123, 6005.699715014242, 6123.724432400541, 6148.907766383508, 6178.845528861781, 6222.471089957359, 5060.089183946879, 5110.821121260757, 5178.042062218502, 5180.3265575475325, 5181.455947125554, 5077.669951453144, 5114.974425127869, 5153.407358153804, 5174.896502069956, 5195.324607800981, 4691.4604820445575, 4886.534039788067, 4891.070696567658, 4920.655554111196, 5100.795968161269, 4878.170710979142, 4909.337239472661, 4909.607231421478, 4926.433460152057, 4936.851894443173, 4341.674374421931, 4345.47854257488, 4356.194104090753, 4388.363687265329, 4412.514623391425, 5822.330432000332, 5931.288245410536, 5951.196588460546, 6026.879462410771, 6087.9650459422, 5621.128725047624, 5622.550195984311, 5653.9151912721345, 5661.943380566224, 5678.801241956512, 6474.773382931622, 6489.4483968862705, 6514.804555863332, 6557.5081868860025, 6599.5380323377385, 4578.816847326103, 4801.495842936476, 4814.711117332971, 4827.275908613736, 4837.879053023667, 6604.14146160996, 6604.93395066048, 6633.734650613969, 6779.830504237433, 6811.795646130624, 4863.221884498464, 4928.802847886044, 4941.25881117828, 4948.579370753454, 4992.2511623256805, 5005.449400565934, 5006.499350064964, 5022.9748851256245, 5026.4973502649445, 5067.3412456381175, 5644.125160600113, 5658.632188907708, 5669.489745922887, 5680.517156041783, 5700.429957004267, 6605.306442823435, 6619.172603424572, 6624.867502650017, 6629.86740265192, 6665.966670166715, 1722.2938595175917, 1742.912854357277, 1746.97379539307, 1765.7727879123886, 1771.070188151231, 1158.9337809215374, 1177.7408970026581, 1199.4122879789015, 1210.8002179640437, 1213.9575114870938, 5474.315710536183, 5498.862528436741, 5520.66875987442, 5567.164925261162, 5597.888042239132, 6484.859996201242, 6550.2794692583775, 6601.471882249409, 6632.2704502504685, 6721.82368085583, 5602.383737788921, 5619.494245517923, 5636.436356364331, 5645.604807663506, 5679.2333035040565, 3474.3051389722154, 3476.331360946709, 3509.0, 3521.859125634946, 3539.150603855056, 6216.844578885564, 6269.435750782361, 6312.400321969406, 6373.649449280334, 6462.773802916875, 6619.338066193439, 6644.534882558174, 6731.865362692719, 6765.830854228684, 6791.966040169767, 6315.621062736159, 6373.808785736435, 6381.521385896076, 6383.265924418658, 6425.710843012076, 6068.514518838394, 6510.3489651034515, 6551.639659818756, 6570.244421891352, 6627.039079333374, 6353.7140828661895, 6378.553501254868, 6415.6471394071905, 6474.967625161844, 6482.837929051811, 6201.441870231701, 6240.344763799736, 6246.46905013079, 6268.592541484789, 6269.592476489013, 4833.559052678375, 4886.218205087169, 4886.560209581155, 4919.532644398776, 4958.8760280993265, 6346.809595712136, 6539.378759017885, 6555.147830781968, 6666.533342665967, 6670.366315200048, 6288.434040936155, 6300.621962682254, 6426.4216220540375, 6463.741450341934, 6489.448396886318, 6356.713947872449, 6367.42693157618, 6384.585001974857, 6459.644719540471, 6477.8704425912165, 6163.568550201443, 6183.350748171557, 6284.371562843862, 6295.213098362705, 6307.779227727007, 6416.390442907917, 6430.2605200400685, 6455.580387274812, 6514.771982980573, 6533.0, 6190.380961903774, 6249.18786546047, 6270.153529273673, 6301.6219026858535, 6305.369463053658], "value": 4977.243161729538, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [914.6890057380491, 920.8020275640736, 926.6015613286288, 933.9906600933997, 941.7410212191648, 19216.615667686656, 20391.184352625914, 20515.794842051593, 20551.0, 20566.48583785406, 17759.0, 17865.0, 17999.910000449978, 18041.7293740594, 18053.638927221447, 932.659579253571, 947.8483442649177, 952.4618590496382, 955.4840386191448, 964.4213471916829, 981.3425005246467, 983.965561205358, 986.8717066781309, 987.4272921705393, 991.5934466868586, 929.7768535551453, 1029.474967766437, 1032.7418145463635, 1038.870141232346, 1044.660485342263, 1026.7227848480943, 1028.1363654530194, 1029.135526158027, 1030.2221822523945, 1030.706248719119, 719.6365835253216, 755.5957562703927, 758.9279018493289, 762.142589586715, 762.881753328235, 20133.295334663362, 20401.591968160552, 20444.693329600068, 20522.486937826674, 20577.588448230952, 22026.0, 22066.66899996485, 22682.546349072927, 22736.54526909469, 22852.314430566945, 17029.65940681192, 17085.2311645975, 17194.74207886883, 17559.385421510313, 17743.757936944417, 3701.6298370163036, 3725.6833169180654, 3737.289914916157, 3738.345789486856, 3741.363968125398, 100381.0, 141961.0, 143094.28452857773, 143808.0, 144138.0, 16641.334346625998, 16864.32542698303, 16894.662106757794, 16969.15154242283, 17010.659786804194, 30591.69408305933, 31977.20056998547, 32111.03666889997, 32156.19609509734, 32354.0, 8932.285417166611, 9062.0, 9085.409448385833, 9139.314551408672, 9192.81614367709, 4293.355996600535, 4313.633341165973, 4359.346098085249, 4391.14372697321, 4391.6486681065435, 5540.196671482693, 5554.444555544494, 5578.470045345767, 5594.972025139929, 5597.468240517144, 1089.8692156941217, 1112.193659596786, 1115.0466351269547, 1115.1413411672966, 1119.9776004479866, 699.6396855619361, 706.1138271469273, 719.1837264704598, 723.2369849808398, 723.5767076260447, 12010.63968080959, 12234.877651223553, 12568.74862502763, 12847.743045139232, 12968.935155324163, 673.0745225315192, 674.5547938360756, 684.6679360510149, 693.826543364159, 695.1449716848305, 5471.388449623576, 5478.589105817, 5566.248556444909, 5612.887742245132, 5671.716414179275, 120278.0, 127854.36072819577, 128123.35938320249, 128599.0, 130428.0, 107623.0, 111375.4431227855, 112269.43865280622, 112382.0, 114980.0, 97318.51340743393, 97555.0, 100824.99175008303, 102494.97505025004, 103027.0, 10447.895521044693, 10542.103921166787, 10604.8939510607, 10608.257421980386, 10738.677839664822, 44625.33062004008, 45695.543044570455, 46152.30771538363, 46153.307700385194, 46836.29745553888, 57326.0, 58993.410065900505, 59134.40865591289, 60695.69652151711, 60997.39002609917, 15985.280662369989, 16035.919820400823, 16045.0, 16153.67692646164, 16194.109323987293, 16948.0, 17057.14714264257, 17145.05702186392, 17352.39266625662, 17564.82435175683, 15246.161461119746, 15455.304511297243, 15520.068795871832, 15594.766078509057, 15783.763243551586, 16831.579210519347, 16880.409185678443, 16933.0, 16984.66030679404, 17239.482815515556, 15977.360905564112, 16072.839271607134, 16082.115483648511, 16179.75730364069, 16209.918950405172, 11549.6535103947, 11607.245529040585, 11668.70828229301, 12106.576269830513, 12157.817632735692, 12235.510579577074, 12251.264924104582, 12297.50809967627, 12315.93842030784, 12500.499980000699], "value": 9083.233909872799, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1459.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 108.0, 110.0, 110.0, 117.0, 110.0, 122.0, 116.0, 108.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 122.0, 118.0, 117.0, 117.0, 123.0, 124.0, 131.0, 123.0, 119.0], "value": 122.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 172.0, 170.0, 162.0, 170.0, 169.0, 166.0, 163.0, 165.0, 162.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 83.0, 86.0, 73.0, 79.0, 78.0, 77.0, 77.0, 80.0, 77.0], "value": 78.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 82.0, 84.0, 81.0, 80.0, 82.0, 84.0, 80.0, 89.0], "value": 82.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 115.0, 119.0, 119.0, 113.0, 123.0, 114.0, 113.0, 117.0, 115.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 155.0, 147.0, 159.0, 149.0, 150.0, 151.0, 151.0, 151.0, 147.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 95.0, 104.0, 99.0, 95.0, 94.0, 94.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 55.0, 62.0, 56.0, 55.0, 54.0, 59.0, 54.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 45.0, 39.0, 38.0, 39.0, 38.0, 42.0, 43.0, 38.0, 38.0], "value": 40.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 73.0, 74.0, 74.0, 75.0, 83.0, 79.0, 80.0, 84.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 121.0, 117.0, 117.0, 121.0, 122.0, 124.0, 118.0, 117.0], "value": 118.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 179.0, 178.0, 175.0, 173.0, 179.0, 182.0, 169.0, 175.0, 170.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 65.0, 68.0, 63.0, 64.0, 69.0, 71.0, 65.0], "value": 66.7, "unit": "score"}]}]} 03:45:06 INFO - Return code: 0 03:45:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:45:06 INFO - # TBPL SUCCESS # 03:45:06 INFO - Running post-action listener: _package_coverage_data 03:45:06 INFO - Running post-action listener: _resource_record_post_action 03:45:06 INFO - [mozharness: 2017-09-18 10:45:06.890013Z] Finished run-tests step (success) 03:45:06 INFO - Running post-run listener: _resource_record_post_run 03:45:06 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 347070464; Read time: 8; Write time: 185908 03:45:06 INFO - TinderboxPrint: CPU usage
13.3% 03:45:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:45:06 INFO - TinderboxPrint: I/O write bytes / time
347,070,464 / 185,908 03:45:06 INFO - TinderboxPrint: CPU idle
8,253.4 (86.7%) 03:45:06 INFO - TinderboxPrint: CPU user
1,201.3 (12.6%) 03:45:06 INFO - TinderboxPrint: Swap in / out
0 / 0 03:45:06 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 13053952; Read time: 0; Write time: 2364 03:45:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:45:06 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 334016512; Read time: 8; Write time: 183544 03:45:07 INFO - Running post-run listener: _upload_blobber_files 03:45:07 INFO - Blob upload gear active. 03:45:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:45:07 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:45:07 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:45:07 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:45:07 INFO - (blobuploader) - INFO - Open directory for files ... 03:45:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:45:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:45:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:09 INFO - (blobuploader) - INFO - Done attempting. 03:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:45:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:09 INFO - (blobuploader) - INFO - Done attempting. 03:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:45:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:11 INFO - (blobuploader) - INFO - Done attempting. 03:45:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:45:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:45:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:18 INFO - (blobuploader) - INFO - Done attempting. 03:45:18 INFO - (blobuploader) - INFO - Iteration through files over. 03:45:18 INFO - Return code: 0 03:45:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:45:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:45:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d165b8c1eaa0687dfd7ea9941e51ae98fe7d306453d7743fba960c8090e21f0f5df07a7d8c2f9482ea6ce49ad9c14eaad07cb4cb57cbfec6b5c0f470206cdae3", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d71dc851c43d0988efa0e50db0051e918725707106a3480db6dcea5bc7a2d563e997166d8c73f64064974101fef6eeed77631a5fd82136c89ff2136c1d75a5a1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e488cb178ed1f8fce431cfa127079d5acee9777889afd649a0a771a14b2dc6af39cd6c3f397dc04b2e68330fbbad7c336c42c52ac4ba8c8cdc5a908176b7401", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7bd2b8f17e18c5eaffab8bb123e2511c0503d129542da026c6f89048694b963ef0431b28232b64f0d2be4bec25a59196a96698689c154c95f3e5cf75f932947"} 03:45:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:45:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:45:18 INFO - Contents: 03:45:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d165b8c1eaa0687dfd7ea9941e51ae98fe7d306453d7743fba960c8090e21f0f5df07a7d8c2f9482ea6ce49ad9c14eaad07cb4cb57cbfec6b5c0f470206cdae3", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d71dc851c43d0988efa0e50db0051e918725707106a3480db6dcea5bc7a2d563e997166d8c73f64064974101fef6eeed77631a5fd82136c89ff2136c1d75a5a1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e488cb178ed1f8fce431cfa127079d5acee9777889afd649a0a771a14b2dc6af39cd6c3f397dc04b2e68330fbbad7c336c42c52ac4ba8c8cdc5a908176b7401", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7bd2b8f17e18c5eaffab8bb123e2511c0503d129542da026c6f89048694b963ef0431b28232b64f0d2be4bec25a59196a96698689c154c95f3e5cf75f932947"} 03:45:18 INFO - Running post-run listener: copy_logs_to_upload_dir 03:45:18 INFO - Copying logs to upload dir... 03:45:18 INFO - mkdir: /builds/slave/test/build/upload/logs 03:45:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.122583 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-18 03:45:18.518654) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 03:45:18.522615) ========= 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=3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d165b8c1eaa0687dfd7ea9941e51ae98fe7d306453d7743fba960c8090e21f0f5df07a7d8c2f9482ea6ce49ad9c14eaad07cb4cb57cbfec6b5c0f470206cdae3", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d71dc851c43d0988efa0e50db0051e918725707106a3480db6dcea5bc7a2d563e997166d8c73f64064974101fef6eeed77631a5fd82136c89ff2136c1d75a5a1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e488cb178ed1f8fce431cfa127079d5acee9777889afd649a0a771a14b2dc6af39cd6c3f397dc04b2e68330fbbad7c336c42c52ac4ba8c8cdc5a908176b7401", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7bd2b8f17e18c5eaffab8bb123e2511c0503d129542da026c6f89048694b963ef0431b28232b64f0d2be4bec25a59196a96698689c154c95f3e5cf75f932947"} build_url:https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011485 build_url: 'https://queue.taskcluster.net/v1/task/L5VTY1pKRgOdH0QnkhRnug/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d165b8c1eaa0687dfd7ea9941e51ae98fe7d306453d7743fba960c8090e21f0f5df07a7d8c2f9482ea6ce49ad9c14eaad07cb4cb57cbfec6b5c0f470206cdae3", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d71dc851c43d0988efa0e50db0051e918725707106a3480db6dcea5bc7a2d563e997166d8c73f64064974101fef6eeed77631a5fd82136c89ff2136c1d75a5a1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e488cb178ed1f8fce431cfa127079d5acee9777889afd649a0a771a14b2dc6af39cd6c3f397dc04b2e68330fbbad7c336c42c52ac4ba8c8cdc5a908176b7401", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7bd2b8f17e18c5eaffab8bb123e2511c0503d129542da026c6f89048694b963ef0431b28232b64f0d2be4bec25a59196a96698689c154c95f3e5cf75f932947"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 03:45:18.551287) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:45:18.551622) ========= 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=3297cc2eebb5444a7688c33f000001b5-1505713358.640106-1256154892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:45:18.636459) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 03:45:18.636821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 03:45:18.637263) ========= ========= Total master_lag: 0.24 =========