builder: cedar_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-071 starttime: 1500304363.63 results: success (0) revision: 1738106d39b8e04c566a879931ff18ce6412b57d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 08:12:43.625741) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 08:12:43.626430) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 08:12:43.626725) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 08:12:43.690350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 08:12:43.690669) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-17 08:12:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2017-07-17 08:12:44 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.231012 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 08:12:43.934527) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 08:12:43.934836) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020019 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 08:12:43.987538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 08:12:43.987852) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 1738106d39b8e04c566a879931ff18ce6412b57d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/cedar --rev 1738106d39b8e04c566a879931ff18ce6412b57d --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=dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-17 08:12:44,414 truncating revision to first 12 chars 2017-07-17 08:12:44,414 Setting DEBUG logging. 2017-07-17 08:12:44,414 attempt 1/10 2017-07-17 08:12:44,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/1738106d39b8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-17 08:12:44,829 unpacking tar archive at: cedar-1738106d39b8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.725054 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 08:12:44.727860) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 08:12:44.731170) ========= script_repo_revision: 1738106d39b8e04c566a879931ff18ce6412b57d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 08:12:44.731541) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 08:12:44.731803) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 08:12:44.746807) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-07-17 08:12:44.747090) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:12:45 INFO - MultiFileLogger online at 20170717 08:12:45 in /builds/slave/test 08:12:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 08:12:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:12:45 INFO - {'append_to_log': False, 08:12:45 INFO - 'base_work_dir': '/builds/slave/test', 08:12:45 INFO - 'blob_upload_branch': 'Cedar', 08:12:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:12:45 INFO - 'branch': 'Cedar', 08:12:45 INFO - 'buildbot_json_path': 'buildprops.json', 08:12:45 INFO - 'code_coverage': False, 08:12:45 INFO - 'config_files': ('talos/linux_config.py',), 08:12:45 INFO - 'default_actions': ('clobber', 08:12:45 INFO - 'read-buildbot-config', 08:12:45 INFO - 'download-and-extract', 08:12:45 INFO - 'populate-webroot', 08:12:45 INFO - 'create-virtualenv', 08:12:45 INFO - 'install', 08:12:45 INFO - 'setup-mitmproxy', 08:12:45 INFO - 'run-tests'), 08:12:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:12:45 INFO - 'disable_ccov_upload': False, 08:12:45 INFO - 'download_minidump_stackwalk': True, 08:12:45 INFO - 'download_symbols': 'ondemand', 08:12:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:12:45 INFO - 'tooltool.py': '/tools/tooltool.py', 08:12:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:12:45 INFO - '/tools/misc-python/virtualenv.py')}, 08:12:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:12:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:12:45 INFO - 'gecko_profile': False, 08:12:45 INFO - 'gecko_profile_interval': 0, 08:12:45 INFO - 'installer_path': 'installer.exe', 08:12:45 INFO - 'log_level': 'info', 08:12:45 INFO - 'log_name': 'talos', 08:12:45 INFO - 'log_to_console': True, 08:12:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:12:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:12:45 INFO - 'opt_config_files': (), 08:12:45 INFO - 'pip_index': False, 08:12:45 INFO - 'suite': 'dromaeojs-e10s', 08:12:45 INFO - 'system_bits': '32', 08:12:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:12:45 INFO - 'title': 'talos-linux64-ix-071', 08:12:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:12:45 INFO - 'use_talos_json': True, 08:12:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:12:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:12:45 INFO - 'work_dir': 'build'} 08:12:45 INFO - [mozharness: 2017-07-17 15:12:45.279254Z] Running clobber step. 08:12:45 INFO - Running pre-action listener: _resource_record_pre_action 08:12:45 INFO - Running main action method: clobber 08:12:45 INFO - rmtree: /builds/slave/test/build 08:12:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:12:46 INFO - Running post-action listener: _resource_record_post_action 08:12:46 INFO - [mozharness: 2017-07-17 15:12:46.823054Z] Finished clobber step (success) 08:12:46 INFO - [mozharness: 2017-07-17 15:12:46.823157Z] Running read-buildbot-config step. 08:12:46 INFO - Running pre-action listener: _resource_record_pre_action 08:12:46 INFO - Running main action method: read_buildbot_config 08:12:46 INFO - Using buildbot properties: 08:12:46 INFO - { 08:12:46 INFO - "project": "", 08:12:46 INFO - "product": "firefox", 08:12:46 INFO - "who": "mconley@mozilla.com", 08:12:46 INFO - "installer_path": "public/build/target.tar.bz2", 08:12:46 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs-e10s", 08:12:46 INFO - "repository": "https://hg.mozilla.org/projects/cedar/", 08:12:46 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs-e10s", 08:12:46 INFO - "stage_platform": "linux64", 08:12:46 INFO - "basedir": "/builds/slave/test", 08:12:46 INFO - "buildnumber": 6, 08:12:46 INFO - "platform": "ubuntu64_hw", 08:12:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:12:46 INFO - "slavebuilddir": "test", 08:12:46 INFO - "taskId": "eJmhdTKbST-KZlsLPDgDBQ", 08:12:46 INFO - "branch": "cedar", 08:12:46 INFO - "script_repo_revision": "default", 08:12:46 INFO - "revision": "1738106d39b8e04c566a879931ff18ce6412b57d", 08:12:46 INFO - "slavename": "talos-linux64-ix-071", 08:12:46 INFO - "repo_path": "projects/cedar" 08:12:46 INFO - } 08:12:46 INFO - Finding installer, test and symbols from parent task. 08:12:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eJmhdTKbST-KZlsLPDgDBQ'}, attempt #1 08:12:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eJmhdTKbST-KZlsLPDgDBQ'}, attempt #1 08:12:47 INFO - Task dependencies: ayuRFLoYT6GffaIWWJf5NQ 08:12:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ'}, attempt #1 08:12:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.tar.bz2 08:12:48 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/test_packages.json 08:12:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.crashreporter-symbols.zip 08:12:48 INFO - Running post-action listener: _resource_record_post_action 08:12:48 INFO - [mozharness: 2017-07-17 15:12:48.168406Z] Finished read-buildbot-config step (success) 08:12:48 INFO - [mozharness: 2017-07-17 15:12:48.168628Z] Running download-and-extract step. 08:12:48 INFO - Running pre-action listener: _resource_record_pre_action 08:12:48 INFO - Running main action method: download_and_extract 08:12:48 INFO - mkdir: /builds/slave/test/build/tests 08:12:48 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')]} 08:12:48 INFO - trying https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.test_packages.json 08:12:48 INFO - Downloading https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:12:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:12:48 INFO - Downloaded 989 bytes. 08:12:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:12:48 INFO - Using the following test package requirements: 08:12:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:12:48 INFO - u'common': [u'target.common.tests.zip'], 08:12:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:12:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:12:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:12:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:12:48 INFO - u'mozbase': [u'target.common.tests.zip'], 08:12:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:12:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:12:48 INFO - u'web-platform': [u'target.common.tests.zip', 08:12:48 INFO - u'target.web-platform.tests.tar.gz'], 08:12:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:12:48 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:12:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.common.tests.zip 08:12:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:12:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.common.tests.zip into memory 08:12:49 INFO - Content-Length response header: 72769147 08:12:50 INFO - Bytes received: 72769147 08:13:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:13:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.common.tests.zip 08:13:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:13:01 INFO - Fetch https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.common.tests.zip into memory 08:13:02 INFO - Content-Length response header: 72769147 08:13:02 INFO - Bytes received: 72769147 08:13:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.talos.tests.zip 08:13:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:13:14 INFO - Fetch https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.talos.tests.zip into memory 08:13:15 INFO - Content-Length response header: 14495033 08:13:15 INFO - Bytes received: 14495033 08:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:15 INFO - trying https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.tar.bz2 08:13:15 INFO - Downloading https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:13:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:13:16 INFO - Downloaded 61864088 bytes. 08:13:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.tar.bz2 08:13:16 INFO - mkdir: /builds/slave/test/properties 08:13:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:13:16 INFO - Writing to file /builds/slave/test/properties/build_url 08:13:16 INFO - Contents: 08:13:16 INFO - build_url:https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.tar.bz2 08:13:16 INFO - Running post-action listener: _resource_record_post_action 08:13:16 INFO - Running post-action listener: set_extra_try_arguments 08:13:16 INFO - [mozharness: 2017-07-17 15:13:16.666534Z] Finished download-and-extract step (success) 08:13:16 INFO - [mozharness: 2017-07-17 15:13:16.666633Z] Running populate-webroot step. 08:13:16 INFO - Running pre-action listener: _resource_record_pre_action 08:13:16 INFO - Running main action method: populate_webroot 08:13:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:13:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:13:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:13:16 INFO - '--tppagecycles', 08:13:16 INFO - '7'], 08:13:16 INFO - 'tests': ['tsvgm']}}, 08:13:16 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:13:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:13:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:13:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:13:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:13:16 INFO - 'talos_options': ['--disable-e10s'], 08:13:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:13:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:13:16 INFO - 'talos_options': ['--disable-e10s'], 08:13:16 INFO - 'tests': ['damp', 'tps']}, 08:13:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:13:16 INFO - 'tests': ['damp', 'tps']}, 08:13:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:13:16 INFO - 'tests': ['dromaeo_dom']}, 08:13:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:13:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:13:16 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:13:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:13:16 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:13:16 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:13:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:13:16 INFO - 'tests': ['a11yr', 08:13:16 INFO - 'ts_paint', 08:13:16 INFO - 'tpaint', 08:13:16 INFO - 'sessionrestore', 08:13:16 INFO - 'sessionrestore_no_auto_restore', 08:13:16 INFO - 'tabpaint']}, 08:13:16 INFO - 'other-e10s': {'tests': ['a11yr', 08:13:16 INFO - 'ts_paint', 08:13:16 INFO - 'tpaint', 08:13:16 INFO - 'sessionrestore', 08:13:16 INFO - 'sessionrestore_many_windows', 08:13:16 INFO - 'sessionrestore_no_auto_restore', 08:13:16 INFO - 'tabpaint']}, 08:13:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:13:16 INFO - 'ts_paint', 08:13:16 INFO - 'tpaint', 08:13:16 INFO - 'sessionrestore', 08:13:16 INFO - 'sessionrestore_many_windows', 08:13:16 INFO - 'sessionrestore_no_auto_restore', 08:13:16 INFO - 'tabpaint']}, 08:13:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:13:16 INFO - 'ts_paint', 08:13:16 INFO - 'tpaint', 08:13:16 INFO - 'sessionrestore', 08:13:16 INFO - 'sessionrestore_many_windows', 08:13:16 INFO - 'sessionrestore_no_auto_restore', 08:13:16 INFO - 'tabpaint']}, 08:13:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:13:16 INFO - 'tests': ['a11yr', 08:13:16 INFO - 'ts_paint', 08:13:16 INFO - 'tpaint', 08:13:16 INFO - 'sessionrestore', 08:13:16 INFO - 'sessionrestore_no_auto_restore', 08:13:16 INFO - 'tabpaint']}, 08:13:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:13:16 INFO - 'tests': ['a11yr', 08:13:16 INFO - 'ts_paint', 08:13:16 INFO - 'tpaint', 08:13:16 INFO - 'sessionrestore', 08:13:16 INFO - 'sessionrestore_no_auto_restore', 08:13:16 INFO - 'tabpaint']}, 08:13:16 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 08:13:16 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:13:16 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:13:16 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:13:16 INFO - 'talos_options': ['--mitmproxy', 08:13:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:13:16 INFO - '--firstNonBlankPaint'], 08:13:16 INFO - 'tests': ['quantum_pageload_google', 08:13:16 INFO - 'quantum_pageload_youtube', 08:13:16 INFO - 'quantum_pageload_amazon', 08:13:16 INFO - 'quantum_pageload_facebook']}, 08:13:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:13:16 INFO - 'tests': ['tsvgx', 08:13:16 INFO - 'tsvgr_opacity', 08:13:16 INFO - 'tart', 08:13:16 INFO - 'tscrollx', 08:13:16 INFO - 'cart', 08:13:16 INFO - 'tsvg_static']}, 08:13:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:13:16 INFO - 'tsvgr_opacity', 08:13:16 INFO - 'tart', 08:13:16 INFO - 'tscrollx', 08:13:16 INFO - 'cart', 08:13:16 INFO - 'tsvg_static']}, 08:13:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:13:16 INFO - 'talos_options': ['--disable-e10s'], 08:13:16 INFO - 'tests': ['tp5o']}, 08:13:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:13:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:13:16 INFO - 'talos_options': ['--disable-e10s', 08:13:16 INFO - '--xperf_path', 08:13:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:16 INFO - 'tests': ['tp5n']}, 08:13:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:13:16 INFO - 'talos_options': ['--xperf_path', 08:13:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:16 INFO - 'tests': ['tp5n']}}, 08:13:16 INFO - 'talos.zip': {'path': '', 08:13:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:13:16 INFO - Running post-action listener: _resource_record_post_action 08:13:16 INFO - [mozharness: 2017-07-17 15:13:16.681951Z] Finished populate-webroot step (success) 08:13:16 INFO - [mozharness: 2017-07-17 15:13:16.682042Z] Running create-virtualenv step. 08:13:16 INFO - Running pre-action listener: _resource_record_pre_action 08:13:16 INFO - Running main action method: create_virtualenv 08:13:16 INFO - Creating virtualenv /builds/slave/test/build/venv 08:13:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:13:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:13:16 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:13:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:13:16 INFO - Using real prefix '/usr' 08:13:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:13:17 INFO - Installing distribute.............................................................................................................................................................................................done. 08:13:19 INFO - Installing pip.................done. 08:13:19 INFO - Return code: 0 08:13:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:13:19 INFO - Reading from file tmpfile_stdout 08:13:19 INFO - Output received: 08:13:19 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:13:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:19 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 0x13501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bed00>, '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 0x16bfc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c0090>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', '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 08:13:19 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 08:13:19 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 08:13:19 INFO - Using env: {'DISPLAY': ':0', 08:13:19 INFO - 'HOME': '/home/cltbld', 08:13:19 INFO - 'LANG': 'en_US.UTF-8', 08:13:19 INFO - 'LANGUAGE': 'en_US:en', 08:13:19 INFO - 'LOGNAME': 'cltbld', 08:13:19 INFO - 'MAIL': '/var/mail/cltbld', 08:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:19 INFO - 'MOZ_NO_REMOTE': '1', 08:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:19 INFO - 'NO_EM_RESTART': '1', 08:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:19 INFO - 'PWD': '/builds/slave/test', 08:13:19 INFO - 'SHELL': '/bin/bash', 08:13:19 INFO - 'SHLVL': '1', 08:13:19 INFO - 'TERM': 'linux', 08:13:19 INFO - 'TMOUT': '86400', 08:13:19 INFO - 'USER': 'cltbld', 08:13:19 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', 08:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:19 INFO - '_': '/tools/buildbot/bin/python'} 08:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:13:19 INFO - Cleaning up... 08:13:19 INFO - Return code: 0 08:13:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:19 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 0x13501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bed00>, '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 0x16bfc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c0090>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', '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 08:13:19 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 08:13:19 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 08:13:19 INFO - Using env: {'DISPLAY': ':0', 08:13:19 INFO - 'HOME': '/home/cltbld', 08:13:19 INFO - 'LANG': 'en_US.UTF-8', 08:13:19 INFO - 'LANGUAGE': 'en_US:en', 08:13:19 INFO - 'LOGNAME': 'cltbld', 08:13:19 INFO - 'MAIL': '/var/mail/cltbld', 08:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:19 INFO - 'MOZ_NO_REMOTE': '1', 08:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:19 INFO - 'NO_EM_RESTART': '1', 08:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:19 INFO - 'PWD': '/builds/slave/test', 08:13:19 INFO - 'SHELL': '/bin/bash', 08:13:19 INFO - 'SHLVL': '1', 08:13:19 INFO - 'TERM': 'linux', 08:13:19 INFO - 'TMOUT': '86400', 08:13:19 INFO - 'USER': 'cltbld', 08:13:19 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', 08:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:19 INFO - '_': '/tools/buildbot/bin/python'} 08:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:19 INFO - Downloading/unpacking psutil>=3.1.1 08:13:19 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 08:13:19 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 08:13:19 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 08:13:19 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 08:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:13:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:21 INFO - Installing collected packages: psutil 08:13:21 INFO - Running setup.py install for psutil 08:13:21 INFO - building 'psutil._psutil_linux' extension 08:13:21 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 08:13:21 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 08:13:21 INFO - building 'psutil._psutil_posix' extension 08:13:21 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 08:13:21 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 08:13:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:21 INFO - Successfully installed psutil 08:13:21 INFO - Cleaning up... 08:13:21 INFO - Return code: 0 08:13:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:13:21 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')]} 08:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:21 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')]} 08:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:21 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 0x13501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bed00>, '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 0x16bfc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c0090>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', '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 08:13:21 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 08:13:21 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 08:13:21 INFO - Using env: {'DISPLAY': ':0', 08:13:21 INFO - 'HOME': '/home/cltbld', 08:13:21 INFO - 'LANG': 'en_US.UTF-8', 08:13:21 INFO - 'LANGUAGE': 'en_US:en', 08:13:21 INFO - 'LOGNAME': 'cltbld', 08:13:21 INFO - 'MAIL': '/var/mail/cltbld', 08:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:21 INFO - 'MOZ_NO_REMOTE': '1', 08:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:21 INFO - 'NO_EM_RESTART': '1', 08:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:21 INFO - 'PWD': '/builds/slave/test', 08:13:21 INFO - 'SHELL': '/bin/bash', 08:13:21 INFO - 'SHLVL': '1', 08:13:21 INFO - 'TERM': 'linux', 08:13:21 INFO - 'TMOUT': '86400', 08:13:21 INFO - 'USER': 'cltbld', 08:13:21 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', 08:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:21 INFO - '_': '/tools/buildbot/bin/python'} 08:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:13:21 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 08:13:21 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 08:13:21 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 08:13:21 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 08:13:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:13:23 INFO - Installing collected packages: mozsystemmonitor 08:13:23 INFO - Running setup.py install for mozsystemmonitor 08:13:23 INFO - Successfully installed mozsystemmonitor 08:13:23 INFO - Cleaning up... 08:13:23 INFO - Return code: 0 08:13:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bed00>, '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 0x16bfc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c0090>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', '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 08:13:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:13:23 INFO - Using env: {'DISPLAY': ':0', 08:13:23 INFO - 'HOME': '/home/cltbld', 08:13:23 INFO - 'LANG': 'en_US.UTF-8', 08:13:23 INFO - 'LANGUAGE': 'en_US:en', 08:13:23 INFO - 'LOGNAME': 'cltbld', 08:13:23 INFO - 'MAIL': '/var/mail/cltbld', 08:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:23 INFO - 'MOZ_NO_REMOTE': '1', 08:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:23 INFO - 'NO_EM_RESTART': '1', 08:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:23 INFO - 'PWD': '/builds/slave/test', 08:13:23 INFO - 'SHELL': '/bin/bash', 08:13:23 INFO - 'SHLVL': '1', 08:13:23 INFO - 'TERM': 'linux', 08:13:23 INFO - 'TMOUT': '86400', 08:13:23 INFO - 'USER': 'cltbld', 08:13:23 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', 08:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:23 INFO - '_': '/tools/buildbot/bin/python'} 08:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:23 INFO - Downloading/unpacking jsonschema==2.5.1 08:13:23 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 08:13:23 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 08:13:23 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 08:13:23 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 08:13:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:13:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:24 INFO - Downloading functools32-3.2.3-2.tar.gz 08:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:13:24 INFO - warning: no files found matching '*.txt' 08:13:24 INFO - no previously-included directories found matching 'build' 08:13:24 INFO - no previously-included directories found matching 'dist' 08:13:24 INFO - no previously-included directories found matching '.git*' 08:13:24 INFO - Installing collected packages: jsonschema, functools32 08:13:24 INFO - Running setup.py install for functools32 08:13:24 INFO - warning: no files found matching '*.txt' 08:13:24 INFO - no previously-included directories found matching 'build' 08:13:24 INFO - no previously-included directories found matching 'dist' 08:13:24 INFO - no previously-included directories found matching '.git*' 08:13:24 INFO - Successfully installed jsonschema functools32 08:13:24 INFO - Cleaning up... 08:13:24 INFO - Return code: 0 08:13:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bed00>, '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 0x16bfc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c0090>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', '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 08:13:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:13:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:13:24 INFO - Using env: {'DISPLAY': ':0', 08:13:24 INFO - 'HOME': '/home/cltbld', 08:13:24 INFO - 'LANG': 'en_US.UTF-8', 08:13:24 INFO - 'LANGUAGE': 'en_US:en', 08:13:24 INFO - 'LOGNAME': 'cltbld', 08:13:24 INFO - 'MAIL': '/var/mail/cltbld', 08:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:24 INFO - 'MOZ_NO_REMOTE': '1', 08:13:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:24 INFO - 'NO_EM_RESTART': '1', 08:13:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:24 INFO - 'PWD': '/builds/slave/test', 08:13:24 INFO - 'SHELL': '/bin/bash', 08:13:24 INFO - 'SHLVL': '1', 08:13:24 INFO - 'TERM': 'linux', 08:13:24 INFO - 'TMOUT': '86400', 08:13:24 INFO - 'USER': 'cltbld', 08:13:24 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', 08:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:24 INFO - '_': '/tools/buildbot/bin/python'} 08:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:13:25 INFO - Cleaning up... 08:13:25 INFO - Return code: 0 08:13:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:13:25 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')]} 08:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:25 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')]} 08:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:25 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 0x13501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bed00>, '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 0x16bfc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c0090>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', '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 08:13:25 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 08:13:25 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 08:13:25 INFO - Using env: {'DISPLAY': ':0', 08:13:25 INFO - 'HOME': '/home/cltbld', 08:13:25 INFO - 'LANG': 'en_US.UTF-8', 08:13:25 INFO - 'LANGUAGE': 'en_US:en', 08:13:25 INFO - 'LOGNAME': 'cltbld', 08:13:25 INFO - 'MAIL': '/var/mail/cltbld', 08:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:25 INFO - 'MOZ_NO_REMOTE': '1', 08:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:25 INFO - 'NO_EM_RESTART': '1', 08:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:25 INFO - 'PWD': '/builds/slave/test', 08:13:25 INFO - 'SHELL': '/bin/bash', 08:13:25 INFO - 'SHLVL': '1', 08:13:25 INFO - 'TERM': 'linux', 08:13:25 INFO - 'TMOUT': '86400', 08:13:25 INFO - 'USER': 'cltbld', 08:13:25 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', 08:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:25 INFO - '_': '/tools/buildbot/bin/python'} 08:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:25 INFO - Downloading/unpacking blobuploader==1.2.4 08:13:25 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 08:13:25 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 08:13:25 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 08:13:25 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 08:13:26 INFO - Downloading blobuploader-1.2.4.tar.gz 08:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:13:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:13:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:26 INFO - Downloading docopt-0.6.1.tar.gz 08:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:13:26 INFO - Installing collected packages: blobuploader, requests, docopt 08:13:26 INFO - Running setup.py install for blobuploader 08:13:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:13:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:13:27 INFO - Running setup.py install for requests 08:13:27 INFO - Running setup.py install for docopt 08:13:27 INFO - Successfully installed blobuploader requests docopt 08:13:27 INFO - Cleaning up... 08:13:27 INFO - Return code: 0 08:13:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:27 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')]} 08:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:27 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')]} 08:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:27 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 0x13501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bed00>, '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 0x16bfc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c0090>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', '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 08:13:27 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 08:13:27 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 08:13:27 INFO - Using env: {'DISPLAY': ':0', 08:13:27 INFO - 'HOME': '/home/cltbld', 08:13:27 INFO - 'LANG': 'en_US.UTF-8', 08:13:27 INFO - 'LANGUAGE': 'en_US:en', 08:13:27 INFO - 'LOGNAME': 'cltbld', 08:13:27 INFO - 'MAIL': '/var/mail/cltbld', 08:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:27 INFO - 'MOZ_NO_REMOTE': '1', 08:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:27 INFO - 'NO_EM_RESTART': '1', 08:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:27 INFO - 'PWD': '/builds/slave/test', 08:13:27 INFO - 'SHELL': '/bin/bash', 08:13:27 INFO - 'SHLVL': '1', 08:13:27 INFO - 'TERM': 'linux', 08:13:27 INFO - 'TMOUT': '86400', 08:13:27 INFO - 'USER': 'cltbld', 08:13:27 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', 08:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:27 INFO - '_': '/tools/buildbot/bin/python'} 08:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:27 INFO - Running setup.py (path:/tmp/pip-mei6n5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:27 INFO - Running setup.py (path:/tmp/pip-N5cyKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:27 INFO - Running setup.py (path:/tmp/pip-85iF53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:27 INFO - Running setup.py (path:/tmp/pip-m9Ogre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:28 INFO - Running setup.py (path:/tmp/pip-z1PG4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:28 INFO - Running setup.py (path:/tmp/pip-DQTAr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:28 INFO - Running setup.py (path:/tmp/pip-2davtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:28 INFO - Running setup.py (path:/tmp/pip-sCSqng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:28 INFO - Running setup.py (path:/tmp/pip-pyZLiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:28 INFO - Running setup.py (path:/tmp/pip-a2nJ_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:28 INFO - Running setup.py (path:/tmp/pip-cL7ydy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:28 INFO - Running setup.py (path:/tmp/pip-XWDk5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:28 INFO - Running setup.py (path:/tmp/pip-5FpXHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:28 INFO - Running setup.py (path:/tmp/pip-vQF1ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:28 INFO - Running setup.py (path:/tmp/pip-z_d7oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:28 INFO - Running setup.py (path:/tmp/pip-vk6suD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:28 INFO - Running setup.py (path:/tmp/pip-0fznwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:13:28 INFO - Running setup.py install for manifestparser 08:13:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:13:29 INFO - Running setup.py install for mozcrash 08:13:29 INFO - Running setup.py install for mozdebug 08:13:29 INFO - Running setup.py install for mozdevice 08:13:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:13:29 INFO - Running setup.py install for mozfile 08:13:29 INFO - Running setup.py install for mozhttpd 08:13:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:13:29 INFO - Running setup.py install for mozinfo 08:13:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:13:29 INFO - Running setup.py install for mozInstall 08:13:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:13:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:13:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:13:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:13:29 INFO - Running setup.py install for mozleak 08:13:29 INFO - Running setup.py install for mozlog 08:13:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:13:29 INFO - Running setup.py install for moznetwork 08:13:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:13:30 INFO - Running setup.py install for mozprocess 08:13:30 INFO - Running setup.py install for mozprofile 08:13:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:13:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:13:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:13:30 INFO - Running setup.py install for mozrunner 08:13:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:13:30 INFO - Running setup.py install for mozscreenshot 08:13:30 INFO - Running setup.py install for moztest 08:13:30 INFO - Running setup.py install for mozversion 08:13:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:13:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:13:30 INFO - Cleaning up... 08:13:30 INFO - Return code: 0 08:13:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:30 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 0x13501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bed00>, '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 0x16bfc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c0090>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', '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 08:13:30 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 08:13:30 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 08:13:30 INFO - Using env: {'DISPLAY': ':0', 08:13:30 INFO - 'HOME': '/home/cltbld', 08:13:30 INFO - 'LANG': 'en_US.UTF-8', 08:13:30 INFO - 'LANGUAGE': 'en_US:en', 08:13:30 INFO - 'LOGNAME': 'cltbld', 08:13:30 INFO - 'MAIL': '/var/mail/cltbld', 08:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:30 INFO - 'MOZ_NO_REMOTE': '1', 08:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:30 INFO - 'NO_EM_RESTART': '1', 08:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:30 INFO - 'PWD': '/builds/slave/test', 08:13:30 INFO - 'SHELL': '/bin/bash', 08:13:30 INFO - 'SHLVL': '1', 08:13:30 INFO - 'TERM': 'linux', 08:13:30 INFO - 'TMOUT': '86400', 08:13:30 INFO - 'USER': 'cltbld', 08:13:30 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', 08:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:30 INFO - '_': '/tools/buildbot/bin/python'} 08:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:30 INFO - Running setup.py (path:/tmp/pip-roKbVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:31 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)) 08:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:31 INFO - Running setup.py (path:/tmp/pip-jl1MyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:31 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)) 08:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:31 INFO - Running setup.py (path:/tmp/pip-tW4EZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:31 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)) 08:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:31 INFO - Running setup.py (path:/tmp/pip-1tS2Sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:31 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)) 08:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:31 INFO - Running setup.py (path:/tmp/pip-Ql3G38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:31 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)) 08:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:31 INFO - Running setup.py (path:/tmp/pip-3u5uPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:31 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)) 08:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:31 INFO - Running setup.py (path:/tmp/pip-xl2zj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:31 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)) 08:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:31 INFO - Running setup.py (path:/tmp/pip-TaUFz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:31 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)) 08:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:31 INFO - Running setup.py (path:/tmp/pip-z3Lr6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:31 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)) 08:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:31 INFO - Running setup.py (path:/tmp/pip-WZGAi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:31 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)) 08:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:31 INFO - Running setup.py (path:/tmp/pip-NQYPcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:31 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)) 08:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:31 INFO - Running setup.py (path:/tmp/pip-F1QBhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:31 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)) 08:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:31 INFO - Running setup.py (path:/tmp/pip-mANQwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:31 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)) 08:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:31 INFO - Running setup.py (path:/tmp/pip-8iP9D5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:31 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)) 08:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:31 INFO - Running setup.py (path:/tmp/pip-paqsjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:32 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)) 08:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:32 INFO - Running setup.py (path:/tmp/pip-EGWNHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:32 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)) 08:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:32 INFO - Running setup.py (path:/tmp/pip-a24URp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:32 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)) 08:13:32 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)) 08:13:32 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)) 08:13:32 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)) 08:13:32 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)) 08:13:32 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)) 08:13:32 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)) 08:13:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:33 INFO - Downloading blessings-1.6.tar.gz 08:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:13:33 INFO - Installing collected packages: blessings 08:13:33 INFO - Running setup.py install for blessings 08:13:33 INFO - Successfully installed blessings 08:13:33 INFO - Cleaning up... 08:13:33 INFO - Return code: 0 08:13:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:13:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:33 INFO - Reading from file tmpfile_stdout 08:13:33 INFO - Current package versions: 08:13:33 INFO - argparse == 1.2.1 08:13:33 INFO - blessings == 1.6 08:13:33 INFO - blobuploader == 1.2.4 08:13:33 INFO - docopt == 0.6.1 08:13:33 INFO - functools32 == 3.2.3-2 08:13:33 INFO - jsonschema == 2.5.1 08:13:33 INFO - manifestparser == 1.1 08:13:33 INFO - mozInstall == 1.13 08:13:33 INFO - mozcrash == 1.0 08:13:33 INFO - mozdebug == 0.1 08:13:33 INFO - mozdevice == 0.51 08:13:33 INFO - mozfile == 1.2 08:13:33 INFO - mozhttpd == 0.7 08:13:33 INFO - mozinfo == 0.10 08:13:33 INFO - mozleak == 0.1 08:13:33 INFO - mozlog == 3.5 08:13:33 INFO - moznetwork == 0.27 08:13:33 INFO - mozprocess == 0.25 08:13:33 INFO - mozprofile == 0.28 08:13:33 INFO - mozrunner == 6.13 08:13:33 INFO - mozscreenshot == 0.1 08:13:33 INFO - mozsystemmonitor == 0.3 08:13:33 INFO - moztest == 0.8 08:13:33 INFO - mozversion == 1.4 08:13:33 INFO - psutil == 3.1.1 08:13:33 INFO - requests == 1.2.3 08:13:33 INFO - wsgiref == 0.1.2 08:13:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:33 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 0x13501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bed00>, '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 0x16bfc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c0090>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', '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 08:13:33 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 08:13:33 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 08:13:33 INFO - Using env: {'DISPLAY': ':0', 08:13:33 INFO - 'HOME': '/home/cltbld', 08:13:33 INFO - 'LANG': 'en_US.UTF-8', 08:13:33 INFO - 'LANGUAGE': 'en_US:en', 08:13:33 INFO - 'LOGNAME': 'cltbld', 08:13:33 INFO - 'MAIL': '/var/mail/cltbld', 08:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:33 INFO - 'MOZ_NO_REMOTE': '1', 08:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:33 INFO - 'NO_EM_RESTART': '1', 08:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:33 INFO - 'PWD': '/builds/slave/test', 08:13:33 INFO - 'SHELL': '/bin/bash', 08:13:33 INFO - 'SHLVL': '1', 08:13:33 INFO - 'TERM': 'linux', 08:13:33 INFO - 'TMOUT': '86400', 08:13:33 INFO - 'USER': 'cltbld', 08:13:33 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', 08:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:33 INFO - '_': '/tools/buildbot/bin/python'} 08:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:33 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)) 08:13:33 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)) 08:13:33 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)) 08:13:33 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)) 08:13:33 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)) 08:13:33 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)) 08:13:33 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)) 08:13:33 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)) 08:13:33 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)) 08:13:33 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:13:33 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 08:13:33 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 08:13:33 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 08:13:33 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 08:13:35 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:13:35 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 08:13:35 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 08:13:35 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 08:13:35 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 08:13:35 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 08:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:13:35 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)) 08:13:35 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)) 08:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:13:35 INFO - Installing collected packages: marionette-driver, simplejson 08:13:35 INFO - Running setup.py install for marionette-driver 08:13:35 INFO - Running setup.py install for simplejson 08:13:35 INFO - building 'simplejson._speedups' extension 08:13:35 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 08:13:36 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 08:13:36 INFO - Successfully installed marionette-driver simplejson 08:13:36 INFO - Cleaning up... 08:13:36 INFO - Return code: 0 08:13:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:36 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 0x13501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bed00>, '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 0x16bfc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c0090>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', '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 08:13:36 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 08:13:36 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 08:13:36 INFO - Using env: {'DISPLAY': ':0', 08:13:36 INFO - 'HOME': '/home/cltbld', 08:13:36 INFO - 'LANG': 'en_US.UTF-8', 08:13:36 INFO - 'LANGUAGE': 'en_US:en', 08:13:36 INFO - 'LOGNAME': 'cltbld', 08:13:36 INFO - 'MAIL': '/var/mail/cltbld', 08:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:36 INFO - 'MOZ_NO_REMOTE': '1', 08:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:36 INFO - 'NO_EM_RESTART': '1', 08:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:36 INFO - 'PWD': '/builds/slave/test', 08:13:36 INFO - 'SHELL': '/bin/bash', 08:13:36 INFO - 'SHLVL': '1', 08:13:36 INFO - 'TERM': 'linux', 08:13:36 INFO - 'TMOUT': '86400', 08:13:36 INFO - 'USER': 'cltbld', 08:13:36 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', 08:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:36 INFO - '_': '/tools/buildbot/bin/python'} 08:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:13:36 INFO - Cleaning up... 08:13:36 INFO - Return code: 0 08:13:36 INFO - Running post-action listener: _resource_record_post_action 08:13:36 INFO - Running post-action listener: _start_resource_monitoring 08:13:36 INFO - Starting resource monitoring. 08:13:36 INFO - [mozharness: 2017-07-17 15:13:36.791435Z] Finished create-virtualenv step (success) 08:13:36 INFO - [mozharness: 2017-07-17 15:13:36.791901Z] Running install step. 08:13:36 INFO - Running pre-action listener: _resource_record_pre_action 08:13:36 INFO - Running main action method: install 08:13:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:37 INFO - Reading from file tmpfile_stdout 08:13:37 INFO - Detecting whether we're running mozinstall >=1.0... 08:13:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:13:37 INFO - Reading from file tmpfile_stdout 08:13:37 INFO - Output received: 08:13:37 INFO - Usage: mozinstall [options] installer 08:13:37 INFO - Options: 08:13:37 INFO - -h, --help show this help message and exit 08:13:37 INFO - -d DEST, --destination=DEST 08:13:37 INFO - Directory to install application into. [default: 08:13:37 INFO - "/builds/slave/test"] 08:13:37 INFO - --app=APP Application being installed. [default: firefox] 08:13:37 INFO - mkdir: /builds/slave/test/build/application 08:13:37 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'] 08:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:13:55 INFO - Reading from file tmpfile_stdout 08:13:55 INFO - Output received: 08:13:55 INFO - /builds/slave/test/build/application/firefox/firefox 08:13:55 INFO - Running post-action listener: _resource_record_post_action 08:13:55 INFO - [mozharness: 2017-07-17 15:13:55.056781Z] Finished install step (success) 08:13:55 INFO - [mozharness: 2017-07-17 15:13:55.057040Z] Running setup-mitmproxy step. 08:13:55 INFO - Running pre-action listener: _resource_record_pre_action 08:13:55 INFO - Running main action method: setup_mitmproxy 08:13:55 INFO - Skipping: mitmproxy is not required 08:13:55 INFO - Running post-action listener: _resource_record_post_action 08:13:55 INFO - [mozharness: 2017-07-17 15:13:55.058182Z] Finished setup-mitmproxy step (success) 08:13:55 INFO - [mozharness: 2017-07-17 15:13:55.058424Z] Running run-tests step. 08:13:55 INFO - Running pre-action listener: _resource_record_pre_action 08:13:55 INFO - Running pre-action listener: _set_gcov_prefix 08:13:55 INFO - Running main action method: run_tests 08:13:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:13:55 INFO - Python 2.7.3 08:13:55 INFO - Return code: 0 08:13:55 INFO - grabbing minidump binary from tooltool 08:13:55 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')]} 08:13:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x16bed00>, '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 0x16bfc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c0090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:13:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 08:13:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:13:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 08:13:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:13:55 INFO - Return code: 0 08:13:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:13:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:13:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:13:55 INFO - ENV: RUST_BACKTRACE is now 1 08:13:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:13:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:13:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--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 08:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-071 --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 08:13:55 INFO - Using env: {'DISPLAY': ':0', 08:13:55 INFO - 'HOME': '/home/cltbld', 08:13:55 INFO - 'LANG': 'en_US.UTF-8', 08:13:55 INFO - 'LANGUAGE': 'en_US:en', 08:13:55 INFO - 'LOGNAME': 'cltbld', 08:13:55 INFO - 'MAIL': '/var/mail/cltbld', 08:13:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:13:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:55 INFO - 'MOZ_NO_REMOTE': '1', 08:13:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:55 INFO - 'NO_EM_RESTART': '1', 08:13:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:55 INFO - 'PWD': '/builds/slave/test', 08:13:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:13:55 INFO - 'RUST_BACKTRACE': '1', 08:13:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:13:55 INFO - 'SHELL': '/bin/bash', 08:13:55 INFO - 'SHLVL': '1', 08:13:55 INFO - 'TERM': 'linux', 08:13:55 INFO - 'TMOUT': '86400', 08:13:55 INFO - 'USER': 'cltbld', 08:13:55 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603', 08:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:55 INFO - '_': '/tools/buildbot/bin/python'} 08:13:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--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 08:13:55 INFO - mozversion application_buildid: 20170717142528 08:13:55 INFO - mozversion application_changeset: 1738106d39b8e04c566a879931ff18ce6412b57d 08:13:55 INFO - mozversion application_display_name: Nightly 08:13:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:13:55 INFO - mozversion application_name: Firefox 08:13:55 INFO - mozversion application_remotingname: firefox 08:13:55 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 08:13:55 INFO - mozversion application_vendor: Mozilla 08:13:55 INFO - mozversion application_version: 56.0a1 08:13:55 INFO - mozversion platform_buildid: 20170717142528 08:13:55 INFO - mozversion platform_changeset: 1738106d39b8e04c566a879931ff18ce6412b57d 08:13:55 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 08:13:55 INFO - mozversion platform_version: 56.0a1 08:13:55 INFO - using testdate: 1500304435 08:13:55 INFO - actual date: 1500304435 08:13:55 INFO - starting webserver on 'localhost:41604' 08:13:55 INFO - SUITE-START | Running 2 tests 08:13:55 INFO - TEST-START | dromaeo_css 08:13:55 INFO - Initialising browser for dromaeo_css test... 08:13:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41604/getInfo.html -profile /tmp/tmp4xa2Qe/profile 08:13:55 INFO - TEST-INFO | started process 23667 (/builds/slave/test/build/application/firefox/firefox http://localhost:41604/getInfo.html) 08:14:02 INFO - TEST-INFO | 23667: exit 0 08:14:02 INFO - Browser initialized. 08:14:02 INFO - Running cycle 1/1 for dromaeo_css test... 08:14:02 INFO - TEST-INFO | started process 23872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4xa2Qe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:13 INFO - PID 23872 | RSS: Main: 167272448 08:14:13 INFO - PID 23872 | 08:17:12 INFO - PID 23872 | Cycle 1(1): loaded http://localhost:41604/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41604/tests/dromaeo/cssquery-ext.html) 08:17:13 INFO - PID 23872 | RSS: Main: 175202304 08:17:13 INFO - PID 23872 | 08:20:15 INFO - PID 23872 | Cycle 1(1): loaded http://localhost:41604/tests/dromaeo/cssquery-ext.html (next: http://localhost:41604/tests/dromaeo/cssquery-jquery.html) 08:20:15 INFO - PID 23872 | RSS: Main: 172900352 08:20:15 INFO - PID 23872 | 08:23:17 INFO - PID 23872 | Cycle 1(1): loaded http://localhost:41604/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41604/tests/dromaeo/cssquery-mootools.html) 08:23:18 INFO - PID 23872 | RSS: Main: 174493696 08:23:18 INFO - PID 23872 | 08:26:19 INFO - PID 23872 | Cycle 1(1): loaded http://localhost:41604/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41604/tests/dromaeo/cssquery-prototype.html) 08:26:20 INFO - PID 23872 | RSS: Main: 173854720 08:26:20 INFO - PID 23872 | 08:29:23 INFO - PID 23872 | Cycle 1(1): loaded http://localhost:41604/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41604/tests/dromaeo/cssquery-yui.html) 08:29:24 INFO - PID 23872 | RSS: Main: 174563328 08:29:24 INFO - PID 23872 | 08:32:25 INFO - PID 23872 | Cycle 1(1): loaded http://localhost:41604/tests/dromaeo/cssquery-yui.html (next: http://localhost:41604/tests/dromaeo/cssquery-dojo.html) 08:32:25 INFO - PID 23872 | RSS: Main: 177397760 08:32:25 INFO - PID 23872 | 08:32:25 INFO - PID 23872 | __start_tp_report 08:32:25 INFO - PID 23872 | _x_x_mozilla_page_load 08:32:25 INFO - PID 23872 | _x_x_mozilla_page_load_details 08:32:25 INFO - PID 23872 | |i|pagename|runs| 08:32:25 INFO - PID 23872 | |0;dojo.html;3064.7241748242654;3127.9061628151157;3140.3248301615163;3149.7952633078853;3156.968430315696;5956.702164891754;6002.579819412643;6027.638341699501;6035.758569657214;6069.119977603256;6018.6689732064715;6070.423309785574;6075.51395888329;6083.54373421994;6092.055731361635;5559.416261292567;5603.60774745767;5613.607047506655;5618.185363122345;5643.209950606918;5550.417206193352;5622.634528755618;5626.915596266059;5634.605577609569;5650.0959846424375;5624.325080990287;5629.971850140764;5636.943630563704;5642.492175704186;5644.125160600113;5608.915866262009;5610.410906854803;5613.522850557708;5616.52259557938;5619.213310136563;5443.374011988632;5541.5289700375515;5544.1960915667405;5596.936582049439;5601.327840659147;6032.638041717467;6036.9396306036815;6097.420745029215;6099.48154406876;6110.847228819271;6351.142595749561;6404.231492220917;6427.2287325520765;6434.227892652912;6517.902231466532;6472.190976127984;6484.416402523749;6491.8052458425855;6491.9350806492275;6501.414872661436;5992.041273396236;6017.338092809788;6022.759089636409;6027.578069535134;6033.909491357633;5584.972075139598;6631.568948018364;6634.601923884486;6635.004749287597;6732.4950628703045;6154.230721159855;6336.303006669263;6414.230292364946;6418.935810641927;6420.935790642034;6362.809115726535;6438.420542151229;6511.609303441809;6523.412892839668;6523.869522609616;6287.056941458726;6344.333844946306;6357.904631430532;6363.681815909186;6454.9677251614385;6328.050792381179;6342.651154186564;6359.332270111571;6372.203474565679;6425.518086143558;5120.769565369567;5227.9805437939995;5257.579393648499;5324.5740340772645;5335.199720042025;4485.551444855553;4517.390152329459;4518.706284091523;4521.5930566248535;4523.231050721385;5517.420670829505;5522.889542209214;5531.308586426697;5551.139573366135;5560.193771903051;6463.192100987377;6473.546851720429;6478.967605161944;6479.44924681398;6490.545661803723;5463.262459567987;5482.259894914216;5549.19536667181;5550.555955523549;5553.861153471114;5611.6071874969175;5684.431556844283;5692.971535142297;5739.598228124075;5780.306363236438;6280.057991301342;6281.874362512815;6282.340354262828;6287.748490060438;6301;6397.328280530477;6406.935930640634;6445.806625801233;6498.415142637185;6499.967500162564;6231.9688401557705;6233.2208473940755;6240.095186197885;6288.654124023223;6315.210598675166;6348;6374.458171055512;6382.521310901608;6466.612003279818;6477;6493.318201588765;6499.0901273820755;6561.540692151694;6583.934160658332;6589.604623722592;6200.162977997912;6304.401081897213;6315.368463153648;6328.841778955563;6371.299157092623;6305.5270854687;6315.747370105328;6318.589291696209;6320.1151838743535;6326.2092238470195;5867.354590994902;6255.40573645503;6257.56197066201;6261.154744109487;6263.498920086473;6250.656213908097;6298.496120310456;6342;6387.584806987531;6392.169018027626;6089.756409743561;6109.938900610937;6124.173236613;6185.381461853779;6202.317745047951 08:32:25 INFO - PID 23872 | |1;ext.html;769.415244414245;830.7341650671788;854.9786255343616;884.4383816276662;884.4648987362643;40386.798066009665;41502.79248603753;41605.375919361235;41635.583644163584;42058.158836823284;37740.62259377405;37849.621503784954;37880.62119378805;37967;37975;6819.113515243024;6957.408620267258;6973.12835895513;6979.336962988508;6990.335918087773;6886.483513736464;6997.790066298019;6998.195207551146;7000.474964377667;7005.404540614054;6944.02783610295;6960.025596416505;6964.4080253178545;6969.860602787941;6980.406665433445;6869.690863911136;6913.792586222421;6948.9999999999745;6955;6961.65191740411;6210.813675589739;6317.93682063178;6333.176687030703;6344.841378965517;6347.904781428282;33390.83304583486;33719.32561348784;33862;33899.491507627405;34000.659993400244;3356.1777364545596;3384.1032126486502;3399.8640054397792;3401.557797486336;3404.165979335054;30927.38145237105;31007.689923100705;31090.222744431343;31188.220294492592;31305;4966.701997880139;4984.77568509418;4992.326035985168;4993.700377977297;5102.107131252016;189140;192985;193909;194055;195014;49360.50639493559;49917.25124123141;50321;50661.240081398806;50970;51947.22079168815;52061;52122.21816672753;52144.478555213966;52148.47851521436;16089.436869709503;16187.19064046793;16239.269232884548;16243.350265989227;16263.18684065792;13393.933030334785;13400.731985360433;13406.329683515785;13434.798478022838;13448.93275533616;14173.149611023166;14175.291235438186;14224.217668028357;14444.277786110863;14584.781228281585;5706.144078388192;5749.597528172988;5783.8554036149435;5828.300603927556;5851.912221316684;977.4086677559974;991.6083147156833;995.1988649137514;1026.5175367577226;1029.330934892326;22311.059585440405;22622.208222712125;22791.316260512212;22795.544089118124;22818.31545053651;1059.6132411669685;1104.8784633690289;1105.5080489182396;1118.3792994887754;1124.9381284029294;11712.297262164297;11982.340971246666;11989.86096320848;12181.573644922386;12261.325627090595;215165;215556;216061;216117;216565;51055.744721276154;51166.74416627968;51222.48777512177;51247.7437612817;51325;1418.581518452059;1469.2433396800657;1491.2692780537675;1504.308018311589;1509.871660908813;21766;21900.671489927983;22495.437614059778;22602.17472815898;22911.083556657548;36315.45526817047;36584.634153658124;36626.81686591657;36653.63346366502;36747.44878826873;192811;194407;194942;196172;196500;34614.13464663403;36785.08037299089;37232.62767372291;37344.253114937004;37364.06589835276;44764.552354476036;45640.93616809179;46125.538744612124;46184.30723539217;46915;31224.375512490078;33069.83465082659;33110.17224569405;33847.492287616195;33923.83038084794;31859.68140318567;33218.66781332156;33551.83224083864;33617.32765344631;33695.494567581016;35279.647203528664;36390.454143188406;36480.81759591185;36636.26727465382;36654.63345366512;31195.37609247757;31311.37377252488;32014.35971280608;32077.358452830347;32583.022509324757;23615.29154125379;23860.284191474282;23963.524440919216;24165.15421960223;24380.146694865594 08:32:25 INFO - PID 23872 | |2;jquery.html;564.5765675743193;564.9265595472588;575.8617931696391;579.1457600039942;593.2584269662922;21852.235171768993;22788.658170127463;22851.97166127526;22879.31362059137;22896.198633047825;24627.138050168247;25942.48115037698;27088.18735437935;27192.45615087697;27254.863725681393;6401.647909364983;6516.185476815398;6524.967375163117;6561.2782593914635;6571.44142747867;6391.776287829927;6466.385693359123;6495.382938620824;6496.545241833073;6499.9350006500035;6129.264488261415;6259.280182778971;6373.3945275198785;6413.03804429337;6499.642519661416;6383;6463.515236357245;6463.547551671385;6467.902981455282;6502.7724029658975;6009.459148676597;6033.637981721111;6038.00372938469;6038.1848450459065;6057.848553786146;26922.461550769072;30045.399092018255;30247.546286805715;30437.543436848464;30509.542356864444;1916.7029110487897;1941.7572803399576;1943.9611207775906;1949.1813438355925;1959.3240332085409;18622.162002709774;19161.233550658097;19170.137343819562;19177.424677259565;19186.712199317022;2247.685324054634;2270.8751018693965;2305.873176975266;2313.9652905206435;2414.8913298901593;131759.34120329336;138718.30640846732;138740;139153;139156;14688.192149431883;14948.551543453714;15084;15156.772648410282;15457.768133478006;23452.530949380918;23555.88222058913;23580;23659.526809463714;23660.88169559141;10251.948740256401;10269.897301026895;10355.17158627308;10394.584216631401;10645.254832161674;9682;9737.513124343895;9745.951270243604;9869.35849169816;9909.950450247847;9337.112974267433;9351.895823439807;9427.245820334358;9491.47796871165;9538.189253913495;2668.319578507468;2745.3548416122194;2776.5835124731047;2810.1990932584117;2878.165332053723;932.2635118256637;933.3186773655269;951.538503825644;960.6205548808322;986.0927946289431;19794.70307945382;20111.29610463656;20380.286689966077;23663.29010129699;25359.366015849384;1024.8667673202435;1045.4250162410644;1047.1256500821898;1048.7797562511957;1051.090806452413;11318.886811131782;11333.320000799979;11337;11437.771244575062;11763.823542646867;492543;501073;502325;503649;516643;115814;116249.41875290738;116302;117721.4113929442;118303.40848295703;1246.9314187719763;1256.8805963433458;1288.890444312225;1289.6646871813396;1298.558490113347;17389.47831565055;18349.449516514527;18564.2574297032;18869.811301886806;18930.33743819015;53838;54420.455795441536;56505.434945651665;57230;57264.713676431355;66806.6659666718;67850.66074669792;67892.660536697;67938.3206167932;68993.65503172453;14250.216238106588;14662.706745865236;15045.849541504445;15122;15351;22599.20902768395;22829.77170228343;23036.4240893979;23280.53438931178;23565.410864728517;17978.5505362367;18007.63984720272;18151.45545633633;18264.543386415447;18340.72488912694;16454.259558319663;16579.171041447637;16921.661566768842;17019.48941531756;17526.474205773848;20331;20350.898245508677;20475.692864606746;20598.38204853857;20692.482687932923;14470.855291447371;14646.194459304841;15132.394704212149;15313.310901009705;15337.76993345123;19226.134823933236;19265.8073419264;19277.325293614656;19484.707729384354;19512.707309390655 08:32:25 INFO - PID 23872 | |3;mootools.html;1355.7424089423012;1400.6218321053316;1408.2325132802625;1411.9011669183162;1416.3343228682515;13142.868571314284;13719.725605487884;13758.38087286072;13811.861881381195;13848.653783655402;13109.27898965559;13519.32403379832;13553.254570998592;13592.72814543711;13638.0453368264;2551.0688598661495;2628.6714160729907;2629.3952390950094;2629.815912886099;2630.2109367189864;2519.6976362836394;2605.6091586262023;2605.895764169431;2615.228507590256;2620.1222590432226;2535.6703628528267;2569.498947705198;2579.9742002580015;2584.508943300776;2596.0913680211966;2496.400863792695;2501.6122501012374;2502.78726308264;2513.3465299022205;2514.9874250628814;2413.3966508372905;2446.510697860417;2447.0945750072588;2458.4960083182905;2459.963100553493;13301.73396532064;13604;13706.040577159603;13719.794203086962;13723.725525489433;7175.677094530759;7523.887141692879;7526.623668816592;7529.698812047512;7542.170361260257;4890.779914903838;4890.975545122287;4969.27945447908;5052.166392545226;5078.187490001582;1809.1406581873637;1855.081734541397;1891.3569386408549;1905.3521802587047;1911.5125642961095;20350.389488315373;21017.8949105255;21027.15891364359;21137.47156321089;21200.575988480145;5746.339170995389;6229.750809967551;6496.0255961606135;6613;6631.204255489372;15397.230138493254;15421.151836649093;15437.15095669749;15439.691206175814;15454.613634659223;7198.604076775723;7550.131734850453;7566.9621651892485;7572.432067594952;7578.696852125963;6668.933310666928;6848.7260509579055;6854.108965834509;6891.758788442481;6896.448284137257;4992.101421744121;5150.793968241228;5152.484751524892;5199.818006369759;5216.356847592996;1404.2417094768914;1471.5364660132025;1482.78499617557;1482.9851701482846;1496.0500082447725;841.2891107014563;856.546030603781;856.8971723393232;863.8229163021691;882.6601758323092;6664.666766661648;6671;6683.097781799492;6766.323367663194;6794.694238759268;683.0948992584845;729.1796728680234;968.7626531499686;991.6330957545754;993.4933184076028;4757.9532502849315;5019.698818070928;5020.472850350734;5107.41264754558;5123.974380128076;17800;18613.162407691685;18827.529311767314;18876.90561547211;19312.90343548273;17222.224999875034;17586.12069396525;18034.549136271435;18178.18198181085;18267.451976440727;9937.80124397508;10271.435071071162;10487.842682359771;10502.842457363146;10538.894611053945;7555.622218888923;7838.529688218725;7984.161663025298;7986.680532778624;8063.233992770677;15968.28142733603;16030.759538606697;16400.17999100064;16413.17934103266;16610.418635347705;15904.284307205971;16198.595035124215;16396.26216820222;16562.50312490627;16868.57828554247;10644.308119972176;10830.296030757976;10860.511276992713;10862.837057444303;11001.779964400826;12733.172343797623;12983.480660773463;13007.804882926574;13014.80477792815;13015.349232538147;9803.80392392134;9945.850812237966;10000.549975250986;10400.791984160425;10486.108680762221;9899.604015839286;10339.276250662382;10339.948300258451;10457.058864702214;10622.52198651078;8430.915690843012;8530.530820804915;8545.914540854512;8565.229129378386;8595.570221488775;6180.567360284737;6341.778037768656;6392.264889537577;6491.318411566717;6657;5750.539956803529;6058.606190597597;6093.586485274295;6103.3591472894705;6249.156363890998 08:32:25 INFO - PID 23872 | |4;prototype.html;487.943886453058;497.43292646383105;521.397785557681;523.5863667702515;525.9421463639;6050.485708714754;6134.171886795281;6156.661383623905;6169.784057557987;6170.488230383562;5790.507806836414;6033.939660603392;6060.393960603938;6072.696365181734;6083.634981901078;4778.378810754597;4876;4893.119238537062;4958.256261560777;4989.3513843200335;4876.780544875472;4902.264660300965;4922.3354847095725;4939.629527785412;4979.87952710639;4912.428023032613;4926.9753651231695;4936.136176169174;4953.752312384385;4959.975200124012;4601.953980460203;4821.590164835993;4848.878778030542;4885.143645414755;4925.408950925876;4390.27560452525;4405.070628032355;4417.712848664826;4425.911481770347;4455.173378914662;5874.971879920997;5882.529397648178;5894.646321220697;5937.228160339171;5960.122561393147;5491.039068163055;5552.500274975271;5562.805301814457;5600.663960162403;5641.802536911188;6410.166678331833;6469.450096741735;6469.902951455732;6472.5371926019825;6535.248446428626;4813.879653008703;4857.247126695368;4879;4882.511748825124;4889.09551732927;6715.56348837324;6770.255271920085;6773.661316934183;6846.760363387258;6907;4931.2659846547;4956.132676781549;4967.751612419437;5004.174311238678;5006.6245031622775;4990.525900039491;5015.673981191211;5018.146915024455;5051.6716413433005;5062.341895553554;5612.1581762735095;5618.213450116987;5622.550195984311;5635.492805647511;5665.150227465913;6422.165118534561;6440.452561532228;6463.903041454382;6488.253850807123;6500.057491663682;1737.1922056243907;1753.2285794250488;1754.649070185968;1758;1762.524118488001;1132.7394699219226;1226.8589112252205;1231.5566396097397;1234.6912272990658;1241.540629966918;5462.972685136629;5542.8337149885565;5576.135698966586;5581.972090139605;5701.315842098975;6542.378474045054;6552.868942621216;6592.340765923369;6623.9070553359115;6720.697568609425;5532.3914369419335;5557.3886872444;5565.916511252334;5583;5602.38373778884;3446.724262059029;3475.6350583188905;3475.652434756504;3528.7120201126404;3539.5398598182073;6447.548671592944;6468.579542329733;6475.222973243147;6487.3836985486305;6497.447716944018;6718.428933540606;6838.589684618939;6854.794356169323;6858.485613579001;6889.414399776075;6381.712822922979;6412.35876412355;6438.742450301936;6451.258105317855;6455.612663240033;6558.704858281293;6599.637019963948;6602.273749887412;6636.303188165366;6713.832154196184;6490.156279683611;6525.738970441129;6568.7372505099265;6574.868502630016;6619.470442364503;6299.811005669837;6380.202474690664;6395.20059992501;6396.520260980352;6447.451966582893;4819.421669399694;4834.20235661126;4856.1987272099705;4859.31969524274;4883.462819089968;6643.468522518284;6663.267040625624;6686.331366863469;6691.966540167268;6695.966520167368;6397.168368112116;6429.6142231466265;6456.418922297016;6480.870382592416;6500.252470965899;6373.681315934092;6375.936240637534;6435.292117866938;6521.152250207443;6529.225079341356;6326.525510586633;6354.824357493879;6393.4885209184085;6446.226452825691;6454.870902582016;5954.880902382015;6375.458086062737;6447.290798012309;6449;6488.545801793829;6175.413335733098;6229.2524897012645;6241.719122639402;6256.186695729526;6276.7988325955 08:32:25 INFO - PID 23872 | |5;yui.html;910.5811326789676;911.2209061252629;924.269826836799;933.043630278964;943.4952300519224;17958.551036224086;18754.812451875496;18888.527786805338;18889.527761805926;18943.33698320559;19226.51933701658;20240.39278821634;21118;21160.153593856267;21263;1022.8874823769379;1023.1763430438494;1041.7760181560964;1042.3276986343803;1050.5745173204864;1028.9794204115913;1032.339302846179;1040.8126537223297;1041.1670663469233;1042.5100202904662;1036.8030074285862;1076.6231818863375;1078.9695840472368;1096.2381145104155;1098.7363032872133;1075.8171110911164;1080.135891286975;1080.3086024944002;1081.2809481694665;1083.4528563075596;794.4359504751633;796.1322158846884;798.1220657277007;798.5767543202112;799.4723482501521;18444.446666600023;19444.416667499998;19612.607747845104;19815.900920495304;19959.80040199594;18870.622587548172;18883.244670213313;19267.710984335245;19498.220071197276;19529.902350488297;14788.852111478962;15228.390864365412;15285.465008724641;15351.07893526392;15381.154036527987;3419.760616756828;3481.425564781808;3502.597201321855;3508.386032444312;3509.0700964244243;109459;110888;116116;121813;122433.99999999911;15375.384984600714;15406.614834629225;15479.84520154784;15551;15605.219739013004;28308.009219677213;28860;29285.56071658927;29392.412151756846;29745.851270743507;8096.635651395702;8352.665893364197;8399.874001889977;8403.07566167721;8408.075111737704;3818.3127037133027;3935.134270460494;3940.4680368149934;3963.841446342172;3964.1675248198203;5018.573421259234;5119.667221630582;5130.692158470503;5134.435212126663;5167.767450464738;856.246503077288;888.4358432395476;894.8926128864578;901.5852707754507;980.8970058143935;624.5565648389694;653.9738410463623;669.5079116849112;684.0764967294114;692.9826754331182;11272.38023282397;11547;11600.767984640428;11631.88368116325;11706.70733231676;657.6054367379534;674.4132604634;689.290031267795;700.1213477086225;702.8418605813753;5316.601254905898;5406.02691515531;5802.448767367094;6026.849328766728;6238.781642642486;92319.5384023089;92653;96196.51901740447;98457;99587.50206248922;84767.15232847715;85560;87174;87410;89844.55077724569;72819.2718072823;76205.61897190589;76492;76802;80566;11090.611828585961;11650.242734222249;11948.940255298668;12138.575149869712;12222.961048310994;35732.821335894194;35948;36838;37444.81277593595;37841.05397365088;45468.31797522974;45899.311510326705;46657.53342466532;47065.29402058903;47696;17051.91474042622;17137.571560711083;17443.82556174422;17570.472885813448;17882.5529361767;19947.20211191536;20085.59828803445;20108.899455503215;20626.58746825085;20643.174273029512;16696.49910502687;17438.21528031267;18033.909830451288;18078.638427231646;18358.082095895417;18212.18045187996;18362.81637183611;18681.81318186855;18846.905765471085;18848.905755471682;16908.40820571274;17374.305027798746;17451.738223926906;17474.47576572705;17824.821751782318;11332.773344533229;11996.820047699117;12466.43901024438;12545.93727031359;12609.810852837398;12079.03367730597;12103.576374826838;12104.878951210376;12174.330411827434;12719.80920286215 08:32:25 INFO - PID 23872 | __end_tp_report 08:32:25 INFO - PID 23872 | __start_cc_report 08:32:25 INFO - PID 23872 | _x_x_mozilla_cycle_collect,361 08:32:25 INFO - PID 23872 | __end_cc_report 08:32:25 INFO - PID 23872 | __startTimestamp1500305545960__endTimestamp 08:32:25 INFO - PID 23872 | 08:32:25 INFO - PID 23872 | ------- Summary: start ------- 08:32:25 INFO - PID 23872 | Number of tests: 6 08:32:25 INFO - PID 23872 | 08:32:25 INFO - PID 23872 | [#0] dojo.html Cycles:165 Average:5953.60 Median:6200.16 stddev:680.28 (11.0%) stddev-sans-first:643.51 08:32:25 INFO - PID 23872 | Values: 3064.7 3127.9 3140.3 3149.8 3157.0 5956.7 6002.6 6027.6 6035.8 6069.1 6018.7 6070.4 6075.5 6083.5 6092.1 5559.4 5603.6 5613.6 5618.2 5643.2 5550.4 5622.6 5626.9 5634.6 5650.1 5624.3 5630.0 5636.9 5642.5 5644.1 5608.9 5610.4 5613.5 5616.5 5619.2 5443.4 5541.5 5544.2 5596.9 5601.3 6032.6 6036.9 6097.4 6099.5 6110.8 6351.1 6404.2 6427.2 6434.2 6517.9 6472.2 6484.4 6491.8 6491.9 6501.4 5992.0 6017.3 6022.8 6027.6 6033.9 5585.0 6631.6 6634.6 6635.0 6732.5 6154.2 6336.3 6414.2 6418.9 6420.9 6362.8 6438.4 6511.6 6523.4 6523.9 6287.1 6344.3 6357.9 6363.7 6455.0 6328.1 6342.7 6359.3 6372.2 6425.5 5120.8 5228.0 5257.6 5324.6 5335.2 4485.6 4517.4 4518.7 4521.6 4523.2 5517.4 5522.9 5531.3 5551.1 5560.2 6463.2 6473.5 6479.0 6479.4 6490.5 5463.3 5482.3 5549.2 5550.6 5553.9 5611.6 5684.4 5693.0 5739.6 5780.3 6280.1 6281.9 6282.3 6287.7 6301.0 6397.3 6406.9 6445.8 6498.4 6500.0 6232.0 6233.2 6240.1 6288.7 6315.2 6348.0 6374.5 6382.5 6466.6 6477.0 6493.3 6499.1 6561.5 6583.9 6589.6 6200.2 6304.4 6315.4 6328.8 6371.3 6305.5 6315.7 6318.6 6320.1 6326.2 5867.4 6255.4 6257.6 6261.2 6263.5 6250.7 6298.5 6342.0 6387.6 6392.2 6089.8 6109.9 6124.2 6185.4 6202.3 08:32:25 INFO - PID 23872 | 08:32:25 INFO - PID 23872 | [#1] ext.html Cycles:180 Average:37023.46 Median:3402.86 stddev:52231.52 (1534.9%) stddev-sans-first:52307.10 08:32:25 INFO - PID 23872 | Values: 769.4 830.7 855.0 884.4 884.5 40386.8 41502.8 41605.4 41635.6 42058.2 37740.6 37849.6 37880.6 37967.0 37975.0 6819.1 6957.4 6973.1 6979.3 6990.3 6886.5 6997.8 6998.2 7000.5 7005.4 6944.0 6960.0 6964.4 6969.9 6980.4 6869.7 6913.8 6949.0 6955.0 6961.7 6210.8 6317.9 6333.2 6344.8 6347.9 33390.8 33719.3 33862.0 33899.5 34000.7 3356.2 3384.1 3399.9 3401.6 3404.2 30927.4 31007.7 31090.2 31188.2 31305.0 4966.7 4984.8 4992.3 4993.7 5102.1 189140.0 192985.0 193909.0 194055.0 195014.0 49360.5 49917.3 50321.0 50661.2 50970.0 51947.2 52061.0 52122.2 52144.5 52148.5 16089.4 16187.2 16239.3 16243.4 16263.2 13393.9 13400.7 13406.3 13434.8 13448.9 14173.1 14175.3 14224.2 14444.3 14584.8 5706.1 5749.6 5783.9 5828.3 5851.9 977.4 991.6 995.2 1026.5 1029.3 22311.1 22622.2 22791.3 22795.5 22818.3 1059.6 1104.9 1105.5 1118.4 1124.9 11712.3 11982.3 11989.9 12181.6 12261.3 215165.0 215556.0 216061.0 216117.0 216565.0 51055.7 51166.7 51222.5 51247.7 51325.0 1418.6 1469.2 1491.3 1504.3 1509.9 21766.0 21900.7 22495.4 22602.2 22911.1 36315.5 36584.6 36626.8 36653.6 36747.4 192811.0 194407.0 194942.0 196172.0 196500.0 34614.1 36785.1 37232.6 37344.3 37364.1 44764.6 45640.9 46125.5 46184.3 46915.0 31224.4 33069.8 33110.2 33847.5 33923.8 31859.7 33218.7 33551.8 33617.3 33695.5 35279.6 36390.5 36480.8 36636.3 36654.6 31195.4 31311.4 32014.4 32077.4 32583.0 23615.3 23860.3 23963.5 24165.2 24380.1 08:32:25 INFO - PID 23872 | 08:32:25 INFO - PID 23872 | [#2] jquery.html Cycles:180 Average:35267.46 Median:22887.76 stddev:84553.72 (369.4%) stddev-sans-first:84750.77 08:32:25 INFO - PID 23872 | Values: 564.6 564.9 575.9 579.1 593.3 21852.2 22788.7 22852.0 22879.3 22896.2 24627.1 25942.5 27088.2 27192.5 27254.9 6401.6 6516.2 6525.0 6561.3 6571.4 6391.8 6466.4 6495.4 6496.5 6499.9 6129.3 6259.3 6373.4 6413.0 6499.6 6383.0 6463.5 6463.5 6467.9 6502.8 6009.5 6033.6 6038.0 6038.2 6057.8 26922.5 30045.4 30247.5 30437.5 30509.5 1916.7 1941.8 1944.0 1949.2 1959.3 18622.2 19161.2 19170.1 19177.4 19186.7 2247.7 2270.9 2305.9 2314.0 2414.9 131759.3 138718.3 138740.0 139153.0 139156.0 14688.2 14948.6 15084.0 15156.8 15457.8 23452.5 23555.9 23580.0 23659.5 23660.9 10251.9 10269.9 10355.2 10394.6 10645.3 9682.0 9737.5 9746.0 9869.4 9910.0 9337.1 9351.9 9427.2 9491.5 9538.2 2668.3 2745.4 2776.6 2810.2 2878.2 932.3 933.3 951.5 960.6 986.1 19794.7 20111.3 20380.3 23663.3 25359.4 1024.9 1045.4 1047.1 1048.8 1051.1 11318.9 11333.3 11337.0 11437.8 11763.8 492543.0 501073.0 502325.0 503649.0 516643.0 115814.0 116249.4 116302.0 117721.4 118303.4 1246.9 1256.9 1288.9 1289.7 1298.6 17389.5 18349.4 18564.3 18869.8 18930.3 53838.0 54420.5 56505.4 57230.0 57264.7 66806.7 67850.7 67892.7 67938.3 68993.7 14250.2 14662.7 15045.8 15122.0 15351.0 22599.2 22829.8 23036.4 23280.5 23565.4 17978.6 18007.6 18151.5 18264.5 18340.7 16454.3 16579.2 16921.7 17019.5 17526.5 20331.0 20350.9 20475.7 20598.4 20692.5 14470.9 14646.2 15132.4 15313.3 15337.8 19226.1 19265.8 19277.3 19484.7 19512.7 08:32:25 INFO - PID 23872 | 08:32:25 INFO - PID 23872 | [#3] mootools.html Cycles:180 Average:8305.43 Median:2517.34 stddev:5608.64 (222.8%) stddev-sans-first:5600.06 08:32:25 INFO - PID 23872 | Values: 1355.7 1400.6 1408.2 1411.9 1416.3 13142.9 13719.7 13758.4 13811.9 13848.7 13109.3 13519.3 13553.3 13592.7 13638.0 2551.1 2628.7 2629.4 2629.8 2630.2 2519.7 2605.6 2605.9 2615.2 2620.1 2535.7 2569.5 2580.0 2584.5 2596.1 2496.4 2501.6 2502.8 2513.3 2515.0 2413.4 2446.5 2447.1 2458.5 2460.0 13301.7 13604.0 13706.0 13719.8 13723.7 7175.7 7523.9 7526.6 7529.7 7542.2 4890.8 4891.0 4969.3 5052.2 5078.2 1809.1 1855.1 1891.4 1905.4 1911.5 20350.4 21017.9 21027.2 21137.5 21200.6 5746.3 6229.8 6496.0 6613.0 6631.2 15397.2 15421.2 15437.2 15439.7 15454.6 7198.6 7550.1 7567.0 7572.4 7578.7 6668.9 6848.7 6854.1 6891.8 6896.4 4992.1 5150.8 5152.5 5199.8 5216.4 1404.2 1471.5 1482.8 1483.0 1496.1 841.3 856.5 856.9 863.8 882.7 6664.7 6671.0 6683.1 6766.3 6794.7 683.1 729.2 968.8 991.6 993.5 4758.0 5019.7 5020.5 5107.4 5124.0 17800.0 18613.2 18827.5 18876.9 19312.9 17222.2 17586.1 18034.5 18178.2 18267.5 9937.8 10271.4 10487.8 10502.8 10538.9 7555.6 7838.5 7984.2 7986.7 8063.2 15968.3 16030.8 16400.2 16413.2 16610.4 15904.3 16198.6 16396.3 16562.5 16868.6 10644.3 10830.3 10860.5 10862.8 11001.8 12733.2 12983.5 13007.8 13014.8 13015.3 9803.8 9945.9 10000.5 10400.8 10486.1 9899.6 10339.3 10339.9 10457.1 10622.5 8430.9 8530.5 8545.9 8565.2 8595.6 6180.6 6341.8 6392.3 6491.3 6657.0 5750.5 6058.6 6093.6 6103.4 6249.2 08:32:25 INFO - PID 23872 | 08:32:25 INFO - PID 23872 | [#4] prototype.html Cycles:180 Average:5424.17 Median:5957.50 stddev:1521.29 (25.5%) stddev-sans-first:1479.75 08:32:25 INFO - PID 23872 | Values: 487.9 497.4 521.4 523.6 525.9 6050.5 6134.2 6156.7 6169.8 6170.5 5790.5 6033.9 6060.4 6072.7 6083.6 4778.4 4876.0 4893.1 4958.3 4989.4 4876.8 4902.3 4922.3 4939.6 4979.9 4912.4 4927.0 4936.1 4953.8 4960.0 4602.0 4821.6 4848.9 4885.1 4925.4 4390.3 4405.1 4417.7 4425.9 4455.2 5875.0 5882.5 5894.6 5937.2 5960.1 5491.0 5552.5 5562.8 5600.7 5641.8 6410.2 6469.5 6469.9 6472.5 6535.2 4813.9 4857.2 4879.0 4882.5 4889.1 6715.6 6770.3 6773.7 6846.8 6907.0 4931.3 4956.1 4967.8 5004.2 5006.6 4990.5 5015.7 5018.1 5051.7 5062.3 5612.2 5618.2 5622.6 5635.5 5665.2 6422.2 6440.5 6463.9 6488.3 6500.1 1737.2 1753.2 1754.6 1758.0 1762.5 1132.7 1226.9 1231.6 1234.7 1241.5 5463.0 5542.8 5576.1 5582.0 5701.3 6542.4 6552.9 6592.3 6623.9 6720.7 5532.4 5557.4 5565.9 5583.0 5602.4 3446.7 3475.6 3475.7 3528.7 3539.5 6447.5 6468.6 6475.2 6487.4 6497.4 6718.4 6838.6 6854.8 6858.5 6889.4 6381.7 6412.4 6438.7 6451.3 6455.6 6558.7 6599.6 6602.3 6636.3 6713.8 6490.2 6525.7 6568.7 6574.9 6619.5 6299.8 6380.2 6395.2 6396.5 6447.5 4819.4 4834.2 4856.2 4859.3 4883.5 6643.5 6663.3 6686.3 6692.0 6696.0 6397.2 6429.6 6456.4 6480.9 6500.3 6373.7 6375.9 6435.3 6521.2 6529.2 6326.5 6354.8 6393.5 6446.2 6454.9 5954.9 6375.5 6447.3 6449.0 6488.5 6175.4 6229.3 6241.7 6256.2 6276.8 08:32:25 INFO - PID 23872 | 08:32:25 INFO - PID 23872 | [#5] yui.html Cycles:180 Average:21406.13 Median:19953.50 stddev:28178.19 (141.2%) stddev-sans-first:28215.20 08:32:25 INFO - PID 23872 | Values: 910.6 911.2 924.3 933.0 943.5 17958.6 18754.8 18888.5 18889.5 18943.3 19226.5 20240.4 21118.0 21160.2 21263.0 1022.9 1023.2 1041.8 1042.3 1050.6 1029.0 1032.3 1040.8 1041.2 1042.5 1036.8 1076.6 1079.0 1096.2 1098.7 1075.8 1080.1 1080.3 1081.3 1083.5 794.4 796.1 798.1 798.6 799.5 18444.4 19444.4 19612.6 19815.9 19959.8 18870.6 18883.2 19267.7 19498.2 19529.9 14788.9 15228.4 15285.5 15351.1 15381.2 3419.8 3481.4 3502.6 3508.4 3509.1 109459.0 110888.0 116116.0 121813.0 122434.0 15375.4 15406.6 15479.8 15551.0 15605.2 28308.0 28860.0 29285.6 29392.4 29745.9 8096.6 8352.7 8399.9 8403.1 8408.1 3818.3 3935.1 3940.5 3963.8 3964.2 5018.6 5119.7 5130.7 5134.4 5167.8 856.2 888.4 894.9 901.6 980.9 624.6 654.0 669.5 684.1 693.0 11272.4 11547.0 11600.8 11631.9 11706.7 657.6 674.4 689.3 700.1 702.8 5316.6 5406.0 5802.4 6026.8 6238.8 92319.5 92653.0 96196.5 98457.0 99587.5 84767.2 85560.0 87174.0 87410.0 89844.6 72819.3 76205.6 76492.0 76802.0 80566.0 11090.6 11650.2 11948.9 12138.6 12223.0 35732.8 35948.0 36838.0 37444.8 37841.1 45468.3 45899.3 46657.5 47065.3 47696.0 17051.9 17137.6 17443.8 17570.5 17882.6 19947.2 20085.6 20108.9 20626.6 20643.2 16696.5 17438.2 18033.9 18078.6 18358.1 18212.2 18362.8 18681.8 18846.9 18848.9 16908.4 17374.3 17451.7 17474.5 17824.8 11332.8 11996.8 12466.4 12545.9 12609.8 12079.0 12103.6 12104.9 12174.3 12719.8 08:32:25 INFO - PID 23872 | -------- Summary: end -------- 08:32:25 INFO - PID 23872 | 08:32:26 INFO - TEST-INFO | 23872: exit 0 08:32:26 INFO - TEST-OK | dromaeo_css | took 1111110ms 08:32:26 INFO - TEST-START | kraken 08:32:26 INFO - Initialising browser for kraken test... 08:32:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41604/getInfo.html -profile /tmp/tmp6Rrua8/profile 08:32:26 INFO - TEST-INFO | started process 24283 (/builds/slave/test/build/application/firefox/firefox http://localhost:41604/getInfo.html) 08:32:32 INFO - TEST-INFO | 24283: exit 0 08:32:32 INFO - Browser initialized. 08:32:32 INFO - Running cycle 1/1 for kraken test... 08:32:32 INFO - TEST-INFO | started process 24489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Rrua8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:32:44 INFO - PID 24489 | RSS: Main: 167280640 08:32:44 INFO - PID 24489 | 08:32:46 INFO - PID 24489 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41604/tests/kraken/driver.html?testName=audio-beat-detection) 08:32:47 INFO - PID 24489 | RSS: Main: 174555136 08:32:47 INFO - PID 24489 | 08:32:50 INFO - PID 24489 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41604/tests/kraken/driver.html?testName=audio-dft) 08:32:50 INFO - PID 24489 | RSS: Main: 174882816 08:32:50 INFO - PID 24489 | 08:32:53 INFO - PID 24489 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41604/tests/kraken/driver.html?testName=audio-fft) 08:32:54 INFO - PID 24489 | RSS: Main: 168361984 08:32:54 INFO - PID 24489 | 08:32:56 INFO - PID 24489 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41604/tests/kraken/driver.html?testName=audio-oscillator) 08:32:57 INFO - PID 24489 | RSS: Main: 169418752 08:32:57 INFO - PID 24489 | 08:32:59 INFO - PID 24489 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41604/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:32:59 INFO - PID 24489 | RSS: Main: 169857024 08:32:59 INFO - PID 24489 | 08:33:02 INFO - PID 24489 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41604/tests/kraken/driver.html?testName=imaging-darkroom) 08:33:03 INFO - PID 24489 | RSS: Main: 172347392 08:33:03 INFO - PID 24489 | 08:33:06 INFO - PID 24489 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41604/tests/kraken/driver.html?testName=imaging-desaturate) 08:33:07 INFO - PID 24489 | RSS: Main: 174215168 08:33:07 INFO - PID 24489 | 08:33:10 INFO - PID 24489 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41604/tests/kraken/driver.html?testName=json-parse-financial) 08:33:10 INFO - PID 24489 | RSS: Main: 173289472 08:33:10 INFO - PID 24489 | 08:33:12 INFO - PID 24489 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41604/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:33:12 INFO - PID 24489 | RSS: Main: 172908544 08:33:12 INFO - PID 24489 | 08:33:14 INFO - PID 24489 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41604/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:33:15 INFO - PID 24489 | RSS: Main: 173162496 08:33:15 INFO - PID 24489 | 08:33:17 INFO - PID 24489 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41604/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:33:17 INFO - PID 24489 | RSS: Main: 172924928 08:33:17 INFO - PID 24489 | 08:33:20 INFO - PID 24489 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41604/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:33:21 INFO - PID 24489 | RSS: Main: 172888064 08:33:21 INFO - PID 24489 | 08:33:24 INFO - PID 24489 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41604/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:33:24 INFO - PID 24489 | RSS: Main: 173391872 08:33:24 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41604/tests/kraken/driver.html?testName=ai-astar) 08:33:26 INFO - PID 24489 | RSS: Main: 174903296 08:33:26 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | __start_tp_report 08:33:26 INFO - PID 24489 | _x_x_mozilla_page_load 08:33:26 INFO - PID 24489 | _x_x_mozilla_page_load_details 08:33:26 INFO - PID 24489 | |i|pagename|runs| 08:33:26 INFO - PID 24489 | |0;ai-astar;101;107;109;108;108;111;108;109;109;110 08:33:26 INFO - PID 24489 | |1;audio-beat-detection;147;120;147;184;122;154;154;124;167;128 08:33:26 INFO - PID 24489 | |2;audio-dft;164;167;164;162;165;163;164;165;177;165 08:33:26 INFO - PID 24489 | |3;audio-fft;77;74;74;174;76;74;73;75;100;75 08:33:26 INFO - PID 24489 | |4;audio-oscillator;82;82;134;81;81;82;140;82;82;139 08:33:26 INFO - PID 24489 | |5;imaging-gaussian-blur;116;113;114;115;114;114;113;115;114;114 08:33:26 INFO - PID 24489 | |6;imaging-darkroom;150;149;149;149;150;151;149;150;152;150 08:33:26 INFO - PID 24489 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;94 08:33:26 INFO - PID 24489 | |8;json-parse-financial;55;55;55;54;57;55;55;54;56;55 08:33:26 INFO - PID 24489 | |9;json-stringify-tinderbox;54;54;54;54;54;54;54;53;53;54 08:33:26 INFO - PID 24489 | |10;stanford-crypto-aes;79;78;79;77;77;85;76;77;77;76 08:33:26 INFO - PID 24489 | |11;stanford-crypto-ccm;127;134;131;127;139;125;127;122;127;159 08:33:26 INFO - PID 24489 | |12;stanford-crypto-pbkdf2;180;180;182;182;184;187;181;183;180;188 08:33:26 INFO - PID 24489 | |13;stanford-crypto-sha256-iterative;71;72;75;67;72;70;68;67;68;71 08:33:26 INFO - PID 24489 | __end_tp_report 08:33:26 INFO - PID 24489 | __start_cc_report 08:33:26 INFO - PID 24489 | _x_x_mozilla_cycle_collect,925 08:33:26 INFO - PID 24489 | __end_cc_report 08:33:26 INFO - PID 24489 | __startTimestamp1500305606922__endTimestamp 08:33:26 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | ------- Summary: start ------- 08:33:26 INFO - PID 24489 | Number of tests: 14 08:33:26 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | [#0] ai-astar Cycles:10 Average:108.00 Median:109.00 stddev:2.71 (2.5%) stddev-sans-first:1.20 08:33:26 INFO - PID 24489 | Values: 101.0 107.0 109.0 108.0 108.0 111.0 108.0 109.0 109.0 110.0 08:33:26 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:150.50 stddev:21.23 (14.1%) stddev-sans-first:22.51 08:33:26 INFO - PID 24489 | Values: 147.0 120.0 147.0 184.0 122.0 154.0 154.0 124.0 167.0 128.0 08:33:26 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.00 stddev:4.22 (2.6%) stddev-sans-first:4.44 08:33:26 INFO - PID 24489 | Values: 164.0 167.0 164.0 162.0 165.0 163.0 164.0 165.0 177.0 165.0 08:33:26 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | [#3] audio-fft Cycles:10 Average:87.20 Median:74.50 stddev:31.53 (42.3%) stddev-sans-first:33.23 08:33:26 INFO - PID 24489 | Values: 77.0 74.0 74.0 174.0 76.0 74.0 73.0 75.0 100.0 75.0 08:33:26 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:82.00 stddev:27.07 (33.0%) stddev-sans-first:28.05 08:33:26 INFO - PID 24489 | Values: 82.0 82.0 134.0 81.0 81.0 82.0 140.0 82.0 82.0 139.0 08:33:26 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.71 08:33:26 INFO - PID 24489 | Values: 116.0 113.0 114.0 115.0 114.0 114.0 113.0 115.0 114.0 114.0 08:33:26 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 08:33:26 INFO - PID 24489 | Values: 150.0 149.0 149.0 149.0 150.0 151.0 149.0 150.0 152.0 150.0 08:33:26 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:33:26 INFO - PID 24489 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 08:33:26 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 08:33:26 INFO - PID 24489 | Values: 55.0 55.0 55.0 54.0 57.0 55.0 55.0 54.0 56.0 55.0 08:33:26 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 08:33:26 INFO - PID 24489 | Values: 54.0 54.0 54.0 54.0 54.0 54.0 54.0 53.0 53.0 54.0 08:33:26 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:77.50 stddev:2.64 (3.4%) stddev-sans-first:2.78 08:33:26 INFO - PID 24489 | Values: 79.0 78.0 79.0 77.0 77.0 85.0 76.0 77.0 77.0 76.0 08:33:26 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:129.00 stddev:10.71 (8.3%) stddev-sans-first:11.21 08:33:26 INFO - PID 24489 | Values: 127.0 134.0 131.0 127.0 139.0 125.0 127.0 122.0 127.0 159.0 08:33:26 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.70 Median:182.50 stddev:2.87 (1.6%) stddev-sans-first:2.87 08:33:26 INFO - PID 24489 | Values: 180.0 180.0 182.0 182.0 184.0 187.0 181.0 183.0 180.0 188.0 08:33:26 INFO - PID 24489 | 08:33:26 INFO - PID 24489 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:71.00 stddev:2.60 (3.7%) stddev-sans-first:2.74 08:33:26 INFO - PID 24489 | Values: 71.0 72.0 75.0 67.0 72.0 70.0 68.0 67.0 68.0 71.0 08:33:26 INFO - PID 24489 | -------- Summary: end -------- 08:33:26 INFO - PID 24489 | 08:33:27 INFO - PID 24489 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:33:27 INFO - TEST-INFO | 24489: exit 0 08:33:27 INFO - TEST-OK | kraken | took 61086ms 08:33:27 INFO - SUITE-END | took 1172s 08:33:28 INFO - Completed test suite (00:19:32) 08:33:28 INFO - javascript benchmark 08:33:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8258.03003640103, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.7241748242654, 3127.9061628151157, 3140.3248301615163, 3149.7952633078853, 3156.968430315696, 5956.702164891754, 6002.579819412643, 6027.638341699501, 6035.758569657214, 6069.119977603256, 6018.6689732064715, 6070.423309785574, 6075.51395888329, 6083.54373421994, 6092.055731361635, 5559.416261292567, 5603.60774745767, 5613.607047506655, 5618.185363122345, 5643.209950606918, 5550.417206193352, 5622.634528755618, 5626.915596266059, 5634.605577609569, 5650.0959846424375, 5624.325080990287, 5629.971850140764, 5636.943630563704, 5642.492175704186, 5644.125160600113, 5608.915866262009, 5610.410906854803, 5613.522850557708, 5616.52259557938, 5619.213310136563, 5443.374011988632, 5541.5289700375515, 5544.1960915667405, 5596.936582049439, 5601.327840659147, 6032.638041717467, 6036.9396306036815, 6097.420745029215, 6099.48154406876, 6110.847228819271, 6351.142595749561, 6404.231492220917, 6427.2287325520765, 6434.227892652912, 6517.902231466532, 6472.190976127984, 6484.416402523749, 6491.8052458425855, 6491.9350806492275, 6501.414872661436, 5992.041273396236, 6017.338092809788, 6022.759089636409, 6027.578069535134, 6033.909491357633, 5584.972075139598, 6631.568948018364, 6634.601923884486, 6635.004749287597, 6732.4950628703045, 6154.230721159855, 6336.303006669263, 6414.230292364946, 6418.935810641927, 6420.935790642034, 6362.809115726535, 6438.420542151229, 6511.609303441809, 6523.412892839668, 6523.869522609616, 6287.056941458726, 6344.333844946306, 6357.904631430532, 6363.681815909186, 6454.9677251614385, 6328.050792381179, 6342.651154186564, 6359.332270111571, 6372.203474565679, 6425.518086143558, 5120.769565369567, 5227.9805437939995, 5257.579393648499, 5324.5740340772645, 5335.199720042025, 4485.551444855553, 4517.390152329459, 4518.706284091523, 4521.5930566248535, 4523.231050721385, 5517.420670829505, 5522.889542209214, 5531.308586426697, 5551.139573366135, 5560.193771903051, 6463.192100987377, 6473.546851720429, 6478.967605161944, 6479.44924681398, 6490.545661803723, 5463.262459567987, 5482.259894914216, 5549.19536667181, 5550.555955523549, 5553.861153471114, 5611.6071874969175, 5684.431556844283, 5692.971535142297, 5739.598228124075, 5780.306363236438, 6280.057991301342, 6281.874362512815, 6282.340354262828, 6287.748490060438, 6301.0, 6397.328280530477, 6406.935930640634, 6445.806625801233, 6498.415142637185, 6499.967500162564, 6231.9688401557705, 6233.2208473940755, 6240.095186197885, 6288.654124023223, 6315.210598675166, 6348.0, 6374.458171055512, 6382.521310901608, 6466.612003279818, 6477.0, 6493.318201588765, 6499.0901273820755, 6561.540692151694, 6583.934160658332, 6589.604623722592, 6200.162977997912, 6304.401081897213, 6315.368463153648, 6328.841778955563, 6371.299157092623, 6305.5270854687, 6315.747370105328, 6318.589291696209, 6320.1151838743535, 6326.2092238470195, 5867.354590994902, 6255.40573645503, 6257.56197066201, 6261.154744109487, 6263.498920086473, 6250.656213908097, 6298.496120310456, 6342.0, 6387.584806987531, 6392.169018027626, 6089.756409743561, 6109.938900610937, 6124.173236613, 6185.381461853779, 6202.317745047951], "value": 5904.837793004152, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.415244414245, 830.7341650671788, 854.9786255343616, 884.4383816276662, 884.4648987362643, 40386.798066009665, 41502.79248603753, 41605.375919361235, 41635.583644163584, 42058.158836823284, 37740.62259377405, 37849.621503784954, 37880.62119378805, 37967.0, 37975.0, 6819.113515243024, 6957.408620267258, 6973.12835895513, 6979.336962988508, 6990.335918087773, 6886.483513736464, 6997.790066298019, 6998.195207551146, 7000.474964377667, 7005.404540614054, 6944.02783610295, 6960.025596416505, 6964.4080253178545, 6969.860602787941, 6980.406665433445, 6869.690863911136, 6913.792586222421, 6948.9999999999745, 6955.0, 6961.65191740411, 6210.813675589739, 6317.93682063178, 6333.176687030703, 6344.841378965517, 6347.904781428282, 33390.83304583486, 33719.32561348784, 33862.0, 33899.491507627405, 34000.659993400244, 3356.1777364545596, 3384.1032126486502, 3399.8640054397792, 3401.557797486336, 3404.165979335054, 30927.38145237105, 31007.689923100705, 31090.222744431343, 31188.220294492592, 31305.0, 4966.701997880139, 4984.77568509418, 4992.326035985168, 4993.700377977297, 5102.107131252016, 189140.0, 192985.0, 193909.0, 194055.0, 195014.0, 49360.50639493559, 49917.25124123141, 50321.0, 50661.240081398806, 50970.0, 51947.22079168815, 52061.0, 52122.21816672753, 52144.478555213966, 52148.47851521436, 16089.436869709503, 16187.19064046793, 16239.269232884548, 16243.350265989227, 16263.18684065792, 13393.933030334785, 13400.731985360433, 13406.329683515785, 13434.798478022838, 13448.93275533616, 14173.149611023166, 14175.291235438186, 14224.217668028357, 14444.277786110863, 14584.781228281585, 5706.144078388192, 5749.597528172988, 5783.8554036149435, 5828.300603927556, 5851.912221316684, 977.4086677559974, 991.6083147156833, 995.1988649137514, 1026.5175367577226, 1029.330934892326, 22311.059585440405, 22622.208222712125, 22791.316260512212, 22795.544089118124, 22818.31545053651, 1059.6132411669685, 1104.8784633690289, 1105.5080489182396, 1118.3792994887754, 1124.9381284029294, 11712.297262164297, 11982.340971246666, 11989.86096320848, 12181.573644922386, 12261.325627090595, 215165.0, 215556.0, 216061.0, 216117.0, 216565.0, 51055.744721276154, 51166.74416627968, 51222.48777512177, 51247.7437612817, 51325.0, 1418.581518452059, 1469.2433396800657, 1491.2692780537675, 1504.308018311589, 1509.871660908813, 21766.0, 21900.671489927983, 22495.437614059778, 22602.17472815898, 22911.083556657548, 36315.45526817047, 36584.634153658124, 36626.81686591657, 36653.63346366502, 36747.44878826873, 192811.0, 194407.0, 194942.0, 196172.0, 196500.0, 34614.13464663403, 36785.08037299089, 37232.62767372291, 37344.253114937004, 37364.06589835276, 44764.552354476036, 45640.93616809179, 46125.538744612124, 46184.30723539217, 46915.0, 31224.375512490078, 33069.83465082659, 33110.17224569405, 33847.492287616195, 33923.83038084794, 31859.68140318567, 33218.66781332156, 33551.83224083864, 33617.32765344631, 33695.494567581016, 35279.647203528664, 36390.454143188406, 36480.81759591185, 36636.26727465382, 36654.63345366512, 31195.37609247757, 31311.37377252488, 32014.35971280608, 32077.358452830347, 32583.022509324757, 23615.29154125379, 23860.284191474282, 23963.524440919216, 24165.15421960223, 24380.146694865594], "value": 16796.383600205856, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.5765675743193, 564.9265595472588, 575.8617931696391, 579.1457600039942, 593.2584269662922, 21852.235171768993, 22788.658170127463, 22851.97166127526, 22879.31362059137, 22896.198633047825, 24627.138050168247, 25942.48115037698, 27088.18735437935, 27192.45615087697, 27254.863725681393, 6401.647909364983, 6516.185476815398, 6524.967375163117, 6561.2782593914635, 6571.44142747867, 6391.776287829927, 6466.385693359123, 6495.382938620824, 6496.545241833073, 6499.9350006500035, 6129.264488261415, 6259.280182778971, 6373.3945275198785, 6413.03804429337, 6499.642519661416, 6383.0, 6463.515236357245, 6463.547551671385, 6467.902981455282, 6502.7724029658975, 6009.459148676597, 6033.637981721111, 6038.00372938469, 6038.1848450459065, 6057.848553786146, 26922.461550769072, 30045.399092018255, 30247.546286805715, 30437.543436848464, 30509.542356864444, 1916.7029110487897, 1941.7572803399576, 1943.9611207775906, 1949.1813438355925, 1959.3240332085409, 18622.162002709774, 19161.233550658097, 19170.137343819562, 19177.424677259565, 19186.712199317022, 2247.685324054634, 2270.8751018693965, 2305.873176975266, 2313.9652905206435, 2414.8913298901593, 131759.34120329336, 138718.30640846732, 138740.0, 139153.0, 139156.0, 14688.192149431883, 14948.551543453714, 15084.0, 15156.772648410282, 15457.768133478006, 23452.530949380918, 23555.88222058913, 23580.0, 23659.526809463714, 23660.88169559141, 10251.948740256401, 10269.897301026895, 10355.17158627308, 10394.584216631401, 10645.254832161674, 9682.0, 9737.513124343895, 9745.951270243604, 9869.35849169816, 9909.950450247847, 9337.112974267433, 9351.895823439807, 9427.245820334358, 9491.47796871165, 9538.189253913495, 2668.319578507468, 2745.3548416122194, 2776.5835124731047, 2810.1990932584117, 2878.165332053723, 932.2635118256637, 933.3186773655269, 951.538503825644, 960.6205548808322, 986.0927946289431, 19794.70307945382, 20111.29610463656, 20380.286689966077, 23663.29010129699, 25359.366015849384, 1024.8667673202435, 1045.4250162410644, 1047.1256500821898, 1048.7797562511957, 1051.090806452413, 11318.886811131782, 11333.320000799979, 11337.0, 11437.771244575062, 11763.823542646867, 492543.0, 501073.0, 502325.0, 503649.0, 516643.0, 115814.0, 116249.41875290738, 116302.0, 117721.4113929442, 118303.40848295703, 1246.9314187719763, 1256.8805963433458, 1288.890444312225, 1289.6646871813396, 1298.558490113347, 17389.47831565055, 18349.449516514527, 18564.2574297032, 18869.811301886806, 18930.33743819015, 53838.0, 54420.455795441536, 56505.434945651665, 57230.0, 57264.713676431355, 66806.6659666718, 67850.66074669792, 67892.660536697, 67938.3206167932, 68993.65503172453, 14250.216238106588, 14662.706745865236, 15045.849541504445, 15122.0, 15351.0, 22599.20902768395, 22829.77170228343, 23036.4240893979, 23280.53438931178, 23565.410864728517, 17978.5505362367, 18007.63984720272, 18151.45545633633, 18264.543386415447, 18340.72488912694, 16454.259558319663, 16579.171041447637, 16921.661566768842, 17019.48941531756, 17526.474205773848, 20331.0, 20350.898245508677, 20475.692864606746, 20598.38204853857, 20692.482687932923, 14470.855291447371, 14646.194459304841, 15132.394704212149, 15313.310901009705, 15337.76993345123, 19226.134823933236, 19265.8073419264, 19277.325293614656, 19484.707729384354, 19512.707309390655], "value": 12104.2245152364, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.7424089423012, 1400.6218321053316, 1408.2325132802625, 1411.9011669183162, 1416.3343228682515, 13142.868571314284, 13719.725605487884, 13758.38087286072, 13811.861881381195, 13848.653783655402, 13109.27898965559, 13519.32403379832, 13553.254570998592, 13592.72814543711, 13638.0453368264, 2551.0688598661495, 2628.6714160729907, 2629.3952390950094, 2629.815912886099, 2630.2109367189864, 2519.6976362836394, 2605.6091586262023, 2605.895764169431, 2615.228507590256, 2620.1222590432226, 2535.6703628528267, 2569.498947705198, 2579.9742002580015, 2584.508943300776, 2596.0913680211966, 2496.400863792695, 2501.6122501012374, 2502.78726308264, 2513.3465299022205, 2514.9874250628814, 2413.3966508372905, 2446.510697860417, 2447.0945750072588, 2458.4960083182905, 2459.963100553493, 13301.73396532064, 13604.0, 13706.040577159603, 13719.794203086962, 13723.725525489433, 7175.677094530759, 7523.887141692879, 7526.623668816592, 7529.698812047512, 7542.170361260257, 4890.779914903838, 4890.975545122287, 4969.27945447908, 5052.166392545226, 5078.187490001582, 1809.1406581873637, 1855.081734541397, 1891.3569386408549, 1905.3521802587047, 1911.5125642961095, 20350.389488315373, 21017.8949105255, 21027.15891364359, 21137.47156321089, 21200.575988480145, 5746.339170995389, 6229.750809967551, 6496.0255961606135, 6613.0, 6631.204255489372, 15397.230138493254, 15421.151836649093, 15437.15095669749, 15439.691206175814, 15454.613634659223, 7198.604076775723, 7550.131734850453, 7566.9621651892485, 7572.432067594952, 7578.696852125963, 6668.933310666928, 6848.7260509579055, 6854.108965834509, 6891.758788442481, 6896.448284137257, 4992.101421744121, 5150.793968241228, 5152.484751524892, 5199.818006369759, 5216.356847592996, 1404.2417094768914, 1471.5364660132025, 1482.78499617557, 1482.9851701482846, 1496.0500082447725, 841.2891107014563, 856.546030603781, 856.8971723393232, 863.8229163021691, 882.6601758323092, 6664.666766661648, 6671.0, 6683.097781799492, 6766.323367663194, 6794.694238759268, 683.0948992584845, 729.1796728680234, 968.7626531499686, 991.6330957545754, 993.4933184076028, 4757.9532502849315, 5019.698818070928, 5020.472850350734, 5107.41264754558, 5123.974380128076, 17800.0, 18613.162407691685, 18827.529311767314, 18876.90561547211, 19312.90343548273, 17222.224999875034, 17586.12069396525, 18034.549136271435, 18178.18198181085, 18267.451976440727, 9937.80124397508, 10271.435071071162, 10487.842682359771, 10502.842457363146, 10538.894611053945, 7555.622218888923, 7838.529688218725, 7984.161663025298, 7986.680532778624, 8063.233992770677, 15968.28142733603, 16030.759538606697, 16400.17999100064, 16413.17934103266, 16610.418635347705, 15904.284307205971, 16198.595035124215, 16396.26216820222, 16562.50312490627, 16868.57828554247, 10644.308119972176, 10830.296030757976, 10860.511276992713, 10862.837057444303, 11001.779964400826, 12733.172343797623, 12983.480660773463, 13007.804882926574, 13014.80477792815, 13015.349232538147, 9803.80392392134, 9945.850812237966, 10000.549975250986, 10400.791984160425, 10486.108680762221, 9899.604015839286, 10339.276250662382, 10339.948300258451, 10457.058864702214, 10622.52198651078, 8430.915690843012, 8530.530820804915, 8545.914540854512, 8565.229129378386, 8595.570221488775, 6180.567360284737, 6341.778037768656, 6392.264889537577, 6491.318411566717, 6657.0, 5750.539956803529, 6058.606190597597, 6093.586485274295, 6103.3591472894705, 6249.156363890998], "value": 6098.018131889524, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.943886453058, 497.43292646383105, 521.397785557681, 523.5863667702515, 525.9421463639, 6050.485708714754, 6134.171886795281, 6156.661383623905, 6169.784057557987, 6170.488230383562, 5790.507806836414, 6033.939660603392, 6060.393960603938, 6072.696365181734, 6083.634981901078, 4778.378810754597, 4876.0, 4893.119238537062, 4958.256261560777, 4989.3513843200335, 4876.780544875472, 4902.264660300965, 4922.3354847095725, 4939.629527785412, 4979.87952710639, 4912.428023032613, 4926.9753651231695, 4936.136176169174, 4953.752312384385, 4959.975200124012, 4601.953980460203, 4821.590164835993, 4848.878778030542, 4885.143645414755, 4925.408950925876, 4390.27560452525, 4405.070628032355, 4417.712848664826, 4425.911481770347, 4455.173378914662, 5874.971879920997, 5882.529397648178, 5894.646321220697, 5937.228160339171, 5960.122561393147, 5491.039068163055, 5552.500274975271, 5562.805301814457, 5600.663960162403, 5641.802536911188, 6410.166678331833, 6469.450096741735, 6469.902951455732, 6472.5371926019825, 6535.248446428626, 4813.879653008703, 4857.247126695368, 4879.0, 4882.511748825124, 4889.09551732927, 6715.56348837324, 6770.255271920085, 6773.661316934183, 6846.760363387258, 6907.0, 4931.2659846547, 4956.132676781549, 4967.751612419437, 5004.174311238678, 5006.6245031622775, 4990.525900039491, 5015.673981191211, 5018.146915024455, 5051.6716413433005, 5062.341895553554, 5612.1581762735095, 5618.213450116987, 5622.550195984311, 5635.492805647511, 5665.150227465913, 6422.165118534561, 6440.452561532228, 6463.903041454382, 6488.253850807123, 6500.057491663682, 1737.1922056243907, 1753.2285794250488, 1754.649070185968, 1758.0, 1762.524118488001, 1132.7394699219226, 1226.8589112252205, 1231.5566396097397, 1234.6912272990658, 1241.540629966918, 5462.972685136629, 5542.8337149885565, 5576.135698966586, 5581.972090139605, 5701.315842098975, 6542.378474045054, 6552.868942621216, 6592.340765923369, 6623.9070553359115, 6720.697568609425, 5532.3914369419335, 5557.3886872444, 5565.916511252334, 5583.0, 5602.38373778884, 3446.724262059029, 3475.6350583188905, 3475.652434756504, 3528.7120201126404, 3539.5398598182073, 6447.548671592944, 6468.579542329733, 6475.222973243147, 6487.3836985486305, 6497.447716944018, 6718.428933540606, 6838.589684618939, 6854.794356169323, 6858.485613579001, 6889.414399776075, 6381.712822922979, 6412.35876412355, 6438.742450301936, 6451.258105317855, 6455.612663240033, 6558.704858281293, 6599.637019963948, 6602.273749887412, 6636.303188165366, 6713.832154196184, 6490.156279683611, 6525.738970441129, 6568.7372505099265, 6574.868502630016, 6619.470442364503, 6299.811005669837, 6380.202474690664, 6395.20059992501, 6396.520260980352, 6447.451966582893, 4819.421669399694, 4834.20235661126, 4856.1987272099705, 4859.31969524274, 4883.462819089968, 6643.468522518284, 6663.267040625624, 6686.331366863469, 6691.966540167268, 6695.966520167368, 6397.168368112116, 6429.6142231466265, 6456.418922297016, 6480.870382592416, 6500.252470965899, 6373.681315934092, 6375.936240637534, 6435.292117866938, 6521.152250207443, 6529.225079341356, 6326.525510586633, 6354.824357493879, 6393.4885209184085, 6446.226452825691, 6454.870902582016, 5954.880902382015, 6375.458086062737, 6447.290798012309, 6449.0, 6488.545801793829, 6175.413335733098, 6229.2524897012645, 6241.719122639402, 6256.186695729526, 6276.7988325955], "value": 4979.66056217019, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [910.5811326789676, 911.2209061252629, 924.269826836799, 933.043630278964, 943.4952300519224, 17958.551036224086, 18754.812451875496, 18888.527786805338, 18889.527761805926, 18943.33698320559, 19226.51933701658, 20240.39278821634, 21118.0, 21160.153593856267, 21263.0, 1022.8874823769379, 1023.1763430438494, 1041.7760181560964, 1042.3276986343803, 1050.5745173204864, 1028.9794204115913, 1032.339302846179, 1040.8126537223297, 1041.1670663469233, 1042.5100202904662, 1036.8030074285862, 1076.6231818863375, 1078.9695840472368, 1096.2381145104155, 1098.7363032872133, 1075.8171110911164, 1080.135891286975, 1080.3086024944002, 1081.2809481694665, 1083.4528563075596, 794.4359504751633, 796.1322158846884, 798.1220657277007, 798.5767543202112, 799.4723482501521, 18444.446666600023, 19444.416667499998, 19612.607747845104, 19815.900920495304, 19959.80040199594, 18870.622587548172, 18883.244670213313, 19267.710984335245, 19498.220071197276, 19529.902350488297, 14788.852111478962, 15228.390864365412, 15285.465008724641, 15351.07893526392, 15381.154036527987, 3419.760616756828, 3481.425564781808, 3502.597201321855, 3508.386032444312, 3509.0700964244243, 109459.0, 110888.0, 116116.0, 121813.0, 122433.99999999911, 15375.384984600714, 15406.614834629225, 15479.84520154784, 15551.0, 15605.219739013004, 28308.009219677213, 28860.0, 29285.56071658927, 29392.412151756846, 29745.851270743507, 8096.635651395702, 8352.665893364197, 8399.874001889977, 8403.07566167721, 8408.075111737704, 3818.3127037133027, 3935.134270460494, 3940.4680368149934, 3963.841446342172, 3964.1675248198203, 5018.573421259234, 5119.667221630582, 5130.692158470503, 5134.435212126663, 5167.767450464738, 856.246503077288, 888.4358432395476, 894.8926128864578, 901.5852707754507, 980.8970058143935, 624.5565648389694, 653.9738410463623, 669.5079116849112, 684.0764967294114, 692.9826754331182, 11272.38023282397, 11547.0, 11600.767984640428, 11631.88368116325, 11706.70733231676, 657.6054367379534, 674.4132604634, 689.290031267795, 700.1213477086225, 702.8418605813753, 5316.601254905898, 5406.02691515531, 5802.448767367094, 6026.849328766728, 6238.781642642486, 92319.5384023089, 92653.0, 96196.51901740447, 98457.0, 99587.50206248922, 84767.15232847715, 85560.0, 87174.0, 87410.0, 89844.55077724569, 72819.2718072823, 76205.61897190589, 76492.0, 76802.0, 80566.0, 11090.611828585961, 11650.242734222249, 11948.940255298668, 12138.575149869712, 12222.961048310994, 35732.821335894194, 35948.0, 36838.0, 37444.81277593595, 37841.05397365088, 45468.31797522974, 45899.311510326705, 46657.53342466532, 47065.29402058903, 47696.0, 17051.91474042622, 17137.571560711083, 17443.82556174422, 17570.472885813448, 17882.5529361767, 19947.20211191536, 20085.59828803445, 20108.899455503215, 20626.58746825085, 20643.174273029512, 16696.49910502687, 17438.21528031267, 18033.909830451288, 18078.638427231646, 18358.082095895417, 18212.18045187996, 18362.81637183611, 18681.81318186855, 18846.905765471085, 18848.905755471682, 16908.40820571274, 17374.305027798746, 17451.738223926906, 17474.47576572705, 17824.821751782318, 11332.773344533229, 11996.820047699117, 12466.43901024438, 12545.93727031359, 12609.810852837398, 12079.03367730597, 12103.576374826838, 12104.878951210376, 12174.330411827434, 12719.80920286215], "value": 8699.24334887571, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 107.0, 109.0, 108.0, 108.0, 111.0, 108.0, 109.0, 109.0, 110.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 147.0, 184.0, 122.0, 154.0, 154.0, 124.0, 167.0, 128.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 164.0, 162.0, 165.0, 163.0, 164.0, 165.0, 177.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 74.0, 174.0, 76.0, 74.0, 73.0, 75.0, 100.0, 75.0], "value": 87.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 134.0, 81.0, 81.0, 82.0, 140.0, 82.0, 82.0, 139.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 114.0, 115.0, 114.0, 114.0, 113.0, 115.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 149.0, 150.0, 151.0, 149.0, 150.0, 152.0, 150.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 57.0, 55.0, 55.0, 54.0, 56.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 53.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 77.0, 77.0, 85.0, 76.0, 77.0, 77.0, 76.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 134.0, 131.0, 127.0, 139.0, 125.0, 127.0, 122.0, 127.0, 159.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 180.0, 182.0, 182.0, 184.0, 187.0, 181.0, 183.0, 180.0, 188.0], "value": 182.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 75.0, 67.0, 72.0, 70.0, 68.0, 67.0, 68.0, 71.0], "value": 70.1, "unit": "score"}]}]} 08:33:28 INFO - Return code: 0 08:33:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:33:28 INFO - # TBPL SUCCESS # 08:33:28 INFO - Running post-action listener: _package_coverage_data 08:33:28 INFO - Running post-action listener: _resource_record_post_action 08:33:28 INFO - [mozharness: 2017-07-17 15:33:28.194890Z] Finished run-tests step (success) 08:33:28 INFO - Running post-run listener: _resource_record_post_run 08:33:28 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 435306496; Read time: 0; Write time: 281008 08:33:28 INFO - TinderboxPrint: CPU usage
13.1% 08:33:28 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:33:28 INFO - TinderboxPrint: I/O write bytes / time
435,306,496 / 281,008 08:33:28 INFO - TinderboxPrint: CPU idle
8,256.2 (86.9%) 08:33:28 INFO - TinderboxPrint: CPU user
1,195.8 (12.6%) 08:33:28 INFO - TinderboxPrint: Swap in / out
0 / 0 08:33:28 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107352064; Read time: 0; Write time: 89524 08:33:28 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:33:28 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 327954432; Read time: 0; Write time: 191484 08:33:28 INFO - Running post-run listener: _upload_blobber_files 08:33:28 INFO - Blob upload gear active. 08:33:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:33:28 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 08:33:28 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:33:28 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:33:29 INFO - Traceback (most recent call last): 08:33:29 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 08:33:29 INFO - main() 08:33:29 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 08:33:29 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 08:33:29 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 08:33:29 INFO - return set(response.json().get('whitelist', [])) 08:33:29 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 08:33:29 INFO - return json.loads(self.text or self.content, **kwargs) 08:33:29 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 08:33:29 INFO - return _default_decoder.decode(s) 08:33:29 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 08:33:29 INFO - obj, end = self.raw_decode(s) 08:33:29 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 08:33:29 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 08:33:29 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 08:33:29 ERROR - Return code: 1 08:33:29 INFO - Setting buildbot property blobber_files to {} 08:33:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:33:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:33:29 INFO - Contents: 08:33:29 INFO - blobber_files:{} 08:33:29 INFO - Running post-run listener: copy_logs_to_upload_dir 08:33:29 INFO - Copying logs to upload dir... 08:33:29 INFO - mkdir: /builds/slave/test/build/upload/logs 08:33:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.204537 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-07-17 08:33:28.979500) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 08:33:28.987465) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011386 build_url: 'https://queue.taskcluster.net/v1/task/ayuRFLoYT6GffaIWWJf5NQ/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 08:33:29.040953) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 08:33:29.041314) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500298806.204476-1595913603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 08:33:29.090848) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 08:33:29.091160) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 08:33:29.091462) ========= ========= Total master_lag: 0.18 =========