builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1502993098.8 results: success (0) revision: f53a37fc0e92c093bf48baada9f9adab16422cd7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 11:04:58.803908) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 11:04:58.804324) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 11:04:58.804592) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 11:04:58.820309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:04:58.820578) ========= 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=db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-17 11:04:58-- 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% 123M=0s 2017-08-17 11:04:59 (123 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156366 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:04:58.994332) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:04:58.994640) ========= 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=db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020068 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:04:59.043616) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:04:59.043911) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f53a37fc0e92c093bf48baada9f9adab16422cd7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev f53a37fc0e92c093bf48baada9f9adab16422cd7 --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=db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-17 11:04:59,269 truncating revision to first 12 chars 2017-08-17 11:04:59,269 Setting DEBUG logging. 2017-08-17 11:04:59,269 attempt 1/10 2017-08-17 11:04:59,269 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f53a37fc0e92?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-17 11:04:59,734 unpacking tar archive at: mozilla-central-f53a37fc0e92/testing/mozharness/ program finished with exit code 0 elapsedTime=0.775198 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:04:59.835293) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 11:04:59.835648) ========= script_repo_revision: f53a37fc0e92c093bf48baada9f9adab16422cd7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 11:04:59.836057) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 11:04:59.836336) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 11:04:59.846597) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-17 11:04:59.846880) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:05:00 INFO - MultiFileLogger online at 20170817 11:05:00 in /builds/slave/test 11:05:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:05:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:05:00 INFO - {'append_to_log': False, 11:05:00 INFO - 'base_work_dir': '/builds/slave/test', 11:05:00 INFO - 'blob_upload_branch': 'Firefox', 11:05:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:05:00 INFO - 'branch': 'Firefox', 11:05:00 INFO - 'buildbot_json_path': 'buildprops.json', 11:05:00 INFO - 'code_coverage': False, 11:05:00 INFO - 'config_files': ('talos/linux_config.py',), 11:05:00 INFO - 'default_actions': ('clobber', 11:05:00 INFO - 'read-buildbot-config', 11:05:00 INFO - 'download-and-extract', 11:05:00 INFO - 'populate-webroot', 11:05:00 INFO - 'create-virtualenv', 11:05:00 INFO - 'install', 11:05:00 INFO - 'setup-mitmproxy', 11:05:00 INFO - 'run-tests'), 11:05:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:05:00 INFO - 'disable_ccov_upload': False, 11:05:00 INFO - 'download_minidump_stackwalk': True, 11:05:00 INFO - 'download_symbols': 'ondemand', 11:05:00 INFO - 'enable_stylo': False, 11:05:00 INFO - 'enable_webrender': False, 11:05:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:05:00 INFO - 'tooltool.py': '/tools/tooltool.py', 11:05:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:05:00 INFO - '/tools/misc-python/virtualenv.py')}, 11:05:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:05:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:05:00 INFO - 'gecko_profile': False, 11:05:00 INFO - 'gecko_profile_interval': 0, 11:05:00 INFO - 'installer_path': 'installer.exe', 11:05:00 INFO - 'log_level': 'info', 11:05:00 INFO - 'log_name': 'talos', 11:05:00 INFO - 'log_to_console': True, 11:05:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:05:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:05:00 INFO - 'opt_config_files': (), 11:05:00 INFO - 'pip_index': False, 11:05:00 INFO - 'suite': 'dromaeojs-e10s', 11:05:00 INFO - 'system_bits': '32', 11:05:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:05:00 INFO - 'title': 'talos-linux64-ix-049', 11:05:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:05:00 INFO - 'use_talos_json': True, 11:05:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:05:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:05:00 INFO - 'work_dir': 'build'} 11:05:00 INFO - [mozharness: 2017-08-17 18:05:00.169827Z] Running clobber step. 11:05:00 INFO - Running pre-action listener: _resource_record_pre_action 11:05:00 INFO - Running main action method: clobber 11:05:00 INFO - rmtree: /builds/slave/test/build 11:05:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:05:01 INFO - Running post-action listener: _resource_record_post_action 11:05:01 INFO - [mozharness: 2017-08-17 18:05:01.202145Z] Finished clobber step (success) 11:05:01 INFO - [mozharness: 2017-08-17 18:05:01.202248Z] Running read-buildbot-config step. 11:05:01 INFO - Running pre-action listener: _resource_record_pre_action 11:05:01 INFO - Running main action method: read_buildbot_config 11:05:01 INFO - Using buildbot properties: 11:05:01 INFO - { 11:05:01 INFO - "project": "", 11:05:01 INFO - "product": "firefox", 11:05:01 INFO - "who": "ffxbld@noreply.mozilla.org", 11:05:01 INFO - "installer_path": "public/build/target.tar.bz2", 11:05:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 11:05:01 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:05:01 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 11:05:01 INFO - "stage_platform": "linux64-stylo", 11:05:01 INFO - "basedir": "/builds/slave/test", 11:05:01 INFO - "buildnumber": 38, 11:05:01 INFO - "platform": "ubuntu64_hw_stylo", 11:05:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:05:01 INFO - "slavebuilddir": "test", 11:05:01 INFO - "taskId": "Q9g1W2RZQ3Ka8J9OK7O7fw", 11:05:01 INFO - "branch": "mozilla-central", 11:05:01 INFO - "script_repo_revision": "production", 11:05:01 INFO - "revision": "f53a37fc0e92c093bf48baada9f9adab16422cd7", 11:05:01 INFO - "slavename": "talos-linux64-ix-049", 11:05:01 INFO - "repo_path": "mozilla-central" 11:05:01 INFO - } 11:05:01 INFO - Finding installer, test and symbols from parent task. 11:05:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q9g1W2RZQ3Ka8J9OK7O7fw'}, attempt #1 11:05:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q9g1W2RZQ3Ka8J9OK7O7fw'}, attempt #1 11:05:02 INFO - Task dependencies: cTdeNkkcRCqHXVCQPBeYMQ 11:05:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ'}, attempt #1 11:05:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.tar.bz2 11:05:02 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.test_packages.json 11:05:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.crashreporter-symbols.zip 11:05:02 INFO - Running post-action listener: _resource_record_post_action 11:05:02 INFO - [mozharness: 2017-08-17 18:05:02.619243Z] Finished read-buildbot-config step (success) 11:05:02 INFO - [mozharness: 2017-08-17 18:05:02.619468Z] Running download-and-extract step. 11:05:02 INFO - Running pre-action listener: _resource_record_pre_action 11:05:02 INFO - Running main action method: download_and_extract 11:05:02 INFO - mkdir: /builds/slave/test/build/tests 11:05:02 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')]} 11:05:02 INFO - trying https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.test_packages.json 11:05:02 INFO - Downloading https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:05:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:05:03 INFO - Downloaded 989 bytes. 11:05:03 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:05:03 INFO - Using the following test package requirements: 11:05:03 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:05:03 INFO - u'common': [u'target.common.tests.zip'], 11:05:03 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:05:03 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:05:03 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:05:03 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:05:03 INFO - u'mozbase': [u'target.common.tests.zip'], 11:05:03 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:05:03 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:05:03 INFO - u'web-platform': [u'target.common.tests.zip', 11:05:03 INFO - u'target.web-platform.tests.tar.gz'], 11:05:03 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:05:03 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:05:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.common.tests.zip 11:05:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:05:03 INFO - Fetch https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.common.tests.zip into memory 11:05:04 INFO - Content-Length response header: 53999443 11:05:04 INFO - Bytes received: 53999443 11:05:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:05:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.common.tests.zip 11:05:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:05:15 INFO - Fetch https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.common.tests.zip into memory 11:05:16 INFO - Content-Length response header: 53999443 11:05:16 INFO - Bytes received: 53999443 11:05:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.talos.tests.zip 11:05:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:05:28 INFO - Fetch https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.talos.tests.zip into memory 11:05:28 INFO - Content-Length response header: 14496161 11:05:28 INFO - Bytes received: 14496161 11:05:29 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')]} 11:05:29 INFO - trying https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.tar.bz2 11:05:29 INFO - Downloading https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:05:30 INFO - Downloaded 62259900 bytes. 11:05:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.tar.bz2 11:05:30 INFO - mkdir: /builds/slave/test/properties 11:05:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:05:30 INFO - Writing to file /builds/slave/test/properties/build_url 11:05:30 INFO - Contents: 11:05:30 INFO - build_url:https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.tar.bz2 11:05:30 INFO - Running post-action listener: _resource_record_post_action 11:05:30 INFO - Running post-action listener: set_extra_try_arguments 11:05:30 INFO - [mozharness: 2017-08-17 18:05:30.270339Z] Finished download-and-extract step (success) 11:05:30 INFO - [mozharness: 2017-08-17 18:05:30.270438Z] Running populate-webroot step. 11:05:30 INFO - Running pre-action listener: _resource_record_pre_action 11:05:30 INFO - Running main action method: populate_webroot 11:05:30 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:05:30 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:05:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:05:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:05:30 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:05:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:05:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:05:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:30 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:05:30 INFO - 'talos_options': ['--stylo'], 11:05:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:05:30 INFO - 'tests': ['damp', 'tps']}, 11:05:30 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:05:30 INFO - 'talos_options': ['--stylo'], 11:05:30 INFO - 'tests': ['damp', 'tps']}, 11:05:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:05:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:05:30 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:05:30 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:05:30 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:05:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:05:30 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:05:30 INFO - 'talos_options': ['--stylo'], 11:05:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:05:30 INFO - 'other-e10s': {'tests': ['a11yr', 11:05:30 INFO - 'ts_paint', 11:05:30 INFO - 'tpaint', 11:05:30 INFO - 'sessionrestore', 11:05:30 INFO - 'sessionrestore_many_windows', 11:05:30 INFO - 'sessionrestore_no_auto_restore', 11:05:30 INFO - 'tabpaint']}, 11:05:30 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:05:30 INFO - 'tests': ['a11yr', 11:05:30 INFO - 'ts_paint', 11:05:30 INFO - 'tpaint', 11:05:30 INFO - 'sessionrestore', 11:05:30 INFO - 'sessionrestore_many_windows', 11:05:30 INFO - 'sessionrestore_no_auto_restore', 11:05:30 INFO - 'tabpaint']}, 11:05:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:05:30 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:05:30 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:05:30 INFO - 'tests': ['bloom_basic_singleton']}, 11:05:30 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:05:30 INFO - 'tests': ['bloom_basic']}, 11:05:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:05:30 INFO - 'tsvgr_opacity', 11:05:30 INFO - 'tart', 11:05:30 INFO - 'tscrollx', 11:05:30 INFO - 'tsvg_static']}, 11:05:30 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:05:30 INFO - 'tests': ['tsvgx', 11:05:30 INFO - 'tsvgr_opacity', 11:05:30 INFO - 'tart', 11:05:30 INFO - 'tscrollx', 11:05:30 INFO - 'tsvg_static']}, 11:05:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:05:30 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:05:30 INFO - 'talos_options': ['--stylo'], 11:05:30 INFO - 'tests': ['tp5o']}, 11:05:30 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:05:30 INFO - 'talos_options': ['--mitmproxy', 11:05:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:05:30 INFO - '--firstNonBlankPaint'], 11:05:30 INFO - 'tests': ['tp6_google', 11:05:30 INFO - 'tp6_youtube', 11:05:30 INFO - 'tp6_amazon', 11:05:30 INFO - 'tp6_facebook']}, 11:05:30 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:05:30 INFO - 'talos_options': ['--stylo', 11:05:30 INFO - '--mitmproxy', 11:05:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:05:30 INFO - '--firstNonBlankPaint'], 11:05:30 INFO - 'tests': ['tp6_google', 11:05:30 INFO - 'tp6_youtube', 11:05:30 INFO - 'tp6_amazon', 11:05:30 INFO - 'tp6_facebook']}, 11:05:30 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:05:30 INFO - 'talos_options': ['--stylo', 11:05:30 INFO - '--stylo-threads=1', 11:05:30 INFO - '--mitmproxy', 11:05:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:05:30 INFO - '--firstNonBlankPaint'], 11:05:30 INFO - 'tests': ['tp6_google', 11:05:30 INFO - 'tp6_youtube', 11:05:30 INFO - 'tp6_amazon', 11:05:30 INFO - 'tp6_facebook']}, 11:05:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:05:30 INFO - 'talos_options': ['--xperf_path', 11:05:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:30 INFO - 'tests': ['tp5n']}, 11:05:30 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:05:30 INFO - 'talos_options': ['--stylo', 11:05:30 INFO - '--xperf_path', 11:05:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:30 INFO - 'tests': ['tp5n']}}} 11:05:30 INFO - Running post-action listener: _resource_record_post_action 11:05:30 INFO - [mozharness: 2017-08-17 18:05:30.284764Z] Finished populate-webroot step (success) 11:05:30 INFO - [mozharness: 2017-08-17 18:05:30.284854Z] Running create-virtualenv step. 11:05:30 INFO - Running pre-action listener: _resource_record_pre_action 11:05:30 INFO - Running main action method: create_virtualenv 11:05:30 INFO - Creating virtualenv /builds/slave/test/build/venv 11:05:30 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 11:05:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:05:30 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:05:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:05:30 INFO - Using real prefix '/usr' 11:05:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:05:30 INFO - Installing distribute.............................................................................................................................................................................................done. 11:05:32 INFO - Installing pip.................done. 11:05:32 INFO - Return code: 0 11:05:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:05:33 INFO - Reading from file tmpfile_stdout 11:05:33 INFO - Output received: 11:05:33 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) 11:05:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:05: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')]} 11:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05: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')]} 11:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:33 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 0x17fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa00b0>, '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 0x1aa0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', '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 11:05:33 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 11:05:33 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 11:05:33 INFO - Using env: {'DISPLAY': ':0', 11:05:33 INFO - 'HOME': '/home/cltbld', 11:05:33 INFO - 'LANG': 'en_US.UTF-8', 11:05:33 INFO - 'LANGUAGE': 'en_US:en', 11:05:33 INFO - 'LOGNAME': 'cltbld', 11:05:33 INFO - 'MAIL': '/var/mail/cltbld', 11:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:33 INFO - 'MOZ_NO_REMOTE': '1', 11:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:33 INFO - 'NO_EM_RESTART': '1', 11:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:33 INFO - 'PWD': '/builds/slave/test', 11:05:33 INFO - 'SHELL': '/bin/bash', 11:05:33 INFO - 'SHLVL': '1', 11:05:33 INFO - 'TERM': 'linux', 11:05:33 INFO - 'TMOUT': '86400', 11:05:33 INFO - 'USER': 'cltbld', 11:05:33 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', 11:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:33 INFO - '_': '/tools/buildbot/bin/python'} 11:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:33 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 11:05:33 INFO - Cleaning up... 11:05:33 INFO - Return code: 0 11:05:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:05: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')]} 11:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05: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')]} 11:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:33 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 0x17fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa00b0>, '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 0x1aa0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', '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 11:05:33 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 11:05:33 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 11:05:33 INFO - Using env: {'DISPLAY': ':0', 11:05:33 INFO - 'HOME': '/home/cltbld', 11:05:33 INFO - 'LANG': 'en_US.UTF-8', 11:05:33 INFO - 'LANGUAGE': 'en_US:en', 11:05:33 INFO - 'LOGNAME': 'cltbld', 11:05:33 INFO - 'MAIL': '/var/mail/cltbld', 11:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:33 INFO - 'MOZ_NO_REMOTE': '1', 11:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:33 INFO - 'NO_EM_RESTART': '1', 11:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:33 INFO - 'PWD': '/builds/slave/test', 11:05:33 INFO - 'SHELL': '/bin/bash', 11:05:33 INFO - 'SHLVL': '1', 11:05:33 INFO - 'TERM': 'linux', 11:05:33 INFO - 'TMOUT': '86400', 11:05:33 INFO - 'USER': 'cltbld', 11:05:33 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', 11:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:33 INFO - '_': '/tools/buildbot/bin/python'} 11:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:33 INFO - Downloading/unpacking psutil>=3.1.1 11:05: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 11:05: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 11:05: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 11:05: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 11:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:05:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:34 INFO - Installing collected packages: psutil 11:05:34 INFO - Running setup.py install for psutil 11:05:34 INFO - building 'psutil._psutil_linux' extension 11:05:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:05:34 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 11:05:34 INFO - building 'psutil._psutil_posix' extension 11:05:34 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 11:05:35 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 11:05:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:35 INFO - Successfully installed psutil 11:05:35 INFO - Cleaning up... 11:05:35 INFO - Return code: 0 11:05:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:05:35 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')]} 11:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:35 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')]} 11:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:35 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 0x17fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa00b0>, '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 0x1aa0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', '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 11:05:35 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 11:05:35 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 11:05:35 INFO - Using env: {'DISPLAY': ':0', 11:05:35 INFO - 'HOME': '/home/cltbld', 11:05:35 INFO - 'LANG': 'en_US.UTF-8', 11:05:35 INFO - 'LANGUAGE': 'en_US:en', 11:05:35 INFO - 'LOGNAME': 'cltbld', 11:05:35 INFO - 'MAIL': '/var/mail/cltbld', 11:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:35 INFO - 'MOZ_NO_REMOTE': '1', 11:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:35 INFO - 'NO_EM_RESTART': '1', 11:05:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:35 INFO - 'PWD': '/builds/slave/test', 11:05:35 INFO - 'SHELL': '/bin/bash', 11:05:35 INFO - 'SHLVL': '1', 11:05:35 INFO - 'TERM': 'linux', 11:05:35 INFO - 'TMOUT': '86400', 11:05:35 INFO - 'USER': 'cltbld', 11:05:35 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', 11:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:35 INFO - '_': '/tools/buildbot/bin/python'} 11:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:05: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 11:05: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 11:05: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 11:05: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 11:05:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:05:36 INFO - Installing collected packages: mozsystemmonitor 11:05:36 INFO - Running setup.py install for mozsystemmonitor 11:05:36 INFO - Successfully installed mozsystemmonitor 11:05:36 INFO - Cleaning up... 11:05:36 INFO - Return code: 0 11:05:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:05: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')]} 11:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05: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')]} 11:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa00b0>, '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 0x1aa0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', '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 11:05: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==2.5.1'] in /builds/slave/test/build 11:05: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==2.5.1 11:05:36 INFO - Using env: {'DISPLAY': ':0', 11:05:36 INFO - 'HOME': '/home/cltbld', 11:05:36 INFO - 'LANG': 'en_US.UTF-8', 11:05:36 INFO - 'LANGUAGE': 'en_US:en', 11:05:36 INFO - 'LOGNAME': 'cltbld', 11:05:36 INFO - 'MAIL': '/var/mail/cltbld', 11:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:36 INFO - 'MOZ_NO_REMOTE': '1', 11:05:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:36 INFO - 'NO_EM_RESTART': '1', 11:05:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:36 INFO - 'PWD': '/builds/slave/test', 11:05:36 INFO - 'SHELL': '/bin/bash', 11:05:36 INFO - 'SHLVL': '1', 11:05:36 INFO - 'TERM': 'linux', 11:05:36 INFO - 'TMOUT': '86400', 11:05:36 INFO - 'USER': 'cltbld', 11:05:36 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', 11:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:36 INFO - '_': '/tools/buildbot/bin/python'} 11:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:36 INFO - Downloading/unpacking jsonschema==2.5.1 11:05:36 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 11:05:36 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 11:05:36 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 11:05:36 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 11:05:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:05:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:38 INFO - Downloading functools32-3.2.3-2.tar.gz 11:05:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:05:38 INFO - warning: no files found matching '*.txt' 11:05:38 INFO - no previously-included directories found matching 'build' 11:05:38 INFO - no previously-included directories found matching 'dist' 11:05:38 INFO - no previously-included directories found matching '.git*' 11:05:38 INFO - Installing collected packages: jsonschema, functools32 11:05:38 INFO - Running setup.py install for functools32 11:05:38 INFO - warning: no files found matching '*.txt' 11:05:38 INFO - no previously-included directories found matching 'build' 11:05:38 INFO - no previously-included directories found matching 'dist' 11:05:38 INFO - no previously-included directories found matching '.git*' 11:05:38 INFO - Successfully installed jsonschema functools32 11:05:38 INFO - Cleaning up... 11:05:38 INFO - Return code: 0 11:05:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa00b0>, '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 0x1aa0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', '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 11:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:05:38 INFO - Using env: {'DISPLAY': ':0', 11:05:38 INFO - 'HOME': '/home/cltbld', 11:05:38 INFO - 'LANG': 'en_US.UTF-8', 11:05:38 INFO - 'LANGUAGE': 'en_US:en', 11:05:38 INFO - 'LOGNAME': 'cltbld', 11:05:38 INFO - 'MAIL': '/var/mail/cltbld', 11:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:38 INFO - 'MOZ_NO_REMOTE': '1', 11:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:38 INFO - 'NO_EM_RESTART': '1', 11:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:38 INFO - 'PWD': '/builds/slave/test', 11:05:38 INFO - 'SHELL': '/bin/bash', 11:05:38 INFO - 'SHLVL': '1', 11:05:38 INFO - 'TERM': 'linux', 11:05:38 INFO - 'TMOUT': '86400', 11:05:38 INFO - 'USER': 'cltbld', 11:05:38 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', 11:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:38 INFO - '_': '/tools/buildbot/bin/python'} 11:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:05:38 INFO - Cleaning up... 11:05:38 INFO - Return code: 0 11:05:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa00b0>, '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 0x1aa0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', '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 11:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:05:38 INFO - Using env: {'DISPLAY': ':0', 11:05:38 INFO - 'HOME': '/home/cltbld', 11:05:38 INFO - 'LANG': 'en_US.UTF-8', 11:05:38 INFO - 'LANGUAGE': 'en_US:en', 11:05:38 INFO - 'LOGNAME': 'cltbld', 11:05:38 INFO - 'MAIL': '/var/mail/cltbld', 11:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:38 INFO - 'MOZ_NO_REMOTE': '1', 11:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:38 INFO - 'NO_EM_RESTART': '1', 11:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:38 INFO - 'PWD': '/builds/slave/test', 11:05:38 INFO - 'SHELL': '/bin/bash', 11:05:38 INFO - 'SHLVL': '1', 11:05:38 INFO - 'TERM': 'linux', 11:05:38 INFO - 'TMOUT': '86400', 11:05:38 INFO - 'USER': 'cltbld', 11:05:38 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', 11:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:38 INFO - '_': '/tools/buildbot/bin/python'} 11:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:38 INFO - Downloading/unpacking blobuploader==1.2.4 11:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:39 INFO - Downloading blobuploader-1.2.4.tar.gz 11:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:05:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:05:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:40 INFO - Downloading docopt-0.6.1.tar.gz 11:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:05:40 INFO - Installing collected packages: blobuploader, requests, docopt 11:05:40 INFO - Running setup.py install for blobuploader 11:05:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:05:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:05:40 INFO - Running setup.py install for requests 11:05:41 INFO - Running setup.py install for docopt 11:05:41 INFO - Successfully installed blobuploader requests docopt 11:05:41 INFO - Cleaning up... 11:05:41 INFO - Return code: 0 11:05:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:41 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')]} 11:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:41 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')]} 11:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:41 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 0x17fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa00b0>, '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 0x1aa0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', '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 11:05:41 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 11:05:41 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 11:05:41 INFO - Using env: {'DISPLAY': ':0', 11:05:41 INFO - 'HOME': '/home/cltbld', 11:05:41 INFO - 'LANG': 'en_US.UTF-8', 11:05:41 INFO - 'LANGUAGE': 'en_US:en', 11:05:41 INFO - 'LOGNAME': 'cltbld', 11:05:41 INFO - 'MAIL': '/var/mail/cltbld', 11:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:41 INFO - 'MOZ_NO_REMOTE': '1', 11:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:41 INFO - 'NO_EM_RESTART': '1', 11:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:41 INFO - 'PWD': '/builds/slave/test', 11:05:41 INFO - 'SHELL': '/bin/bash', 11:05:41 INFO - 'SHLVL': '1', 11:05:41 INFO - 'TERM': 'linux', 11:05:41 INFO - 'TMOUT': '86400', 11:05:41 INFO - 'USER': 'cltbld', 11:05:41 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', 11:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:41 INFO - '_': '/tools/buildbot/bin/python'} 11:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:41 INFO - Running setup.py (path:/tmp/pip-gAs331-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:41 INFO - Running setup.py (path:/tmp/pip-yoYFKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:41 INFO - Running setup.py (path:/tmp/pip-hA0yy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:41 INFO - Running setup.py (path:/tmp/pip-j9CY03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:41 INFO - Running setup.py (path:/tmp/pip-1pGnzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:41 INFO - Running setup.py (path:/tmp/pip-bsYTSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:41 INFO - Running setup.py (path:/tmp/pip-y40Cfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:41 INFO - Running setup.py (path:/tmp/pip-JwpSC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:42 INFO - Running setup.py (path:/tmp/pip-HtMnaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:42 INFO - Running setup.py (path:/tmp/pip-u_QoNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:42 INFO - Running setup.py (path:/tmp/pip-4T32I_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:42 INFO - Running setup.py (path:/tmp/pip-Xb0vjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:42 INFO - Running setup.py (path:/tmp/pip-km7mrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:42 INFO - Running setup.py (path:/tmp/pip-9phhr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:42 INFO - Running setup.py (path:/tmp/pip-LSdqZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:42 INFO - Running setup.py (path:/tmp/pip-jxg4Bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:42 INFO - Running setup.py (path:/tmp/pip-glhBke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:05:42 INFO - Running setup.py install for manifestparser 11:05:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:05:42 INFO - Running setup.py install for mozcrash 11:05:42 INFO - Running setup.py install for mozdebug 11:05:42 INFO - Running setup.py install for mozdevice 11:05:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:05:43 INFO - Running setup.py install for mozfile 11:05:43 INFO - Running setup.py install for mozhttpd 11:05:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:05:43 INFO - Running setup.py install for mozinfo 11:05:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:05:43 INFO - Running setup.py install for mozInstall 11:05:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:05:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:05:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:05:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:05:43 INFO - Running setup.py install for mozleak 11:05:43 INFO - Running setup.py install for mozlog 11:05:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:05:43 INFO - Running setup.py install for moznetwork 11:05:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:05:43 INFO - Running setup.py install for mozprocess 11:05:43 INFO - Running setup.py install for mozprofile 11:05:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:05:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:05:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:05:44 INFO - Running setup.py install for mozrunner 11:05:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:05:44 INFO - Running setup.py install for mozscreenshot 11:05:44 INFO - Running setup.py install for moztest 11:05:44 INFO - Running setup.py install for mozversion 11:05:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:05:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:05:44 INFO - Cleaning up... 11:05:44 INFO - Return code: 0 11:05:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:44 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')]} 11:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:44 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')]} 11:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:44 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 0x17fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa00b0>, '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 0x1aa0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', '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 11:05:44 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 11:05:44 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 11:05:44 INFO - Using env: {'DISPLAY': ':0', 11:05:44 INFO - 'HOME': '/home/cltbld', 11:05:44 INFO - 'LANG': 'en_US.UTF-8', 11:05:44 INFO - 'LANGUAGE': 'en_US:en', 11:05:44 INFO - 'LOGNAME': 'cltbld', 11:05:44 INFO - 'MAIL': '/var/mail/cltbld', 11:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:44 INFO - 'MOZ_NO_REMOTE': '1', 11:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:44 INFO - 'NO_EM_RESTART': '1', 11:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:44 INFO - 'PWD': '/builds/slave/test', 11:05:44 INFO - 'SHELL': '/bin/bash', 11:05:44 INFO - 'SHLVL': '1', 11:05:44 INFO - 'TERM': 'linux', 11:05:44 INFO - 'TMOUT': '86400', 11:05:44 INFO - 'USER': 'cltbld', 11:05:44 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', 11:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:44 INFO - '_': '/tools/buildbot/bin/python'} 11:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:44 INFO - Running setup.py (path:/tmp/pip-DsW2C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:44 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)) 11:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:44 INFO - Running setup.py (path:/tmp/pip-1p9xiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:44 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)) 11:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:44 INFO - Running setup.py (path:/tmp/pip-wHCPAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:44 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)) 11:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:44 INFO - Running setup.py (path:/tmp/pip-6e9TNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:44 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)) 11:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:44 INFO - Running setup.py (path:/tmp/pip-pt54k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:45 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)) 11:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:45 INFO - Running setup.py (path:/tmp/pip-0Td6yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:45 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)) 11:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:45 INFO - Running setup.py (path:/tmp/pip-ALR0L0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:45 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)) 11:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:45 INFO - Running setup.py (path:/tmp/pip-tUrYbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:45 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)) 11:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:45 INFO - Running setup.py (path:/tmp/pip-AbQPKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:45 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)) 11:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:45 INFO - Running setup.py (path:/tmp/pip-XPLMNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:45 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)) 11:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:45 INFO - Running setup.py (path:/tmp/pip-RtJElM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:45 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)) 11:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:45 INFO - Running setup.py (path:/tmp/pip-8oVHC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:45 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)) 11:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:45 INFO - Running setup.py (path:/tmp/pip-3dl436-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:45 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)) 11:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:45 INFO - Running setup.py (path:/tmp/pip-Vuu29R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:45 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)) 11:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:45 INFO - Running setup.py (path:/tmp/pip-oZ7DMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:45 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)) 11:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:45 INFO - Running setup.py (path:/tmp/pip-bKq7wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:45 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)) 11:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:45 INFO - Running setup.py (path:/tmp/pip-b4T0Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:45 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)) 11:05:45 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)) 11:05:45 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)) 11:05:45 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)) 11:05:45 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)) 11:05:45 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)) 11:05:45 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)) 11:05:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:05:45 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 11:05:45 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 11:05:45 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 11:05:45 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 11:05:46 INFO - Downloading blessings-1.6.tar.gz 11:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:05:47 INFO - Installing collected packages: blessings 11:05:47 INFO - Running setup.py install for blessings 11:05:47 INFO - Successfully installed blessings 11:05:47 INFO - Cleaning up... 11:05:47 INFO - Return code: 0 11:05:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:05:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:05:47 INFO - Reading from file tmpfile_stdout 11:05:47 INFO - Current package versions: 11:05:47 INFO - argparse == 1.2.1 11:05:47 INFO - blessings == 1.6 11:05:47 INFO - blobuploader == 1.2.4 11:05:47 INFO - docopt == 0.6.1 11:05:47 INFO - functools32 == 3.2.3-2 11:05:47 INFO - jsonschema == 2.5.1 11:05:47 INFO - manifestparser == 1.1 11:05:47 INFO - mozInstall == 1.13 11:05:47 INFO - mozcrash == 1.0 11:05:47 INFO - mozdebug == 0.1 11:05:47 INFO - mozdevice == 0.51 11:05:47 INFO - mozfile == 1.2 11:05:47 INFO - mozhttpd == 0.7 11:05:47 INFO - mozinfo == 0.10 11:05:47 INFO - mozleak == 0.1 11:05:47 INFO - mozlog == 3.5 11:05:47 INFO - moznetwork == 0.27 11:05:47 INFO - mozprocess == 0.25 11:05:47 INFO - mozprofile == 0.28 11:05:47 INFO - mozrunner == 6.13 11:05:47 INFO - mozscreenshot == 0.1 11:05:47 INFO - mozsystemmonitor == 0.3 11:05:47 INFO - moztest == 0.8 11:05:47 INFO - mozversion == 1.4 11:05:47 INFO - psutil == 3.1.1 11:05:47 INFO - requests == 1.2.3 11:05:47 INFO - wsgiref == 0.1.2 11:05:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:47 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')]} 11:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:47 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')]} 11:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:47 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 0x17fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa00b0>, '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 0x1aa0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', '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 11:05:47 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 11:05:47 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 11:05:47 INFO - Using env: {'DISPLAY': ':0', 11:05:47 INFO - 'HOME': '/home/cltbld', 11:05:47 INFO - 'LANG': 'en_US.UTF-8', 11:05:47 INFO - 'LANGUAGE': 'en_US:en', 11:05:47 INFO - 'LOGNAME': 'cltbld', 11:05:47 INFO - 'MAIL': '/var/mail/cltbld', 11:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:47 INFO - 'MOZ_NO_REMOTE': '1', 11:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:47 INFO - 'NO_EM_RESTART': '1', 11:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:47 INFO - 'PWD': '/builds/slave/test', 11:05:47 INFO - 'SHELL': '/bin/bash', 11:05:47 INFO - 'SHLVL': '1', 11:05:47 INFO - 'TERM': 'linux', 11:05:47 INFO - 'TMOUT': '86400', 11:05:47 INFO - 'USER': 'cltbld', 11:05:47 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', 11:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:47 INFO - '_': '/tools/buildbot/bin/python'} 11:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:47 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)) 11:05:47 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)) 11:05:47 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)) 11:05:47 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)) 11:05:47 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)) 11:05:47 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)) 11:05:47 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)) 11:05:47 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)) 11:05:47 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)) 11:05:47 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:05:48 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)) 11:05:48 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)) 11:05:48 INFO - Installing collected packages: simplejson 11:05:48 INFO - Running setup.py install for simplejson 11:05:48 INFO - building 'simplejson._speedups' extension 11:05:48 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 11:05:49 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 11:05:49 INFO - Successfully installed simplejson 11:05:49 INFO - Cleaning up... 11:05:49 INFO - Return code: 0 11:05:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:49 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 0x17fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa2ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa00b0>, '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 0x1aa0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', '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 11:05:49 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 11:05:49 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 11:05:49 INFO - Using env: {'DISPLAY': ':0', 11:05:49 INFO - 'HOME': '/home/cltbld', 11:05:49 INFO - 'LANG': 'en_US.UTF-8', 11:05:49 INFO - 'LANGUAGE': 'en_US:en', 11:05:49 INFO - 'LOGNAME': 'cltbld', 11:05:49 INFO - 'MAIL': '/var/mail/cltbld', 11:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:49 INFO - 'MOZ_NO_REMOTE': '1', 11:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:49 INFO - 'NO_EM_RESTART': '1', 11:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:49 INFO - 'PWD': '/builds/slave/test', 11:05:49 INFO - 'SHELL': '/bin/bash', 11:05:49 INFO - 'SHLVL': '1', 11:05:49 INFO - 'TERM': 'linux', 11:05:49 INFO - 'TMOUT': '86400', 11:05:49 INFO - 'USER': 'cltbld', 11:05:49 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', 11:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:49 INFO - '_': '/tools/buildbot/bin/python'} 11:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:05:50 INFO - Cleaning up... 11:05:50 INFO - Return code: 0 11:05:50 INFO - Running post-action listener: _resource_record_post_action 11:05:50 INFO - Running post-action listener: _start_resource_monitoring 11:05:50 INFO - Starting resource monitoring. 11:05:50 INFO - [mozharness: 2017-08-17 18:05:50.142760Z] Finished create-virtualenv step (success) 11:05:50 INFO - [mozharness: 2017-08-17 18:05:50.143279Z] Running install step. 11:05:50 INFO - Running pre-action listener: _resource_record_pre_action 11:05:50 INFO - Running main action method: install 11:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:05:50 INFO - Reading from file tmpfile_stdout 11:05:50 INFO - Detecting whether we're running mozinstall >=1.0... 11:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:05:50 INFO - Reading from file tmpfile_stdout 11:05:50 INFO - Output received: 11:05:50 INFO - Usage: mozinstall [options] installer 11:05:50 INFO - Options: 11:05:50 INFO - -h, --help show this help message and exit 11:05:50 INFO - -d DEST, --destination=DEST 11:05:50 INFO - Directory to install application into. [default: 11:05:50 INFO - "/builds/slave/test"] 11:05:50 INFO - --app=APP Application being installed. [default: firefox] 11:05:50 INFO - mkdir: /builds/slave/test/build/application 11:05:50 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'] 11:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:06:08 INFO - Reading from file tmpfile_stdout 11:06:08 INFO - Output received: 11:06:08 INFO - /builds/slave/test/build/application/firefox/firefox 11:06:08 INFO - Running post-action listener: _resource_record_post_action 11:06:08 INFO - [mozharness: 2017-08-17 18:06:08.568625Z] Finished install step (success) 11:06:08 INFO - [mozharness: 2017-08-17 18:06:08.568971Z] Running setup-mitmproxy step. 11:06:08 INFO - Running pre-action listener: _resource_record_pre_action 11:06:08 INFO - Running main action method: setup_mitmproxy 11:06:08 INFO - Skipping: mitmproxy is not required 11:06:08 INFO - Running post-action listener: _resource_record_post_action 11:06:08 INFO - [mozharness: 2017-08-17 18:06:08.570659Z] Finished setup-mitmproxy step (success) 11:06:08 INFO - [mozharness: 2017-08-17 18:06:08.570972Z] Running run-tests step. 11:06:08 INFO - Running pre-action listener: _resource_record_pre_action 11:06:08 INFO - Running pre-action listener: _set_gcov_prefix 11:06:08 INFO - Running main action method: run_tests 11:06:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:06:08 INFO - Python 2.7.3 11:06:08 INFO - Return code: 0 11:06:08 INFO - grabbing minidump binary from tooltool 11:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:08 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 0x1aa00b0>, '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 0x1aa0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:06:08 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 11:06:08 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 11:06:08 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 11:06:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:06:08 INFO - Return code: 0 11:06:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:06:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:06:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:06:08 INFO - ENV: RUST_BACKTRACE is now full 11:06:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:06:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:06:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 11:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 11:06:08 INFO - Using env: {'DISPLAY': ':0', 11:06:08 INFO - 'HOME': '/home/cltbld', 11:06:08 INFO - 'LANG': 'en_US.UTF-8', 11:06:08 INFO - 'LANGUAGE': 'en_US:en', 11:06:08 INFO - 'LOGNAME': 'cltbld', 11:06:08 INFO - 'MAIL': '/var/mail/cltbld', 11:06:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:06:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:08 INFO - 'MOZ_NO_REMOTE': '1', 11:06:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:08 INFO - 'NO_EM_RESTART': '1', 11:06:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:08 INFO - 'PWD': '/builds/slave/test', 11:06:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:06:08 INFO - 'RUST_BACKTRACE': 'full', 11:06:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:06:08 INFO - 'SHELL': '/bin/bash', 11:06:08 INFO - 'SHLVL': '1', 11:06:08 INFO - 'STYLO_FORCE_ENABLED': '1', 11:06:08 INFO - 'TERM': 'linux', 11:06:08 INFO - 'TMOUT': '86400', 11:06:08 INFO - 'USER': 'cltbld', 11:06:08 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879', 11:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:08 INFO - '_': '/tools/buildbot/bin/python'} 11:06:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 11:06:08 INFO - mozversion application_buildid: 20170817171339 11:06:08 INFO - mozversion application_changeset: f53a37fc0e92c093bf48baada9f9adab16422cd7 11:06:08 INFO - mozversion application_display_name: Nightly 11:06:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:06:08 INFO - mozversion application_name: Firefox 11:06:08 INFO - mozversion application_remotingname: firefox 11:06:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:06:08 INFO - mozversion application_vendor: Mozilla 11:06:08 INFO - mozversion application_version: 57.0a1 11:06:08 INFO - mozversion platform_buildid: 20170817171339 11:06:08 INFO - mozversion platform_changeset: f53a37fc0e92c093bf48baada9f9adab16422cd7 11:06:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:06:08 INFO - mozversion platform_version: 57.0a1 11:06:08 INFO - using testdate: 1502993168 11:06:08 INFO - actual date: 1502993168 11:06:08 INFO - starting webserver on 'localhost:53560' 11:06:08 INFO - SUITE-START | Running 2 tests 11:06:08 INFO - TEST-START | dromaeo_css 11:06:08 INFO - Initialising browser for dromaeo_css test... 11:06:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53560/getInfo.html -profile /tmp/tmpPnKil4/profile 11:06:08 INFO - TEST-INFO | started process 7897 (/builds/slave/test/build/application/firefox/firefox http://localhost:53560/getInfo.html) 11:06:14 INFO - TEST-INFO | 7897: exit 0 11:06:15 INFO - Browser initialized. 11:06:15 INFO - Running cycle 1/1 for dromaeo_css test... 11:06:15 INFO - TEST-INFO | started process 8088 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPnKil4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:06:16 INFO - PID 8088 | 11:06:16 INFO - PID 8088 | (/builds/slave/test/build/application/firefox/firefox:8142): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:06:16 INFO - PID 8088 | 11:06:26 INFO - PID 8088 | RSS: Main: 166625280 11:06:26 INFO - PID 8088 | 11:09:24 INFO - PID 8088 | Cycle 1(1): loaded http://localhost:53560/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53560/tests/dromaeo/cssquery-ext.html) 11:09:26 INFO - PID 8088 | RSS: Main: 174620672 11:09:26 INFO - PID 8088 | 11:12:28 INFO - PID 8088 | Cycle 1(1): loaded http://localhost:53560/tests/dromaeo/cssquery-ext.html (next: http://localhost:53560/tests/dromaeo/cssquery-jquery.html) 11:12:29 INFO - PID 8088 | RSS: Main: 172597248 11:12:29 INFO - PID 8088 | 11:15:31 INFO - PID 8088 | Cycle 1(1): loaded http://localhost:53560/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53560/tests/dromaeo/cssquery-mootools.html) 11:15:31 INFO - PID 8088 | RSS: Main: 173445120 11:15:31 INFO - PID 8088 | 11:18:33 INFO - PID 8088 | Cycle 1(1): loaded http://localhost:53560/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53560/tests/dromaeo/cssquery-prototype.html) 11:18:34 INFO - PID 8088 | RSS: Main: 172236800 11:18:34 INFO - PID 8088 | 11:21:37 INFO - PID 8088 | Cycle 1(1): loaded http://localhost:53560/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53560/tests/dromaeo/cssquery-yui.html) 11:21:38 INFO - PID 8088 | RSS: Main: 175697920 11:21:38 INFO - PID 8088 | 11:24:40 INFO - PID 8088 | Cycle 1(1): loaded http://localhost:53560/tests/dromaeo/cssquery-yui.html (next: http://localhost:53560/tests/dromaeo/cssquery-dojo.html) 11:24:40 INFO - PID 8088 | RSS: Main: 176254976 11:24:40 INFO - PID 8088 | 11:24:40 INFO - PID 8088 | __start_tp_report 11:24:40 INFO - PID 8088 | _x_x_mozilla_page_load 11:24:40 INFO - PID 8088 | _x_x_mozilla_page_load_details 11:24:40 INFO - PID 8088 | |i|pagename|runs| 11:24:40 INFO - PID 8088 | |0;dojo.html;3134.3417882244744;3202.359528094381;3202.823844688541;3208.518722191671;3209.9679003209963;6103.1455596216565;6149.292831324394;6198.752049918004;6229.937700622992;6252.406021427969;6042.395760423967;6168.845778855531;6168.907466388007;6174.043023331391;6195.442410183083;5634.32388113427;5668.319801623811;5681.119426488901;5681.687507187103;5738.540916726673;5724.971375143139;5742.770289188427;5750.022496175639;5763.308402991647;5779.017567013618;5521.806736764234;5642.125470552071;5674.460926212003;5810.099434587624;5812.941870581282;5635.971820140914;5688.089905615123;5707.600467967244;5752.5110365618975;5754.769809207627;5623.606347555673;5646.661200327993;5689.800856969986;5691.117876729114;5707.429257074301;5987.760489580412;6020.397960203988;6059.212302400704;6062.605930614496;6133.049377346519;6680.799576012679;6688.230853451867;6713;6716.0933274007875;6744.258131605568;6714.83212919676;6720;6794.0827988221945;6800.761973330959;6815.829604259933;6054.212952316171;6192.767037765126;6216.689165541705;6281.937180628227;6293.370662933716;6763.256041835394;6787.321267873173;6792.558483698544;6798.796036118924;6811.863762724718;6442.48460123189;6491.156149700603;6516.055172000033;6521.510886683518;6523.217213934358;6592.077109204715;6618.768343107968;6620.801375958729;6677.666116694146;6678.3989440950545;6645.302243264484;6695.665216739144;6699.062131301622;6719.865602687919;6732.427743641747;6620.106285651375;6620.735170593219;6630.734770609121;6714.127163468718;6724;5281.0758117329315;5351.357837059578;5368.597355198376;5493.285872836505;5508.173773933942;4612;4664.95335046652;4665.370175026396;4693.296005599119;4716.481187069419;5778.8266352009505;5803.100519419497;5849.298084229919;5861.5603829712945;5873.295204575393;6719.832004199837;6726.428253598499;6798.218204906499;6812.591244525344;6822.590644561342;5658.830235092953;5723.742431590588;5744.770209191669;5791.797287094932;5860.560457965669;5925.229720136354;5956.821295361146;5960.761569537257;5977.491913187341;5981.611195272293;6424.38968298011;6514.250861151028;6571.57284776488;6604;6611.404973552403;6658.334166583303;6700.6984685688285;6705.497087718343;6797.320267973163;6805.693743781443;6520.902186467112;6548.345165483604;6549.345065493412;6572.14562106923;6590.846601844754;6541.149650545589;6593.703283352356;6669.433098186709;6671.799846004627;6684.699188536625;6685.130932978682;6688.197416310074;6700.430463410665;6797.524173307821;6806.76176333826;6323.588966717149;6410.583312084699;6413.422791948747;6425.164728585254;6469.061986012096;6437.291897891135;6439.162908821823;6439.9696048631995;6447.194100737408;6449.580777249464;6260.28006779208;6359.17330747;6361.491080713625;6364.554481186273;6366;6415.454686351713;6478.190226221723;6494.09082728409;6495.188101487314;6496.512761542997;6293.937060629335;6312.210973628296;6314.842128946813;6321.431071203614;6325.209348831396 11:24:40 INFO - PID 8088 | |1;ext.html;865.385576240869;894.3739382432295;1169.8245263210517;1189.3161432176496;1265.367316341829;39373;39867.2026559469;42393.99999999996;43037.7848110759;43053;40013.19973600526;40575.797121014424;40617;40700.18599628006;40816.387754183714;7267.164276108249;7398.445116616275;7404.333609975101;7649.120351159632;7815.10126335473;7691.576963267018;7785.260400261966;7836.255555722226;7840.7255746048895;7844.294013538781;7830.530168189898;7878.763637090868;7884.32983196429;7886.566238856861;7892.052953645571;7819.061712594496;7858.803529911741;7886.408519361043;7889.8027549311155;7895.131535531087;7735.303822655988;7788.337991270749;7807.180246074137;7812.140664526897;7816.374690024784;40052.599474005176;40200;40203;40419.79790101031;40465;3616.4213725804007;3630.1832087780303;3645.0887278180453;3650.926981460356;3664.560252769658;32215.83892080548;32244;32250.032499025066;32421.189470263198;32502.512462312847;5054.1407960646775;5063.873403164914;5138.537531622134;5142.04872098663;5155.71643559604;183718;184396;186685;186688;186902.99999999863;43969.78015109904;44792.3281150783;49793.25310120278;50519.74740126276;50796.492035079915;52739.472605274226;53769.73115134399;53829.461705383226;53853.73073134609;53936;17018.574535636708;17149.142542873054;17178;17212.569685757957;17271.65456690859;14082.929585352213;14107.294635268196;14118.858811411754;14132.434702611987;14134.85865141356;14940.551783446514;14994.850051499563;15012.47456339023;15134.578467445375;15186.088834669956;5605.577689243028;5717.3996730342715;5762.481376676035;5765.596408251466;5985.850353741192;1002.6390499420203;1011.3830563356347;1019.6176433837311;1035.6168217759478;1041.031840388446;22971.540569188524;24032.51934961326;29841.40317193644;30126.397472050874;30325.848370758005;1097.4183682648209;1106.5850306135198;1108.5177947592822;1110.3837370259423;1117.474786850179;12948.935255323851;12969.76787205214;13129.803052954214;13270.66823329405;13403.865961340261;243572;245081;245359;245446;245760;57565.42434575601;57575.424245757844;57674.423255767746;57893.42106578965;58014;1468.5520916120472;1481.9110853348834;1489.9106053636817;1511.8110236220473;1516.150955464943;23647.763522364556;23877.64183537283;23967.400814979766;24181;24293.149739759025;41137.1772564541;41272.38091428691;41450.170996580506;41501.58498415098;41513.79243103886;202913;203324;204391;204549;205358;31445.371092578476;31818.522722158723;33311.33377332391;36564.451533227555;37505.06237344088;46595.53404465912;48059.519404805505;48555.757221213666;49037.26444103412;49568;33725.49411758777;34173.487397689554;34475.482867757506;34579.30841383108;35118.47322290219;33984.490232646036;34013.319733604694;34193.316133676686;34384;34541;38098.238035239694;38340.424893627176;38491.807540962116;38749.80625096856;38828.80585597054;34060.489092664124;34138.48792268068;34268.48597270993;34621.13447163841;34701.652983469845;24550.386240344134;24731.876340618182;24810;25134.497310054063;25448.618270726325 11:24:40 INFO - PID 8088 | |2;jquery.html;585.443828363055;588.4457874438392;592.8488235499947;595.1935127901694;598.5510866849862;22897;22947.196848110278;23781.881090594543;23829.404264893386;23853;26124.869375653143;26496.33759156022;26518;26620.733792662068;26734;6538.771143009995;6768.492363072764;6770.119884415019;6793.558418702769;6795.592264464123;6276.623402595836;6642.269350371455;6725.192976842785;6793;6794.218664853531;6590.604563726191;6607.5044371672075;6610.834729131762;6610.900836487456;6618.900716489256;6585.275619681831;6609.834754131161;6614.371634694697;6624.238212605515;6628.602283862983;6133;6142.863570239475;6143.416375444325;6152.230971128609;6160.722767475474;29811.552826707615;30426.69573304261;30535.236619084702;30850.07449776488;31003.379932401225;1878.9718154227699;1929.1608150454597;1934.6517626827165;1935.8354539864129;1936.8353689936373;19420.611587768308;19933.900330498254;19935.700964485546;19986.60026799456;19996.400107996782;2418.3470462975074;2477.5630134522116;2540.047482194177;2541.8729063546934;2550.3114159177103;140261;144864.27567862198;145137;145193;145462;15018.774718379014;15434.614134646723;15442.536723898302;15612.55440458529;16138.031718096952;23304.417389565395;23774.405639858796;23899.52200956006;23904.52190956171;24233.878830605736;9996.250281228937;10169.745756356151;10254.28220024606;10277.383356998604;10285.588576457008;9260.861087083698;9267.72196834096;9274.118958698913;9353.298502612332;9379.859302110473;9580.18568421692;9680.370775899684;9707.369021013752;9720.368176068532;9758.414495130315;2670.252329347747;2724.523208438555;2739.7534221920123;2752.119321816999;2816.6760822505266;968.9951550242204;993.8310487217191;1000.9849852252222;1009.4195837393528;1010.4897027001317;19518.414447566596;19889.900550497154;19949.60100798005;20085.698714519294;20315;1030.2273295028729;1043.9530221140067;1044.4412239451856;1058.687687132298;1073.2219141122623;10962.287451315638;11046.889531104585;11169.776604467865;11297;11304.378259195822;488180;493742;495736;505229;537864;108761;114482.42758786153;119255;119490;119956;1195.5098409652176;1204.265398107154;1229.0352073621984;1230.9507619695112;1232.7226374065763;17474.21366038506;17507.912460437616;17540.298388064333;17920.372786952394;18023.369182078564;53954.46045539495;54493.45506544884;58670.4132958682;60311.69844150927;61349;71055.64472177606;71541.28458715347;72209.91685124622;72248;72901;14753.92623036878;15172.620684482976;15247.313870875616;15264.313105910038;15288.694226115638;23817.404564886016;24081.638775418734;24195;24306.87846560756;24510.387240319134;18490.167942442353;18588.44234672962;18898.055097245357;19028.04859757034;19048.904755476135;16540.255688494286;16813.159342032606;16991.49025529236;17070.402535911184;17250.878692884922;17982.37061702834;19462.12420441112;19556.11997460146;19738.703919440934;19752.40742777719;14689.559313220621;14802.62993425173;14852.183129927958;14882.627934301296;14899.851001489846;18477.81522184761;18545.072746362897;18601.255949761857;18601.348952787128;18687.159077841257 11:24:40 INFO - PID 8088 | |3;mootools.html;1300.8699130086989;1361.5915225432368;1388.4654408052902;1388.8125103111083;1389.4442223110748;13885.58343249703;14394.352254148562;14401.711965760678;14428.35072421741;14430.783538246935;13879.375428105734;14362.569122926303;14873.330700118493;14895.553133405989;14895.627609309746;2654.654894863665;2697.9730202698015;2698.231004163804;2702.8378297302124;2706.905258315959;2545.5799793034125;2623.8950441982297;2636.670416197975;2645.2725500487422;2693.46130773845;2663.1477927063347;2681.1956413076095;2697.7302269772963;2704.5672692369226;2707.8510681912485;2563.4360440703017;2564.2563656539583;2580.7548282913094;2584.328074700582;2584.702759182699;2548.566743653565;2564.9871750641314;2579.742025797424;2617.8429294242405;2623.27859838544;14046.227457489835;14149.363278652485;14201.857981420157;14206.644833879132;14221.85778142226;7514.511556748794;7730.304272615435;7755.302022817974;7770.728024519115;7774.533527988338;4971.602271818246;5089.949100509021;5232.058229518685;5236.633435659505;5237.764300606482;1874.578219900525;1881.840043596296;1913.339897735279;1947.7760057593275;1960.8823470591667;23464;23688.64467032996;23719.288421347388;23720.288391348287;23741.643875341884;6567.310432404624;6602.471802255808;6626.204855417381;6776.661166941633;6792.049113124167;16201.351945922266;16252.83747162537;16278.186090695417;16292.918535407247;16312.673746525003;7663.31030207284;7735.303822655988;7763.650635721406;7810.765677029698;7823.84352312962;6841.110655614738;7174.8206294842;7204.171520275236;7219.350258476762;7231.927680723231;5005.924911126336;5177.86087060846;5208.192730126836;5242.790288388422;5275.630705850554;1396.0576610787678;1404.501402002295;1498.9475368362055;1501.677139415031;1514.7652113922359;733.9853202936018;744.9515781474187;748.8801791713299;752.6124046116255;757.5946868425366;7721.729739459092;8652.264557512555;8749.343799214957;8812.295016398673;8877.644894204159;993.9353941993747;996.6611352140308;1012.1194560732063;1012.9290949633455;1014.6144465103362;5049.2173713074535;5122.129238029544;5226.869328266824;5236.371635403776;5330.067238233293;19030.524236894187;19130;19782.109805058808;20003.09986050631;20015.899920500306;19000.334988275343;19406.611867762847;19518.12168452423;19833.801661983194;19853;10848.620298289521;10908.127349811995;11242.7189320266;11249.381284029294;11256.380899050631;8160;8172.550509722022;8268.131846156068;8381.49711017341;8398.748037558884;16915;17411.912940435217;17544;17554.21006054705;17635.64728705393;17490.47528574145;17526.649467010844;17631.20659570348;17639;17731.468055957826;10603.94698026505;10827.350358978487;10835.51240194209;10871.782564348827;10881.727956801144;13144.60566183016;13146.27695476758;13355.931525478132;13372.197668139943;13516.25660588677;11017.889821102008;11029.393383363671;11046.723831904266;11169.497372618414;11369.204155709022;10467.16262698967;10604.840927386249;10784.245102842726;10831.566737330733;10912.454377280945;9177.128172823572;9272.397294175857;9283.72148835536;9322.067793220624;9324.393914395543;6588.308227636029;6693.564918280296;6701.731930722716;6709.329067093252;6745.4266387355665;7573.507721998052;7586.24137586237;7604.277593628596;7641.3886889047635;7705.075390952898 11:24:40 INFO - PID 8088 | |4;prototype.html;495.53667321054803;497.7010003889847;525.4535283305363;532.8934213157368;533.3546408845297;6210.4721098706605;6242.7190776415055;6295.080000599821;6306.747730090797;6339.619622822623;6021.638701677892;6095.664738439384;6103.2605707373405;6125.724342404591;6213.316535181138;5147.382314122292;5197.610179236553;5209.635325527214;5242.711650859202;5248.816291429801;5175.611829112813;5207.244949482341;5250.949810037989;5270.7628156733035;5273.472652734734;4954.554090131887;5147.588192944574;5161.638685292012;5171.50870667286;5199.350081239845;5184.585233181355;5200.323957885488;5230.921536176979;5259.15853463444;5275.973620131875;4782.808687652525;4802.567768900781;4842.443119041285;4862.465128835825;4870.732109733964;6057.545684073712;6057.575969682124;6086.2087928569;6158.261008678943;6169.568130230886;6020.638761674313;6051.485623721989;6055.636661800306;6080.756769729205;6088.756449742005;6490.93509064908;6533;6535;6628.502862285348;6652.2017357916875;5228.895317175999;5298.92051619226;5305.840824775263;5332.226827110087;5362.705051222181;6902.965485172592;6944.131983502062;6951.895721564231;6994.615296158659;7018.227994920555;5422.972885135549;5450.727463626803;5451.209574611659;5461.290032295776;5476.67139971603;5521.101421753531;5534.335879694462;5540.196671482612;5569.832905012856;5589.35722391922;5996.121861506501;6017.368176341509;6066.908996365058;6087.847803804941;6091.329953705089;6513.967430162914;6543.574667646588;6545.574537655038;6558.5409021369;6654.767083152066;1825.9908700456413;1896.8672192946638;1909.5894382707784;1920.6472071712042;1925.5186203449139;1410.4287763455816;1414.978775318371;1435.6697959469382;1473.955781326562;1492.9776053359208;5716.399778023331;5721.971390143022;5745.942540574624;5749.281339832521;5751.194832723422;6631.502637302222;6735.6295403753265;6745.696443660047;6773.525853190229;6785.457163427012;5821.18503409523;5847.415258474203;5857.121431785266;5872.119182122716;5885.264341957255;3602.963970360315;3638.4178531434845;3640.199156185635;3645;3668.779873207616;6632.635205063768;6642.933570664328;6670.466362690973;6678.4991125665765;6698.464122870256;6918.584884906922;6941.895871561931;6975.546589471668;6992.265812089658;7027.508074434741;6576.44100251484;6577.539572229898;6615.857467702803;6628.90056649141;6680.799576012728;6747.325267473213;6773;6864.176298844171;6875.518713689994;6878.65606719652;6722.672277222806;6767.729290828312;6769.661516924232;6770.307423144214;6790.490713196629;6617.966910165418;6625.17185351831;6642.4686025118845;6654.76886775948;6686.732530698718;5043.915558155014;5057.924131137962;5093.592512599057;5094.949050509447;5115.283860259492;6701.765438209639;6727.562708423937;6833.829154271183;6839.726410943506;6916.930830691628;6311.65285909261;6316.589421687576;6382.3617638237665;6400.327965563549;6512.34876512345;6425.903611445926;6474.676266186578;6483.157189565326;6575.967120164369;6576.750417420675;6331.90502142459;6380.234371875219;6408.391202835724;6457.160569125984;6525.9021114684265;6493.9675301625075;6502.187226596676;6552.541322107407;6574.211094668671;6652.534322597372;6338.461230795434;6353.14232578596;6400.1679781629955;6441.291457939529;6472.967635161794 11:24:40 INFO - PID 8088 | |5;yui.html;890.3767362846005;906.6373450619752;921.0467166482691;921.9492927888963;922.326701507899;18658.253669853206;19516.804831951693;19647.901760491197;19752.111154998023;21261.681074783854;21278.787212127874;21879.12483500662;21973.890130549324;21988.120475180975;22017.33947981563;1020.6835880876934;1059.90990765785;1060.9363438193695;1063.0910571461404;1064.6646306413454;1020.2093377632357;1050.5430137890005;1051.7686109055996;1055.5672174408494;1067.3329169269207;1117.2291119127817;1119.261287550217;1120.0143873391405;1120.0647459371394;1120.075937351688;1115.4422788605698;1118.7818375416798;1118.8321751737305;1121.8149005414139;1122.3770807202;821.1131977464383;822.6339279020838;824.8886400335938;825.2943733108166;825.3026192867078;19604.901975490175;20084.397468075982;20188.19247230109;20268.493287667778;20536.07587658559;21426.464338391666;21538.676919846213;21982.560348792933;22067.448313792283;22227.333180004625;16764.07797571133;16798.32806687731;16989.915050424792;17091.658166836594;17190.570235744082;3557.6086630470627;3585.995921142084;3586.8385922633543;3588.5155504006884;3588.5873124590744;126222;127637;128259;130750;130949;17289.913550432168;17317.56706082358;17618.383356582457;17680.557986050193;17943.641127177383;31437.528437073463;32115.67884321127;32162.83918580392;32461.837690811393;32674.183145421553;7690.192529784404;8079.313258372987;8799;9017.504037277882;9273.165415112537;4171.270027745132;4258.936115958263;4262.6376757975295;4277.144571085795;4280;5048.444671086178;5113.1052065888325;5127.256547800623;5151.793928242828;5167.354080739908;1023.8464230365505;1049.8530205771199;1055.6991257491577;1057.8730552333616;1059.7668512927144;670.7719375412383;676.4182802789597;688.3426327856885;694.7811439396675;698.783377153074;11463.770724585462;11694.708656382329;11862.644120676394;12223.511059557519;12386.442610082568;637.719403462475;651.0982289529037;654.3031671270082;654.9945833146098;655.3446553446554;5424.783008679688;5485.6982865942755;5497.285352904177;5505.449455054462;5615.438456154352;109106;109689;110244.44877775559;110312;111879.44060279646;94408.52795736115;96173.51913240529;96560.51719741356;98744;99468;86442.13557864341;87045.56477217701;88189.55905220433;89823.55088224648;91368.54315728378;10059.295849290773;10199.796004080024;10308.536115874953;11590.594329198437;12506.312152831317;36731.63268367282;39526.60473395344;39862.800685996386;40136.59863401329;42017.78991105025;71435;71986;72953.6352318235;73016.63491682507;74192.62903685447;18784;18851.811481885554;19053.42839714811;19089.522761931064;19280.903595482494;21644.891775541022;21819.345419637437;21910.56178876382;21976.780232197474;22183.44541386478;17900.10499474995;18454;18477.630447391246;18781.6243675123;18850.905745471184;18221.635567288846;19222.8077719221;19330.613387732446;19391.709124362864;19459.610807783483;18055.09724513743;18382.080895955416;19121.808781912558;19774.70337944961;19822;12260.448279827251;12522;12598.496060157491;12868.613941581767;13666;13567.118137321042;13606.183628982293;13629.591112266648;14440.638984025483;14669.119852808866 11:24:40 INFO - PID 8088 | __end_tp_report 11:24:40 INFO - PID 8088 | __start_cc_report 11:24:40 INFO - PID 8088 | _x_x_mozilla_cycle_collect,374 11:24:40 INFO - PID 8088 | __end_cc_report 11:24:40 INFO - PID 8088 | __startTimestamp1502994280614__endTimestamp 11:24:40 INFO - PID 8088 | 11:24:40 INFO - PID 8088 | ------- Summary: start ------- 11:24:40 INFO - PID 8088 | Number of tests: 6 11:24:40 INFO - PID 8088 | 11:24:40 INFO - PID 8088 | [#0] dojo.html Cycles:165 Average:6140.61 Median:6359.17 stddev:717.28 (11.3%) stddev-sans-first:679.60 11:24:40 INFO - PID 8088 | Values: 3134.3 3202.4 3202.8 3208.5 3210.0 6103.1 6149.3 6198.8 6229.9 6252.4 6042.4 6168.8 6168.9 6174.0 6195.4 5634.3 5668.3 5681.1 5681.7 5738.5 5725.0 5742.8 5750.0 5763.3 5779.0 5521.8 5642.1 5674.5 5810.1 5812.9 5636.0 5688.1 5707.6 5752.5 5754.8 5623.6 5646.7 5689.8 5691.1 5707.4 5987.8 6020.4 6059.2 6062.6 6133.0 6680.8 6688.2 6713.0 6716.1 6744.3 6714.8 6720.0 6794.1 6800.8 6815.8 6054.2 6192.8 6216.7 6281.9 6293.4 6763.3 6787.3 6792.6 6798.8 6811.9 6442.5 6491.2 6516.1 6521.5 6523.2 6592.1 6618.8 6620.8 6677.7 6678.4 6645.3 6695.7 6699.1 6719.9 6732.4 6620.1 6620.7 6630.7 6714.1 6724.0 5281.1 5351.4 5368.6 5493.3 5508.2 4612.0 4665.0 4665.4 4693.3 4716.5 5778.8 5803.1 5849.3 5861.6 5873.3 6719.8 6726.4 6798.2 6812.6 6822.6 5658.8 5723.7 5744.8 5791.8 5860.6 5925.2 5956.8 5960.8 5977.5 5981.6 6424.4 6514.3 6571.6 6604.0 6611.4 6658.3 6700.7 6705.5 6797.3 6805.7 6520.9 6548.3 6549.3 6572.1 6590.8 6541.1 6593.7 6669.4 6671.8 6684.7 6685.1 6688.2 6700.4 6797.5 6806.8 6323.6 6410.6 6413.4 6425.2 6469.1 6437.3 6439.2 6440.0 6447.2 6449.6 6260.3 6359.2 6361.5 6364.6 6366.0 6415.5 6478.2 6494.1 6495.2 6496.5 6293.9 6312.2 6314.8 6321.4 6325.2 11:24:40 INFO - PID 8088 | 11:24:40 INFO - PID 8088 | [#1] ext.html Cycles:180 Average:39115.35 Median:19367.45 stddev:55214.75 (285.1%) stddev-sans-first:55294.94 11:24:40 INFO - PID 8088 | Values: 865.4 894.4 1169.8 1189.3 1265.4 39373.0 39867.2 42394.0 43037.8 43053.0 40013.2 40575.8 40617.0 40700.2 40816.4 7267.2 7398.4 7404.3 7649.1 7815.1 7691.6 7785.3 7836.3 7840.7 7844.3 7830.5 7878.8 7884.3 7886.6 7892.1 7819.1 7858.8 7886.4 7889.8 7895.1 7735.3 7788.3 7807.2 7812.1 7816.4 40052.6 40200.0 40203.0 40419.8 40465.0 3616.4 3630.2 3645.1 3650.9 3664.6 32215.8 32244.0 32250.0 32421.2 32502.5 5054.1 5063.9 5138.5 5142.0 5155.7 183718.0 184396.0 186685.0 186688.0 186903.0 43969.8 44792.3 49793.3 50519.7 50796.5 52739.5 53769.7 53829.5 53853.7 53936.0 17018.6 17149.1 17178.0 17212.6 17271.7 14082.9 14107.3 14118.9 14132.4 14134.9 14940.6 14994.9 15012.5 15134.6 15186.1 5605.6 5717.4 5762.5 5765.6 5985.9 1002.6 1011.4 1019.6 1035.6 1041.0 22971.5 24032.5 29841.4 30126.4 30325.8 1097.4 1106.6 1108.5 1110.4 1117.5 12948.9 12969.8 13129.8 13270.7 13403.9 243572.0 245081.0 245359.0 245446.0 245760.0 57565.4 57575.4 57674.4 57893.4 58014.0 1468.6 1481.9 1489.9 1511.8 1516.2 23647.8 23877.6 23967.4 24181.0 24293.1 41137.2 41272.4 41450.2 41501.6 41513.8 202913.0 203324.0 204391.0 204549.0 205358.0 31445.4 31818.5 33311.3 36564.5 37505.1 46595.5 48059.5 48555.8 49037.3 49568.0 33725.5 34173.5 34475.5 34579.3 35118.5 33984.5 34013.3 34193.3 34384.0 34541.0 38098.2 38340.4 38491.8 38749.8 38828.8 34060.5 34138.5 34268.5 34621.1 34701.7 24550.4 24731.9 24810.0 25134.5 25448.6 11:24:40 INFO - PID 8088 | 11:24:40 INFO - PID 8088 | [#2] jquery.html Cycles:180 Average:35658.55 Median:23778.14 stddev:85012.24 (357.5%) stddev-sans-first:85209.94 11:24:40 INFO - PID 8088 | Values: 585.4 588.4 592.8 595.2 598.6 22897.0 22947.2 23781.9 23829.4 23853.0 26124.9 26496.3 26518.0 26620.7 26734.0 6538.8 6768.5 6770.1 6793.6 6795.6 6276.6 6642.3 6725.2 6793.0 6794.2 6590.6 6607.5 6610.8 6610.9 6618.9 6585.3 6609.8 6614.4 6624.2 6628.6 6133.0 6142.9 6143.4 6152.2 6160.7 29811.6 30426.7 30535.2 30850.1 31003.4 1879.0 1929.2 1934.7 1935.8 1936.8 19420.6 19933.9 19935.7 19986.6 19996.4 2418.3 2477.6 2540.0 2541.9 2550.3 140261.0 144864.3 145137.0 145193.0 145462.0 15018.8 15434.6 15442.5 15612.6 16138.0 23304.4 23774.4 23899.5 23904.5 24233.9 9996.3 10169.7 10254.3 10277.4 10285.6 9260.9 9267.7 9274.1 9353.3 9379.9 9580.2 9680.4 9707.4 9720.4 9758.4 2670.3 2724.5 2739.8 2752.1 2816.7 969.0 993.8 1001.0 1009.4 1010.5 19518.4 19889.9 19949.6 20085.7 20315.0 1030.2 1044.0 1044.4 1058.7 1073.2 10962.3 11046.9 11169.8 11297.0 11304.4 488180.0 493742.0 495736.0 505229.0 537864.0 108761.0 114482.4 119255.0 119490.0 119956.0 1195.5 1204.3 1229.0 1231.0 1232.7 17474.2 17507.9 17540.3 17920.4 18023.4 53954.5 54493.5 58670.4 60311.7 61349.0 71055.6 71541.3 72209.9 72248.0 72901.0 14753.9 15172.6 15247.3 15264.3 15288.7 23817.4 24081.6 24195.0 24306.9 24510.4 18490.2 18588.4 18898.1 19028.0 19048.9 16540.3 16813.2 16991.5 17070.4 17250.9 17982.4 19462.1 19556.1 19738.7 19752.4 14689.6 14802.6 14852.2 14882.6 14899.9 18477.8 18545.1 18601.3 18601.3 18687.2 11:24:40 INFO - PID 8088 | 11:24:40 INFO - PID 8088 | [#3] mootools.html Cycles:180 Average:8863.33 Median:2563.85 stddev:6071.07 (236.8%) stddev-sans-first:6061.51 11:24:40 INFO - PID 8088 | Values: 1300.9 1361.6 1388.5 1388.8 1389.4 13885.6 14394.4 14401.7 14428.4 14430.8 13879.4 14362.6 14873.3 14895.6 14895.6 2654.7 2698.0 2698.2 2702.8 2706.9 2545.6 2623.9 2636.7 2645.3 2693.5 2663.1 2681.2 2697.7 2704.6 2707.9 2563.4 2564.3 2580.8 2584.3 2584.7 2548.6 2565.0 2579.7 2617.8 2623.3 14046.2 14149.4 14201.9 14206.6 14221.9 7514.5 7730.3 7755.3 7770.7 7774.5 4971.6 5089.9 5232.1 5236.6 5237.8 1874.6 1881.8 1913.3 1947.8 1960.9 23464.0 23688.6 23719.3 23720.3 23741.6 6567.3 6602.5 6626.2 6776.7 6792.0 16201.4 16252.8 16278.2 16292.9 16312.7 7663.3 7735.3 7763.7 7810.8 7823.8 6841.1 7174.8 7204.2 7219.4 7231.9 5005.9 5177.9 5208.2 5242.8 5275.6 1396.1 1404.5 1498.9 1501.7 1514.8 734.0 745.0 748.9 752.6 757.6 7721.7 8652.3 8749.3 8812.3 8877.6 993.9 996.7 1012.1 1012.9 1014.6 5049.2 5122.1 5226.9 5236.4 5330.1 19030.5 19130.0 19782.1 20003.1 20015.9 19000.3 19406.6 19518.1 19833.8 19853.0 10848.6 10908.1 11242.7 11249.4 11256.4 8160.0 8172.6 8268.1 8381.5 8398.7 16915.0 17411.9 17544.0 17554.2 17635.6 17490.5 17526.6 17631.2 17639.0 17731.5 10603.9 10827.4 10835.5 10871.8 10881.7 13144.6 13146.3 13355.9 13372.2 13516.3 11017.9 11029.4 11046.7 11169.5 11369.2 10467.2 10604.8 10784.2 10831.6 10912.5 9177.1 9272.4 9283.7 9322.1 9324.4 6588.3 6693.6 6701.7 6709.3 6745.4 7573.5 7586.2 7604.3 7641.4 7705.1 11:24:40 INFO - PID 8088 | 11:24:40 INFO - PID 8088 | [#4] prototype.html Cycles:180 Average:5642.04 Median:6114.49 stddev:1512.45 (24.7%) stddev-sans-first:1466.54 11:24:40 INFO - PID 8088 | Values: 495.5 497.7 525.5 532.9 533.4 6210.5 6242.7 6295.1 6306.7 6339.6 6021.6 6095.7 6103.3 6125.7 6213.3 5147.4 5197.6 5209.6 5242.7 5248.8 5175.6 5207.2 5250.9 5270.8 5273.5 4954.6 5147.6 5161.6 5171.5 5199.4 5184.6 5200.3 5230.9 5259.2 5276.0 4782.8 4802.6 4842.4 4862.5 4870.7 6057.5 6057.6 6086.2 6158.3 6169.6 6020.6 6051.5 6055.6 6080.8 6088.8 6490.9 6533.0 6535.0 6628.5 6652.2 5228.9 5298.9 5305.8 5332.2 5362.7 6903.0 6944.1 6951.9 6994.6 7018.2 5423.0 5450.7 5451.2 5461.3 5476.7 5521.1 5534.3 5540.2 5569.8 5589.4 5996.1 6017.4 6066.9 6087.8 6091.3 6514.0 6543.6 6545.6 6558.5 6654.8 1826.0 1896.9 1909.6 1920.6 1925.5 1410.4 1415.0 1435.7 1474.0 1493.0 5716.4 5722.0 5745.9 5749.3 5751.2 6631.5 6735.6 6745.7 6773.5 6785.5 5821.2 5847.4 5857.1 5872.1 5885.3 3603.0 3638.4 3640.2 3645.0 3668.8 6632.6 6642.9 6670.5 6678.5 6698.5 6918.6 6941.9 6975.5 6992.3 7027.5 6576.4 6577.5 6615.9 6628.9 6680.8 6747.3 6773.0 6864.2 6875.5 6878.7 6722.7 6767.7 6769.7 6770.3 6790.5 6618.0 6625.2 6642.5 6654.8 6686.7 5043.9 5057.9 5093.6 5094.9 5115.3 6701.8 6727.6 6833.8 6839.7 6916.9 6311.7 6316.6 6382.4 6400.3 6512.3 6425.9 6474.7 6483.2 6576.0 6576.8 6331.9 6380.2 6408.4 6457.2 6525.9 6494.0 6502.2 6552.5 6574.2 6652.5 6338.5 6353.1 6400.2 6441.3 6473.0 11:24:40 INFO - PID 8088 | 11:24:40 INFO - PID 8088 | [#5] yui.html Cycles:180 Average:24166.69 Median:20136.29 stddev:32553.69 (161.7%) stddev-sans-first:32598.09 11:24:40 INFO - PID 8088 | Values: 890.4 906.6 921.0 921.9 922.3 18658.3 19516.8 19647.9 19752.1 21261.7 21278.8 21879.1 21973.9 21988.1 22017.3 1020.7 1059.9 1060.9 1063.1 1064.7 1020.2 1050.5 1051.8 1055.6 1067.3 1117.2 1119.3 1120.0 1120.1 1120.1 1115.4 1118.8 1118.8 1121.8 1122.4 821.1 822.6 824.9 825.3 825.3 19604.9 20084.4 20188.2 20268.5 20536.1 21426.5 21538.7 21982.6 22067.4 22227.3 16764.1 16798.3 16989.9 17091.7 17190.6 3557.6 3586.0 3586.8 3588.5 3588.6 126222.0 127637.0 128259.0 130750.0 130949.0 17289.9 17317.6 17618.4 17680.6 17943.6 31437.5 32115.7 32162.8 32461.8 32674.2 7690.2 8079.3 8799.0 9017.5 9273.2 4171.3 4258.9 4262.6 4277.1 4280.0 5048.4 5113.1 5127.3 5151.8 5167.4 1023.8 1049.9 1055.7 1057.9 1059.8 670.8 676.4 688.3 694.8 698.8 11463.8 11694.7 11862.6 12223.5 12386.4 637.7 651.1 654.3 655.0 655.3 5424.8 5485.7 5497.3 5505.4 5615.4 109106.0 109689.0 110244.4 110312.0 111879.4 94408.5 96173.5 96560.5 98744.0 99468.0 86442.1 87045.6 88189.6 89823.6 91368.5 10059.3 10199.8 10308.5 11590.6 12506.3 36731.6 39526.6 39862.8 40136.6 42017.8 71435.0 71986.0 72953.6 73016.6 74192.6 18784.0 18851.8 19053.4 19089.5 19280.9 21644.9 21819.3 21910.6 21976.8 22183.4 17900.1 18454.0 18477.6 18781.6 18850.9 18221.6 19222.8 19330.6 19391.7 19459.6 18055.1 18382.1 19121.8 19774.7 19822.0 12260.4 12522.0 12598.5 12868.6 13666.0 13567.1 13606.2 13629.6 14440.6 14669.1 11:24:40 INFO - PID 8088 | -------- Summary: end -------- 11:24:40 INFO - PID 8088 | 11:24:41 INFO - TEST-INFO | 8088: exit 0 11:24:41 INFO - TEST-OK | dromaeo_css | took 1112429ms 11:24:41 INFO - TEST-START | kraken 11:24:41 INFO - Initialising browser for kraken test... 11:24:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53560/getInfo.html -profile /tmp/tmpPLEJRp/profile 11:24:41 INFO - TEST-INFO | started process 8464 (/builds/slave/test/build/application/firefox/firefox http://localhost:53560/getInfo.html) 11:24:47 INFO - TEST-INFO | 8464: exit 0 11:24:47 INFO - Browser initialized. 11:24:47 INFO - Running cycle 1/1 for kraken test... 11:24:47 INFO - TEST-INFO | started process 8656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPLEJRp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:24:48 INFO - PID 8656 | 11:24:48 INFO - PID 8656 | (/builds/slave/test/build/application/firefox/firefox:8710): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:24:48 INFO - PID 8656 | 11:24:58 INFO - PID 8656 | RSS: Main: 166158336 11:24:58 INFO - PID 8656 | 11:25:01 INFO - PID 8656 | Cycle 1(1): loaded http://localhost:53560/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53560/tests/kraken/driver.html?testName=audio-beat-detection) 11:25:02 INFO - PID 8656 | RSS: Main: 172986368 11:25:02 INFO - PID 8656 | 11:25:05 INFO - PID 8656 | Cycle 1(1): loaded http://localhost:53560/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53560/tests/kraken/driver.html?testName=audio-dft) 11:25:05 INFO - PID 8656 | RSS: Main: 172908544 11:25:05 INFO - PID 8656 | 11:25:08 INFO - PID 8656 | Cycle 1(1): loaded http://localhost:53560/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53560/tests/kraken/driver.html?testName=audio-fft) 11:25:09 INFO - PID 8656 | RSS: Main: 168345600 11:25:09 INFO - PID 8656 | 11:25:11 INFO - PID 8656 | Cycle 1(1): loaded http://localhost:53560/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53560/tests/kraken/driver.html?testName=audio-oscillator) 11:25:12 INFO - PID 8656 | RSS: Main: 168685568 11:25:12 INFO - PID 8656 | 11:25:14 INFO - PID 8656 | Cycle 1(1): loaded http://localhost:53560/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53560/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:25:15 INFO - PID 8656 | RSS: Main: 168787968 11:25:15 INFO - PID 8656 | 11:25:18 INFO - PID 8656 | Cycle 1(1): loaded http://localhost:53560/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53560/tests/kraken/driver.html?testName=imaging-darkroom) 11:25:18 INFO - PID 8656 | RSS: Main: 171380736 11:25:18 INFO - PID 8656 | 11:25:22 INFO - PID 8656 | Cycle 1(1): loaded http://localhost:53560/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53560/tests/kraken/driver.html?testName=imaging-desaturate) 11:25:22 INFO - PID 8656 | RSS: Main: 170983424 11:25:22 INFO - PID 8656 | 11:25:25 INFO - PID 8656 | Cycle 1(1): loaded http://localhost:53560/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53560/tests/kraken/driver.html?testName=json-parse-financial) 11:25:26 INFO - PID 8656 | RSS: Main: 171671552 11:25:26 INFO - PID 8656 | 11:25:28 INFO - PID 8656 | Cycle 1(1): loaded http://localhost:53560/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53560/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:25:28 INFO - PID 8656 | RSS: Main: 171323392 11:25:28 INFO - PID 8656 | 11:25:30 INFO - PID 8656 | Cycle 1(1): loaded http://localhost:53560/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53560/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:25:31 INFO - PID 8656 | RSS: Main: 171704320 11:25:31 INFO - PID 8656 | 11:25:33 INFO - PID 8656 | Cycle 1(1): loaded http://localhost:53560/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53560/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:25:34 INFO - PID 8656 | RSS: Main: 171458560 11:25:34 INFO - PID 8656 | 11:25:36 INFO - PID 8656 | Cycle 1(1): loaded http://localhost:53560/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:25:37 INFO - PID 8656 | RSS: Main: 172109824 11:25:37 INFO - PID 8656 | 11:25:40 INFO - PID 8656 | Cycle 1(1): loaded http://localhost:53560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:25:41 INFO - PID 8656 | RSS: Main: 172720128 11:25:41 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | Cycle 1(1): loaded http://localhost:53560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53560/tests/kraken/driver.html?testName=ai-astar) 11:25:43 INFO - PID 8656 | RSS: Main: 173850624 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | __start_tp_report 11:25:43 INFO - PID 8656 | _x_x_mozilla_page_load 11:25:43 INFO - PID 8656 | _x_x_mozilla_page_load_details 11:25:43 INFO - PID 8656 | |i|pagename|runs| 11:25:43 INFO - PID 8656 | |0;ai-astar;97;109;109;108;108;111;108;100;109;108 11:25:43 INFO - PID 8656 | |1;audio-beat-detection;152;122;153;175;123;147;147;119;170;118 11:25:43 INFO - PID 8656 | |2;audio-dft;173;162;174;163;163;163;174;167;163;164 11:25:43 INFO - PID 8656 | |3;audio-fft;82;77;76;177;76;74;74;75;160;76 11:25:43 INFO - PID 8656 | |4;audio-oscillator;82;78;130;86;79;79;134;82;84;121 11:25:43 INFO - PID 8656 | |5;imaging-gaussian-blur;114;116;117;115;114;116;117;117;116;114 11:25:43 INFO - PID 8656 | |6;imaging-darkroom;149;150;151;151;150;151;154;151;151;151 11:25:43 INFO - PID 8656 | |7;imaging-desaturate;99;94;94;94;94;93;93;99;96;95 11:25:43 INFO - PID 8656 | |8;json-parse-financial;63;53;53;62;54;55;53;54;54;54 11:25:43 INFO - PID 8656 | |9;json-stringify-tinderbox;54;54;55;59;54;54;55;54;55;55 11:25:43 INFO - PID 8656 | |10;stanford-crypto-aes;77;78;76;78;80;77;79;76;84;79 11:25:43 INFO - PID 8656 | |11;stanford-crypto-ccm;124;131;129;122;133;125;125;118;133;161 11:25:43 INFO - PID 8656 | |12;stanford-crypto-pbkdf2;172;176;179;182;186;176;180;173;170;180 11:25:43 INFO - PID 8656 | |13;stanford-crypto-sha256-iterative;76;69;69;74;68;70;67;72;68;78 11:25:43 INFO - PID 8656 | __end_tp_report 11:25:43 INFO - PID 8656 | __start_cc_report 11:25:43 INFO - PID 8656 | _x_x_mozilla_cycle_collect,936 11:25:43 INFO - PID 8656 | __end_cc_report 11:25:43 INFO - PID 8656 | __startTimestamp1502994343362__endTimestamp 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | ------- Summary: start ------- 11:25:43 INFO - PID 8656 | Number of tests: 14 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | [#0] ai-astar Cycles:10 Average:106.70 Median:109.00 stddev:4.47 (4.1%) stddev-sans-first:3.07 11:25:43 INFO - PID 8656 | Values: 97.0 109.0 109.0 108.0 108.0 111.0 108.0 100.0 109.0 108.0 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:149.50 stddev:21.10 (14.1%) stddev-sans-first:22.10 11:25:43 INFO - PID 8656 | Values: 152.0 122.0 153.0 175.0 123.0 147.0 147.0 119.0 170.0 118.0 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | [#2] audio-dft Cycles:10 Average:166.60 Median:165.50 stddev:5.06 (3.1%) stddev-sans-first:4.81 11:25:43 INFO - PID 8656 | Values: 173.0 162.0 174.0 163.0 163.0 163.0 174.0 167.0 163.0 164.0 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:39.17 (51.5%) stddev-sans-first:41.27 11:25:43 INFO - PID 8656 | Values: 82.0 77.0 76.0 177.0 76.0 74.0 74.0 75.0 160.0 76.0 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:80.50 stddev:23.00 (28.6%) stddev-sans-first:23.87 11:25:43 INFO - PID 8656 | Values: 82.0 78.0 130.0 86.0 79.0 79.0 134.0 82.0 84.0 121.0 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:116.00 stddev:1.26 (1.1%) stddev-sans-first:1.20 11:25:43 INFO - PID 8656 | Values: 114.0 116.0 117.0 115.0 114.0 116.0 117.0 117.0 116.0 114.0 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:1.29 (0.9%) stddev-sans-first:1.17 11:25:43 INFO - PID 8656 | Values: 149.0 150.0 151.0 151.0 150.0 151.0 154.0 151.0 151.0 151.0 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.50 stddev:2.23 (2.4%) stddev-sans-first:1.87 11:25:43 INFO - PID 8656 | Values: 99.0 94.0 94.0 94.0 94.0 93.0 93.0 99.0 96.0 95.0 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:54.00 stddev:3.75 (6.9%) stddev-sans-first:2.83 11:25:43 INFO - PID 8656 | Values: 63.0 53.0 53.0 62.0 54.0 55.0 53.0 54.0 54.0 54.0 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:55.00 stddev:1.52 (2.8%) stddev-sans-first:1.58 11:25:43 INFO - PID 8656 | Values: 54.0 54.0 55.0 59.0 54.0 54.0 55.0 54.0 55.0 55.0 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.50 stddev:2.37 (3.0%) stddev-sans-first:2.46 11:25:43 INFO - PID 8656 | Values: 77.0 78.0 76.0 78.0 80.0 77.0 79.0 76.0 84.0 79.0 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:130.00 stddev:11.90 (9.2%) stddev-sans-first:12.42 11:25:43 INFO - PID 8656 | Values: 124.0 131.0 129.0 122.0 133.0 125.0 125.0 118.0 133.0 161.0 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:179.50 stddev:4.93 (2.7%) stddev-sans-first:4.82 11:25:43 INFO - PID 8656 | Values: 172.0 176.0 179.0 182.0 186.0 176.0 180.0 173.0 170.0 180.0 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.00 stddev:3.75 (5.3%) stddev-sans-first:3.54 11:25:43 INFO - PID 8656 | Values: 76.0 69.0 69.0 74.0 68.0 70.0 67.0 72.0 68.0 78.0 11:25:43 INFO - PID 8656 | -------- Summary: end -------- 11:25:43 INFO - PID 8656 | 11:25:43 INFO - PID 8656 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:25:44 INFO - TEST-INFO | 8656: exit 0 11:25:44 INFO - TEST-OK | kraken | took 62709ms 11:25:44 INFO - SUITE-END | took 1175s 11:25:44 INFO - Completed test suite (00:19:35) 11:25:44 INFO - javascript benchmark 11:25:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8639.115519746938, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3134.3417882244744, 3202.359528094381, 3202.823844688541, 3208.518722191671, 3209.9679003209963, 6103.1455596216565, 6149.292831324394, 6198.752049918004, 6229.937700622992, 6252.406021427969, 6042.395760423967, 6168.845778855531, 6168.907466388007, 6174.043023331391, 6195.442410183083, 5634.32388113427, 5668.319801623811, 5681.119426488901, 5681.687507187103, 5738.540916726673, 5724.971375143139, 5742.770289188427, 5750.022496175639, 5763.308402991647, 5779.017567013618, 5521.806736764234, 5642.125470552071, 5674.460926212003, 5810.099434587624, 5812.941870581282, 5635.971820140914, 5688.089905615123, 5707.600467967244, 5752.5110365618975, 5754.769809207627, 5623.606347555673, 5646.661200327993, 5689.800856969986, 5691.117876729114, 5707.429257074301, 5987.760489580412, 6020.397960203988, 6059.212302400704, 6062.605930614496, 6133.049377346519, 6680.799576012679, 6688.230853451867, 6713.0, 6716.0933274007875, 6744.258131605568, 6714.83212919676, 6720.0, 6794.0827988221945, 6800.761973330959, 6815.829604259933, 6054.212952316171, 6192.767037765126, 6216.689165541705, 6281.937180628227, 6293.370662933716, 6763.256041835394, 6787.321267873173, 6792.558483698544, 6798.796036118924, 6811.863762724718, 6442.48460123189, 6491.156149700603, 6516.055172000033, 6521.510886683518, 6523.217213934358, 6592.077109204715, 6618.768343107968, 6620.801375958729, 6677.666116694146, 6678.3989440950545, 6645.302243264484, 6695.665216739144, 6699.062131301622, 6719.865602687919, 6732.427743641747, 6620.106285651375, 6620.735170593219, 6630.734770609121, 6714.127163468718, 6724.0, 5281.0758117329315, 5351.357837059578, 5368.597355198376, 5493.285872836505, 5508.173773933942, 4612.0, 4664.95335046652, 4665.370175026396, 4693.296005599119, 4716.481187069419, 5778.8266352009505, 5803.100519419497, 5849.298084229919, 5861.5603829712945, 5873.295204575393, 6719.832004199837, 6726.428253598499, 6798.218204906499, 6812.591244525344, 6822.590644561342, 5658.830235092953, 5723.742431590588, 5744.770209191669, 5791.797287094932, 5860.560457965669, 5925.229720136354, 5956.821295361146, 5960.761569537257, 5977.491913187341, 5981.611195272293, 6424.38968298011, 6514.250861151028, 6571.57284776488, 6604.0, 6611.404973552403, 6658.334166583303, 6700.6984685688285, 6705.497087718343, 6797.320267973163, 6805.693743781443, 6520.902186467112, 6548.345165483604, 6549.345065493412, 6572.14562106923, 6590.846601844754, 6541.149650545589, 6593.703283352356, 6669.433098186709, 6671.799846004627, 6684.699188536625, 6685.130932978682, 6688.197416310074, 6700.430463410665, 6797.524173307821, 6806.76176333826, 6323.588966717149, 6410.583312084699, 6413.422791948747, 6425.164728585254, 6469.061986012096, 6437.291897891135, 6439.162908821823, 6439.9696048631995, 6447.194100737408, 6449.580777249464, 6260.28006779208, 6359.17330747, 6361.491080713625, 6364.554481186273, 6366.0, 6415.454686351713, 6478.190226221723, 6494.09082728409, 6495.188101487314, 6496.512761542997, 6293.937060629335, 6312.210973628296, 6314.842128946813, 6321.431071203614, 6325.209348831396], "value": 6087.708605548343, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [865.385576240869, 894.3739382432295, 1169.8245263210517, 1189.3161432176496, 1265.367316341829, 39373.0, 39867.2026559469, 42393.99999999996, 43037.7848110759, 43053.0, 40013.19973600526, 40575.797121014424, 40617.0, 40700.18599628006, 40816.387754183714, 7267.164276108249, 7398.445116616275, 7404.333609975101, 7649.120351159632, 7815.10126335473, 7691.576963267018, 7785.260400261966, 7836.255555722226, 7840.7255746048895, 7844.294013538781, 7830.530168189898, 7878.763637090868, 7884.32983196429, 7886.566238856861, 7892.052953645571, 7819.061712594496, 7858.803529911741, 7886.408519361043, 7889.8027549311155, 7895.131535531087, 7735.303822655988, 7788.337991270749, 7807.180246074137, 7812.140664526897, 7816.374690024784, 40052.599474005176, 40200.0, 40203.0, 40419.79790101031, 40465.0, 3616.4213725804007, 3630.1832087780303, 3645.0887278180453, 3650.926981460356, 3664.560252769658, 32215.83892080548, 32244.0, 32250.032499025066, 32421.189470263198, 32502.512462312847, 5054.1407960646775, 5063.873403164914, 5138.537531622134, 5142.04872098663, 5155.71643559604, 183718.0, 184396.0, 186685.0, 186688.0, 186902.99999999863, 43969.78015109904, 44792.3281150783, 49793.25310120278, 50519.74740126276, 50796.492035079915, 52739.472605274226, 53769.73115134399, 53829.461705383226, 53853.73073134609, 53936.0, 17018.574535636708, 17149.142542873054, 17178.0, 17212.569685757957, 17271.65456690859, 14082.929585352213, 14107.294635268196, 14118.858811411754, 14132.434702611987, 14134.85865141356, 14940.551783446514, 14994.850051499563, 15012.47456339023, 15134.578467445375, 15186.088834669956, 5605.577689243028, 5717.3996730342715, 5762.481376676035, 5765.596408251466, 5985.850353741192, 1002.6390499420203, 1011.3830563356347, 1019.6176433837311, 1035.6168217759478, 1041.031840388446, 22971.540569188524, 24032.51934961326, 29841.40317193644, 30126.397472050874, 30325.848370758005, 1097.4183682648209, 1106.5850306135198, 1108.5177947592822, 1110.3837370259423, 1117.474786850179, 12948.935255323851, 12969.76787205214, 13129.803052954214, 13270.66823329405, 13403.865961340261, 243572.0, 245081.0, 245359.0, 245446.0, 245760.0, 57565.42434575601, 57575.424245757844, 57674.423255767746, 57893.42106578965, 58014.0, 1468.5520916120472, 1481.9110853348834, 1489.9106053636817, 1511.8110236220473, 1516.150955464943, 23647.763522364556, 23877.64183537283, 23967.400814979766, 24181.0, 24293.149739759025, 41137.1772564541, 41272.38091428691, 41450.170996580506, 41501.58498415098, 41513.79243103886, 202913.0, 203324.0, 204391.0, 204549.0, 205358.0, 31445.371092578476, 31818.522722158723, 33311.33377332391, 36564.451533227555, 37505.06237344088, 46595.53404465912, 48059.519404805505, 48555.757221213666, 49037.26444103412, 49568.0, 33725.49411758777, 34173.487397689554, 34475.482867757506, 34579.30841383108, 35118.47322290219, 33984.490232646036, 34013.319733604694, 34193.316133676686, 34384.0, 34541.0, 38098.238035239694, 38340.424893627176, 38491.807540962116, 38749.80625096856, 38828.80585597054, 34060.489092664124, 34138.48792268068, 34268.48597270993, 34621.13447163841, 34701.652983469845, 24550.386240344134, 24731.876340618182, 24810.0, 25134.497310054063, 25448.618270726325], "value": 17952.048895474843, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.443828363055, 588.4457874438392, 592.8488235499947, 595.1935127901694, 598.5510866849862, 22897.0, 22947.196848110278, 23781.881090594543, 23829.404264893386, 23853.0, 26124.869375653143, 26496.33759156022, 26518.0, 26620.733792662068, 26734.0, 6538.771143009995, 6768.492363072764, 6770.119884415019, 6793.558418702769, 6795.592264464123, 6276.623402595836, 6642.269350371455, 6725.192976842785, 6793.0, 6794.218664853531, 6590.604563726191, 6607.5044371672075, 6610.834729131762, 6610.900836487456, 6618.900716489256, 6585.275619681831, 6609.834754131161, 6614.371634694697, 6624.238212605515, 6628.602283862983, 6133.0, 6142.863570239475, 6143.416375444325, 6152.230971128609, 6160.722767475474, 29811.552826707615, 30426.69573304261, 30535.236619084702, 30850.07449776488, 31003.379932401225, 1878.9718154227699, 1929.1608150454597, 1934.6517626827165, 1935.8354539864129, 1936.8353689936373, 19420.611587768308, 19933.900330498254, 19935.700964485546, 19986.60026799456, 19996.400107996782, 2418.3470462975074, 2477.5630134522116, 2540.047482194177, 2541.8729063546934, 2550.3114159177103, 140261.0, 144864.27567862198, 145137.0, 145193.0, 145462.0, 15018.774718379014, 15434.614134646723, 15442.536723898302, 15612.55440458529, 16138.031718096952, 23304.417389565395, 23774.405639858796, 23899.52200956006, 23904.52190956171, 24233.878830605736, 9996.250281228937, 10169.745756356151, 10254.28220024606, 10277.383356998604, 10285.588576457008, 9260.861087083698, 9267.72196834096, 9274.118958698913, 9353.298502612332, 9379.859302110473, 9580.18568421692, 9680.370775899684, 9707.369021013752, 9720.368176068532, 9758.414495130315, 2670.252329347747, 2724.523208438555, 2739.7534221920123, 2752.119321816999, 2816.6760822505266, 968.9951550242204, 993.8310487217191, 1000.9849852252222, 1009.4195837393528, 1010.4897027001317, 19518.414447566596, 19889.900550497154, 19949.60100798005, 20085.698714519294, 20315.0, 1030.2273295028729, 1043.9530221140067, 1044.4412239451856, 1058.687687132298, 1073.2219141122623, 10962.287451315638, 11046.889531104585, 11169.776604467865, 11297.0, 11304.378259195822, 488180.0, 493742.0, 495736.0, 505229.0, 537864.0, 108761.0, 114482.42758786153, 119255.0, 119490.0, 119956.0, 1195.5098409652176, 1204.265398107154, 1229.0352073621984, 1230.9507619695112, 1232.7226374065763, 17474.21366038506, 17507.912460437616, 17540.298388064333, 17920.372786952394, 18023.369182078564, 53954.46045539495, 54493.45506544884, 58670.4132958682, 60311.69844150927, 61349.0, 71055.64472177606, 71541.28458715347, 72209.91685124622, 72248.0, 72901.0, 14753.92623036878, 15172.620684482976, 15247.313870875616, 15264.313105910038, 15288.694226115638, 23817.404564886016, 24081.638775418734, 24195.0, 24306.87846560756, 24510.387240319134, 18490.167942442353, 18588.44234672962, 18898.055097245357, 19028.04859757034, 19048.904755476135, 16540.255688494286, 16813.159342032606, 16991.49025529236, 17070.402535911184, 17250.878692884922, 17982.37061702834, 19462.12420441112, 19556.11997460146, 19738.703919440934, 19752.40742777719, 14689.559313220621, 14802.62993425173, 14852.183129927958, 14882.627934301296, 14899.851001489846, 18477.81522184761, 18545.072746362897, 18601.255949761857, 18601.348952787128, 18687.159077841257], "value": 12210.711276566335, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.8699130086989, 1361.5915225432368, 1388.4654408052902, 1388.8125103111083, 1389.4442223110748, 13885.58343249703, 14394.352254148562, 14401.711965760678, 14428.35072421741, 14430.783538246935, 13879.375428105734, 14362.569122926303, 14873.330700118493, 14895.553133405989, 14895.627609309746, 2654.654894863665, 2697.9730202698015, 2698.231004163804, 2702.8378297302124, 2706.905258315959, 2545.5799793034125, 2623.8950441982297, 2636.670416197975, 2645.2725500487422, 2693.46130773845, 2663.1477927063347, 2681.1956413076095, 2697.7302269772963, 2704.5672692369226, 2707.8510681912485, 2563.4360440703017, 2564.2563656539583, 2580.7548282913094, 2584.328074700582, 2584.702759182699, 2548.566743653565, 2564.9871750641314, 2579.742025797424, 2617.8429294242405, 2623.27859838544, 14046.227457489835, 14149.363278652485, 14201.857981420157, 14206.644833879132, 14221.85778142226, 7514.511556748794, 7730.304272615435, 7755.302022817974, 7770.728024519115, 7774.533527988338, 4971.602271818246, 5089.949100509021, 5232.058229518685, 5236.633435659505, 5237.764300606482, 1874.578219900525, 1881.840043596296, 1913.339897735279, 1947.7760057593275, 1960.8823470591667, 23464.0, 23688.64467032996, 23719.288421347388, 23720.288391348287, 23741.643875341884, 6567.310432404624, 6602.471802255808, 6626.204855417381, 6776.661166941633, 6792.049113124167, 16201.351945922266, 16252.83747162537, 16278.186090695417, 16292.918535407247, 16312.673746525003, 7663.31030207284, 7735.303822655988, 7763.650635721406, 7810.765677029698, 7823.84352312962, 6841.110655614738, 7174.8206294842, 7204.171520275236, 7219.350258476762, 7231.927680723231, 5005.924911126336, 5177.86087060846, 5208.192730126836, 5242.790288388422, 5275.630705850554, 1396.0576610787678, 1404.501402002295, 1498.9475368362055, 1501.677139415031, 1514.7652113922359, 733.9853202936018, 744.9515781474187, 748.8801791713299, 752.6124046116255, 757.5946868425366, 7721.729739459092, 8652.264557512555, 8749.343799214957, 8812.295016398673, 8877.644894204159, 993.9353941993747, 996.6611352140308, 1012.1194560732063, 1012.9290949633455, 1014.6144465103362, 5049.2173713074535, 5122.129238029544, 5226.869328266824, 5236.371635403776, 5330.067238233293, 19030.524236894187, 19130.0, 19782.109805058808, 20003.09986050631, 20015.899920500306, 19000.334988275343, 19406.611867762847, 19518.12168452423, 19833.801661983194, 19853.0, 10848.620298289521, 10908.127349811995, 11242.7189320266, 11249.381284029294, 11256.380899050631, 8160.0, 8172.550509722022, 8268.131846156068, 8381.49711017341, 8398.748037558884, 16915.0, 17411.912940435217, 17544.0, 17554.21006054705, 17635.64728705393, 17490.47528574145, 17526.649467010844, 17631.20659570348, 17639.0, 17731.468055957826, 10603.94698026505, 10827.350358978487, 10835.51240194209, 10871.782564348827, 10881.727956801144, 13144.60566183016, 13146.27695476758, 13355.931525478132, 13372.197668139943, 13516.25660588677, 11017.889821102008, 11029.393383363671, 11046.723831904266, 11169.497372618414, 11369.204155709022, 10467.16262698967, 10604.840927386249, 10784.245102842726, 10831.566737330733, 10912.454377280945, 9177.128172823572, 9272.397294175857, 9283.72148835536, 9322.067793220624, 9324.393914395543, 6588.308227636029, 6693.564918280296, 6701.731930722716, 6709.329067093252, 6745.4266387355665, 7573.507721998052, 7586.24137586237, 7604.277593628596, 7641.3886889047635, 7705.075390952898], "value": 6427.9301137756265, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.53667321054803, 497.7010003889847, 525.4535283305363, 532.8934213157368, 533.3546408845297, 6210.4721098706605, 6242.7190776415055, 6295.080000599821, 6306.747730090797, 6339.619622822623, 6021.638701677892, 6095.664738439384, 6103.2605707373405, 6125.724342404591, 6213.316535181138, 5147.382314122292, 5197.610179236553, 5209.635325527214, 5242.711650859202, 5248.816291429801, 5175.611829112813, 5207.244949482341, 5250.949810037989, 5270.7628156733035, 5273.472652734734, 4954.554090131887, 5147.588192944574, 5161.638685292012, 5171.50870667286, 5199.350081239845, 5184.585233181355, 5200.323957885488, 5230.921536176979, 5259.15853463444, 5275.973620131875, 4782.808687652525, 4802.567768900781, 4842.443119041285, 4862.465128835825, 4870.732109733964, 6057.545684073712, 6057.575969682124, 6086.2087928569, 6158.261008678943, 6169.568130230886, 6020.638761674313, 6051.485623721989, 6055.636661800306, 6080.756769729205, 6088.756449742005, 6490.93509064908, 6533.0, 6535.0, 6628.502862285348, 6652.2017357916875, 5228.895317175999, 5298.92051619226, 5305.840824775263, 5332.226827110087, 5362.705051222181, 6902.965485172592, 6944.131983502062, 6951.895721564231, 6994.615296158659, 7018.227994920555, 5422.972885135549, 5450.727463626803, 5451.209574611659, 5461.290032295776, 5476.67139971603, 5521.101421753531, 5534.335879694462, 5540.196671482612, 5569.832905012856, 5589.35722391922, 5996.121861506501, 6017.368176341509, 6066.908996365058, 6087.847803804941, 6091.329953705089, 6513.967430162914, 6543.574667646588, 6545.574537655038, 6558.5409021369, 6654.767083152066, 1825.9908700456413, 1896.8672192946638, 1909.5894382707784, 1920.6472071712042, 1925.5186203449139, 1410.4287763455816, 1414.978775318371, 1435.6697959469382, 1473.955781326562, 1492.9776053359208, 5716.399778023331, 5721.971390143022, 5745.942540574624, 5749.281339832521, 5751.194832723422, 6631.502637302222, 6735.6295403753265, 6745.696443660047, 6773.525853190229, 6785.457163427012, 5821.18503409523, 5847.415258474203, 5857.121431785266, 5872.119182122716, 5885.264341957255, 3602.963970360315, 3638.4178531434845, 3640.199156185635, 3645.0, 3668.779873207616, 6632.635205063768, 6642.933570664328, 6670.466362690973, 6678.4991125665765, 6698.464122870256, 6918.584884906922, 6941.895871561931, 6975.546589471668, 6992.265812089658, 7027.508074434741, 6576.44100251484, 6577.539572229898, 6615.857467702803, 6628.90056649141, 6680.799576012728, 6747.325267473213, 6773.0, 6864.176298844171, 6875.518713689994, 6878.65606719652, 6722.672277222806, 6767.729290828312, 6769.661516924232, 6770.307423144214, 6790.490713196629, 6617.966910165418, 6625.17185351831, 6642.4686025118845, 6654.76886775948, 6686.732530698718, 5043.915558155014, 5057.924131137962, 5093.592512599057, 5094.949050509447, 5115.283860259492, 6701.765438209639, 6727.562708423937, 6833.829154271183, 6839.726410943506, 6916.930830691628, 6311.65285909261, 6316.589421687576, 6382.3617638237665, 6400.327965563549, 6512.34876512345, 6425.903611445926, 6474.676266186578, 6483.157189565326, 6575.967120164369, 6576.750417420675, 6331.90502142459, 6380.234371875219, 6408.391202835724, 6457.160569125984, 6525.9021114684265, 6493.9675301625075, 6502.187226596676, 6552.541322107407, 6574.211094668671, 6652.534322597372, 6338.461230795434, 6353.14232578596, 6400.1679781629955, 6441.291457939529, 6472.967635161794], "value": 5206.445347035603, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.3767362846005, 906.6373450619752, 921.0467166482691, 921.9492927888963, 922.326701507899, 18658.253669853206, 19516.804831951693, 19647.901760491197, 19752.111154998023, 21261.681074783854, 21278.787212127874, 21879.12483500662, 21973.890130549324, 21988.120475180975, 22017.33947981563, 1020.6835880876934, 1059.90990765785, 1060.9363438193695, 1063.0910571461404, 1064.6646306413454, 1020.2093377632357, 1050.5430137890005, 1051.7686109055996, 1055.5672174408494, 1067.3329169269207, 1117.2291119127817, 1119.261287550217, 1120.0143873391405, 1120.0647459371394, 1120.075937351688, 1115.4422788605698, 1118.7818375416798, 1118.8321751737305, 1121.8149005414139, 1122.3770807202, 821.1131977464383, 822.6339279020838, 824.8886400335938, 825.2943733108166, 825.3026192867078, 19604.901975490175, 20084.397468075982, 20188.19247230109, 20268.493287667778, 20536.07587658559, 21426.464338391666, 21538.676919846213, 21982.560348792933, 22067.448313792283, 22227.333180004625, 16764.07797571133, 16798.32806687731, 16989.915050424792, 17091.658166836594, 17190.570235744082, 3557.6086630470627, 3585.995921142084, 3586.8385922633543, 3588.5155504006884, 3588.5873124590744, 126222.0, 127637.0, 128259.0, 130750.0, 130949.0, 17289.913550432168, 17317.56706082358, 17618.383356582457, 17680.557986050193, 17943.641127177383, 31437.528437073463, 32115.67884321127, 32162.83918580392, 32461.837690811393, 32674.183145421553, 7690.192529784404, 8079.313258372987, 8799.0, 9017.504037277882, 9273.165415112537, 4171.270027745132, 4258.936115958263, 4262.6376757975295, 4277.144571085795, 4280.0, 5048.444671086178, 5113.1052065888325, 5127.256547800623, 5151.793928242828, 5167.354080739908, 1023.8464230365505, 1049.8530205771199, 1055.6991257491577, 1057.8730552333616, 1059.7668512927144, 670.7719375412383, 676.4182802789597, 688.3426327856885, 694.7811439396675, 698.783377153074, 11463.770724585462, 11694.708656382329, 11862.644120676394, 12223.511059557519, 12386.442610082568, 637.719403462475, 651.0982289529037, 654.3031671270082, 654.9945833146098, 655.3446553446554, 5424.783008679688, 5485.6982865942755, 5497.285352904177, 5505.449455054462, 5615.438456154352, 109106.0, 109689.0, 110244.44877775559, 110312.0, 111879.44060279646, 94408.52795736115, 96173.51913240529, 96560.51719741356, 98744.0, 99468.0, 86442.13557864341, 87045.56477217701, 88189.55905220433, 89823.55088224648, 91368.54315728378, 10059.295849290773, 10199.796004080024, 10308.536115874953, 11590.594329198437, 12506.312152831317, 36731.63268367282, 39526.60473395344, 39862.800685996386, 40136.59863401329, 42017.78991105025, 71435.0, 71986.0, 72953.6352318235, 73016.63491682507, 74192.62903685447, 18784.0, 18851.811481885554, 19053.42839714811, 19089.522761931064, 19280.903595482494, 21644.891775541022, 21819.345419637437, 21910.56178876382, 21976.780232197474, 22183.44541386478, 17900.10499474995, 18454.0, 18477.630447391246, 18781.6243675123, 18850.905745471184, 18221.635567288846, 19222.8077719221, 19330.613387732446, 19391.709124362864, 19459.610807783483, 18055.09724513743, 18382.080895955416, 19121.808781912558, 19774.70337944961, 19822.0, 12260.448279827251, 12522.0, 12598.496060157491, 12868.613941581767, 13666.0, 13567.118137321042, 13606.183628982293, 13629.591112266648, 14440.638984025483, 14669.119852808866], "value": 9308.233803881183, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 109.0, 109.0, 108.0, 108.0, 111.0, 108.0, 100.0, 109.0, 108.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 153.0, 175.0, 123.0, 147.0, 147.0, 119.0, 170.0, 118.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 162.0, 174.0, 163.0, 163.0, 163.0, 174.0, 167.0, 163.0, 164.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 76.0, 177.0, 76.0, 74.0, 74.0, 75.0, 160.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 130.0, 86.0, 79.0, 79.0, 134.0, 82.0, 84.0, 121.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 117.0, 115.0, 114.0, 116.0, 117.0, 117.0, 116.0, 114.0], "value": 115.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 151.0, 151.0, 150.0, 151.0, 154.0, 151.0, 151.0, 151.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 94.0, 94.0, 94.0, 93.0, 93.0, 99.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 53.0, 53.0, 62.0, 54.0, 55.0, 53.0, 54.0, 54.0, 54.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 59.0, 54.0, 54.0, 55.0, 54.0, 55.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 78.0, 80.0, 77.0, 79.0, 76.0, 84.0, 79.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 131.0, 129.0, 122.0, 133.0, 125.0, 125.0, 118.0, 133.0, 161.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 176.0, 179.0, 182.0, 186.0, 176.0, 180.0, 173.0, 170.0, 180.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 69.0, 69.0, 74.0, 68.0, 70.0, 67.0, 72.0, 68.0, 78.0], "value": 71.1, "unit": "score"}]}]} 11:25:44 INFO - Return code: 0 11:25:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:25:44 INFO - # TBPL SUCCESS # 11:25:44 INFO - Running post-action listener: _package_coverage_data 11:25:44 INFO - Running post-action listener: _resource_record_post_action 11:25:44 INFO - [mozharness: 2017-08-17 18:25:44.650313Z] Finished run-tests step (success) 11:25:44 INFO - Running post-run listener: _resource_record_post_run 11:25:44 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 421888; Write bytes: 432275456; Read time: 28; Write time: 337444 11:25:44 INFO - TinderboxPrint: CPU usage
13.1% 11:25:44 INFO - TinderboxPrint: I/O read bytes / time
421,888 / 28 11:25:44 INFO - TinderboxPrint: I/O write bytes / time
432,275,456 / 337,444 11:25:44 INFO - TinderboxPrint: CPU idle
8,267.7 (86.8%) 11:25:44 INFO - TinderboxPrint: CPU user
1,202.2 (12.6%) 11:25:44 INFO - TinderboxPrint: Swap in / out
0 / 0 11:25:44 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107122688; Read time: 0; Write time: 87288 11:25:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:25:44 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 417792; Write bytes: 324128768; Read time: 24; Write time: 250132 11:25:45 INFO - Running post-run listener: _upload_blobber_files 11:25:45 INFO - Blob upload gear active. 11:25:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:25:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:25:45 INFO - (blobuploader) - INFO - Open directory for files ... 11:25:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:25:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:25:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:25:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:25:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:25:46 INFO - (blobuploader) - INFO - Done attempting. 11:25:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:25:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:25:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:25:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:25:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:25:47 INFO - (blobuploader) - INFO - Done attempting. 11:25:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:25:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:25:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:25:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:25:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:25:48 INFO - (blobuploader) - INFO - Done attempting. 11:25:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:25:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:25:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:25:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:25:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:25:55 INFO - (blobuploader) - INFO - Done attempting. 11:25:55 INFO - (blobuploader) - INFO - Iteration through files over. 11:25:55 INFO - Return code: 0 11:25:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:25:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:25:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb2a3fa65cf13f97e530df77230a0b3d5c0b52f472cd479471ab66899b669e2d582ce2535ab54e3dc3def0c7d5caf580cd567b0d75efcc35497abc9516359743", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b805634e37e4d6c2337e0878bdca96bc6ef9c3252c4ed666f83d0b948164b73461da192990bcc7b728811904189f6bf05029a8811b7db96a6b6dfe434d09e33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35fce78e625cc0922ea1e14ee1777ca70c52e0a1f046822d892f560c135ba7c5b2c1d59abb29ad9bf8d556ee1ca93d4d166dd00f68eb8d2c2f72459f4d539821", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8a1c52e8a6464e1fe80842a8665a8d905f5dd558f70444d3ef647101afbef717b55fcac3f272e1d6b1836a62972f7a12b82c3e2be95f2ab8d85a7afb9ad8c0b"} 11:25:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:25:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:25:55 INFO - Contents: 11:25:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb2a3fa65cf13f97e530df77230a0b3d5c0b52f472cd479471ab66899b669e2d582ce2535ab54e3dc3def0c7d5caf580cd567b0d75efcc35497abc9516359743", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b805634e37e4d6c2337e0878bdca96bc6ef9c3252c4ed666f83d0b948164b73461da192990bcc7b728811904189f6bf05029a8811b7db96a6b6dfe434d09e33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35fce78e625cc0922ea1e14ee1777ca70c52e0a1f046822d892f560c135ba7c5b2c1d59abb29ad9bf8d556ee1ca93d4d166dd00f68eb8d2c2f72459f4d539821", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8a1c52e8a6464e1fe80842a8665a8d905f5dd558f70444d3ef647101afbef717b55fcac3f272e1d6b1836a62972f7a12b82c3e2be95f2ab8d85a7afb9ad8c0b"} 11:25:55 INFO - Running post-run listener: copy_logs_to_upload_dir 11:25:55 INFO - Copying logs to upload dir... 11:25:55 INFO - mkdir: /builds/slave/test/build/upload/logs 11:25:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.071007 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-17 11:25:54.939840) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 11:25:54.947404) ========= 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=db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb2a3fa65cf13f97e530df77230a0b3d5c0b52f472cd479471ab66899b669e2d582ce2535ab54e3dc3def0c7d5caf580cd567b0d75efcc35497abc9516359743", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b805634e37e4d6c2337e0878bdca96bc6ef9c3252c4ed666f83d0b948164b73461da192990bcc7b728811904189f6bf05029a8811b7db96a6b6dfe434d09e33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35fce78e625cc0922ea1e14ee1777ca70c52e0a1f046822d892f560c135ba7c5b2c1d59abb29ad9bf8d556ee1ca93d4d166dd00f68eb8d2c2f72459f4d539821", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8a1c52e8a6464e1fe80842a8665a8d905f5dd558f70444d3ef647101afbef717b55fcac3f272e1d6b1836a62972f7a12b82c3e2be95f2ab8d85a7afb9ad8c0b"} build_url:https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb2a3fa65cf13f97e530df77230a0b3d5c0b52f472cd479471ab66899b669e2d582ce2535ab54e3dc3def0c7d5caf580cd567b0d75efcc35497abc9516359743", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b805634e37e4d6c2337e0878bdca96bc6ef9c3252c4ed666f83d0b948164b73461da192990bcc7b728811904189f6bf05029a8811b7db96a6b6dfe434d09e33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35fce78e625cc0922ea1e14ee1777ca70c52e0a1f046822d892f560c135ba7c5b2c1d59abb29ad9bf8d556ee1ca93d4d166dd00f68eb8d2c2f72459f4d539821", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8a1c52e8a6464e1fe80842a8665a8d905f5dd558f70444d3ef647101afbef717b55fcac3f272e1d6b1836a62972f7a12b82c3e2be95f2ab8d85a7afb9ad8c0b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 11:25:54.976364) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:25:54.976648) ========= 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=db7e7c15f3ca076d53731445000001ba-1502993098.143706-1599960879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:25:55.058864) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 11:25:55.062201) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 11:25:55.062469) ========= ========= Total master_lag: 0.18 =========